php.net |  support |  documentation |  report a bug |  advanced search |  search howto |  statistics |  random bug |  login
Bug #77175 Old script executed after update
Submitted: 2018-11-19 10:34 UTC Modified: 2021-10-17 04:22 UTC
From: olafvdspek at gmail dot com Assigned: cmb (profile)
Status: No Feedback Package: opcache
PHP Version: 7.3.0RC5 OS: Debian 10
Private report: No CVE-ID: None
 [2018-11-19 10:34 UTC] olafvdspek at gmail dot com
Description:
------------
I've updated a script but PHP doesn't appear to detect this. Could it be a caching issue?
The 'update' is a bit weird, I've replaced phpMyAdmin by Adminer. 
/var/www/html/pma used to be a symlink to /srv/pma
Now it's a directory containing adminer's index.php: https://github.com/vrana/adminer/releases/download/v4.6.3/adminer-4.6.3-mysql-en.php

Web server is nginx.
The request is for /var/www/html/pma/index.php.

> getcwd("/usr/share/phpmyadmin", 4095)   = 22

Not sure why it does this.

> chdir("/var/www/html/pma")              = 0

OK

> stat("/srv/pma/libraries/common.inc.php", {st_mode=S_IFREG|0644, st_size=13837, ...}) = 0

Hmm, that's from the OLD script.



Test script:
---------------
https://github.com/vrana/adminer/releases/download/v4.6.3/adminer-4.6.3-mysql-en.php


Expected result:
----------------
200 OK

Actual result:
--------------
nginx log:
2018/11/19 11:25:41 [error] 12306#12306: *3 FastCGI sent in stderr: "PHP message: PHP Warning:  require_once(./libraries/vendor_config.php): failed to open stream: No such file or directory in /srv/pma/libraries/common.inc.php on line 74PHP message: PHP Fatal error:  require_once(): Failed opening required './libraries/vendor_config.php' (include_path='.:/usr/share/php') in /srv/pma/libraries/common.inc.php on line 74" while reading response header from upstream, client: 192.168.127.1, server: _, request: "GET /pma/ HTTP/1.1", upstream: "fastcgi://unix:/var/run/php/php7.3-fpm.sock:", host: "unstable"

# strace -s 999 -p 917
strace: Process 917 attached
accept(9, {sa_family=AF_UNIX}, [112->2]) = 4
poll([{fd=4, events=POLLIN}], 1, 5000)  = 1 ([{fd=4, revents=POLLIN}])
times({tms_utime=26, tms_stime=32, tms_cutime=0, tms_cstime=0}) = 1718394780
read(4, "\1\1\0\1\0\10\0\0", 8)         = 8
read(4, "\0\1\0\0\0\0\0\0", 8)          = 8
read(4, "\1\4\0\1\3\313\5\0", 8)        = 8
read(4, "\t\0PATH_INFO\17\33SCRIPT_FILENAME/var/www/html/pma/index.php\f\0QUERY_STRING\16\3REQUEST_METHODGET\f\0CONTENT_TYPE\16\0CONTENT_LENGTH\v\16SCRIPT_NAME/pma/index.php\v\5REQUEST_URI/pma/\f\16DOCUMENT_URI/pma/index.php\r\rDOCUMENT_ROOT/var/www/html\17\10SERVER_PROTOCOLHTTP/1.1\16\4REQUEST_SCHEMEhttp\21\7GATEWAY_INTERFACECGI/1.1\17\fSERVER_SOFTWAREnginx/1.14.1\v\rREMOTE_ADDR192.168.127.1\v\5REMOTE_PORT64518\v\17SERVER_ADDR192.168.127.135\v\2SERVER_PORT80\v\1SERVER_NAME_\17\3REDIRECT_STATUS200\t\10HTTP_HOSTunstable\17\nHTTP_CONNECTIONkeep-alive\22\tHTTP_CACHE_CONTROLmax-age=0\22\36HTTP_AUTHORIZATIONBasic cm9vdDp0ODFsZW8wQmNpbWk=\36\1HTTP_UPGRADE_INSECURE_REQUESTS1\17sHTTP_USER_AGENTMozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/70.0.3538.102 Safari/537.36\vUHTTP_ACCEPTtext/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8\24\rHTTP_ACCEPT_ENCODINGgzip, deflate\24\27HTTP_ACCEPT_LANGUAGEen-US,en;q=0.9,nl;q=0.8\v2HTTP_COOKIEpma_lang=en; phpMyAdmin=i7sk4evlhdcld3s7aun6mm7ds0\0\0\0\0\0", 976) = 976
read(4, "\1\4\0\1\0\0\0\0", 8)          = 8
lstat("/var/www/html/pma/index.php", {st_mode=S_IFREG|0644, st_size=208150, ...}) = 0
lstat("/var/www/html/pma", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
lstat("/var/www/html", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
lstat("/var/www", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
lstat("/var", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
rt_sigaction(SIGPROF, NULL, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, 8) = 0
rt_sigaction(SIGHUP, NULL, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, 8) = 0
rt_sigaction(SIGINT, NULL, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, 8) = 0
rt_sigaction(SIGQUIT, NULL, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, 8) = 0
rt_sigaction(SIGTERM, NULL, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, 8) = 0
rt_sigaction(SIGUSR1, NULL, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, 8) = 0
rt_sigaction(SIGUSR2, NULL, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, 8) = 0
setitimer(ITIMER_PROF, {it_interval={tv_sec=0, tv_usec=0}, it_value={tv_sec=60, tv_usec=0}}, NULL) = 0
rt_sigaction(SIGPROF, {sa_handler=0x5573360402a0, sa_mask=~[ILL TRAP ABRT BUS FPE KILL SEGV CONT STOP TSTP TTIN TTOU SYS RTMIN RT_1], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f18207b6fc0}, NULL, 8) = 0
rt_sigprocmask(SIG_UNBLOCK, [PROF], NULL, 8) = 0
getcwd("/usr/share/phpmyadmin", 4095)   = 22
chdir("/var/www/html/pma")              = 0
setitimer(ITIMER_PROF, {it_interval={tv_sec=0, tv_usec=0}, it_value={tv_sec=30, tv_usec=0}}, NULL) = 0
fcntl(3, F_SETLK, {l_type=F_RDLCK, l_whence=SEEK_SET, l_start=1, l_len=1}) = 0
stat("/srv/pma/index.php", {st_mode=S_IFREG|0644, st_size=20359, ...}) = 0
getcwd("/var/www/html/pma", 4096)       = 18
stat("/srv/pma/libraries/common.inc.php", {st_mode=S_IFREG|0644, st_size=13837, ...}) = 0
getcwd("/var/www/html/pma", 4096)       = 18
getcwd("/var/www/html/pma", 4096)       = 18
lstat("/var/www/html/pma/./libraries/vendor_config.php", 0x7fff12726dc0) = -1 ENOENT (No such file or directory)
getcwd("/var/www/html/pma", 4096)       = 18
lstat("/var/www/html/pma/./libraries/vendor_config.php", 0x7fff12726c60) = -1 ENOENT (No such file or directory)
getcwd("/var/www/html/pma", 4096)       = 18
lstat("/var/www/html/pma/./libraries/vendor_config.php", 0x7fff12727dd0) = -1 ENOENT (No such file or directory)
lstat("/var/www/html/pma/./libraries", 0x7fff12727c50) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/var/www/html/pma/libraries/vendor_config.php", O_RDONLY) = -1 ENOENT (No such file or directory)
write(2, "NOTICE: PHP message: PHP Warning:  require_once(./libraries/vendor_config.php): failed to open stream: No such file or directory in /srv/pma/libraries/common.inc.php on line 74\n", 177) = 177
write(2, "NOTICE: PHP message: PHP Fatal error:  require_once(): Failed opening required './libraries/vendor_config.php' (include_path='.:/usr/share/php') in /srv/pma/libraries/common.inc.php on line 74\n", 193) = 193
chdir("/usr/share/phpmyadmin")          = 0
times({tms_utime=26, tms_stime=32, tms_cutime=0, tms_cstime=0}) = 1718394782
write(2, "\0", 1)                       = 1
setitimer(ITIMER_PROF, {it_interval={tv_sec=0, tv_usec=0}, it_value={tv_sec=0, tv_usec=0}}, NULL) = 0
fcntl(3, F_SETLK, {l_type=F_UNLCK, l_whence=SEEK_SET, l_start=0, l_len=0}) = 0
write(4, "\1\7\0\1\1`\0\0PHP message: PHP Warning:  require_once(./libraries/vendor_config.php): failed to open stream: No such file or directory in /srv/pma/libraries/common.inc.php on line 74PHP message: PHP Fatal error:  require_once(): Failed opening required './libraries/vendor_config.php' (include_path='.:/usr/share/php') in /srv/pma/libraries/common.inc.php on line 74\1\6\0\1\0M\3\0Status: 500 Internal Server Error\r\nContent-type: text/html; charset=UTF-8\r\n\r\n\0\0\0\1\3\0\1\0\10\0\0\0\0\0\0\0HTG", 464) = 464
shutdown(4, SHUT_WR)                    = 0
recvfrom(4, "\1\5\0\1\0\0\0\0", 8, 0, NULL, NULL) = 8
recvfrom(4, "", 8, 0, NULL, NULL)       = 0
close(4)                                = 0
setitimer(ITIMER_PROF, {it_interval={tv_sec=0, tv_usec=0}, it_value={tv_sec=0, tv_usec=0}}, NULL) = 0
accept(9, 

Patches

Pull Requests

History

AllCommentsChangesGit/SVN commitsRelated reports
 [2018-11-19 10:37 UTC] spam2 at rhsoft dot net
check your opcache settings, when validation is disabled you need to reload php

opcache.use_cwd = 1
opcache.validate_timestamps = 1
opcache.revalidate_freq = 5
 [2018-11-19 11:08 UTC] olafvdspek at gmail dot com
I'm using package defaults from https://deb.sury.org/

opcache.use_cwd	= On
opcache.validate_timestamps = On
opcache.revalidate_freq = 2
 [2018-11-19 11:19 UTC] cmb@php.net
-Package: *General Issues +Package: opcache
 [2021-10-07 10:06 UTC] cmb@php.net
-Status: Open +Status: Feedback -Assigned To: +Assigned To: cmb
 [2021-10-07 10:06 UTC] cmb@php.net
This might be a duplicate of bug #74268.  Anyhow, does it still
happen with any of the actively supported PHP versions[1]?

[1] <https://www.php.net/supported-versions.php>
 [2021-10-17 04:22 UTC] php-bugs at lists dot php dot net
No feedback was provided. The bug is being suspended because
we assume that you are no longer experiencing the problem.
If this is not the case and you are able to provide the
information that was requested earlier, please do so and
change the status of the bug back to "Re-Opened". Thank you.
 
PHP Copyright © 2001-2024 The PHP Group
All rights reserved.
Last updated: Thu Nov 21 17:01:32 2024 UTC