builder: fx-team_win7-ix_test-dromaeojs
slave: t-w732-ix-105
starttime: 1445621650.86
results: success (0)
buildid: 20151023085550
builduid: 7ea3b5ede34e41e089b62d922ebd0f2d
revision: 1105f8e2c4857800a91f6b8ead4359f641c3bfb5
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:10.856276) =========
master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:10.857778) =========
========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-23 10:34:10.858108) =========
'cd'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['cd']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
C:\slave\test
program finished with exit code 0
elapsedTime=0.619000
basedir: 'C:\\slave\\test'
========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-23 10:34:13.023895) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2015-10-23 10:34:13.024219) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2015-10-23 10:34:16.887691) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-23 10:34:16.888040) =========
'rm' '-rf' 'properties'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'properties']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.501000
========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-23 10:34:19.629742) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:19.630062) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:19.630438) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-23 10:34:19.631195) =========
'bash' '-c' 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
--10:34:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 1.96 GB/s
10:34:21 (1.96 GB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=1.047000
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-23 10:34:21.871623) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 27 secs) (at 2015-10-23 10:34:21.871943) =========
'rm' '-rf' 'scripts'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=13.907000
========= Finished 'rm -rf ...' (results: 0, elapsed: 27 secs) (at 2015-10-23 10:34:49.301195) =========
========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-23 10:34:49.301532) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 1105f8e2c4857800a91f6b8ead4359f641c3bfb5 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1105f8e2c4857800a91f6b8ead4359f641c3bfb5 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
2015-10-23 10:34:50,263 truncating revision to first 12 chars
2015-10-23 10:34:50,263 Setting DEBUG logging.
2015-10-23 10:34:50,263 attempt 1/10
2015-10-23 10:34:50,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1105f8e2c485?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-10-23 10:34:50,752 unpacking tar archive at: fx-team-1105f8e2c485/testing/mozharness/
program finished with exit code 0
elapsedTime=1.393000
========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-23 10:34:52.649225) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:52.649536) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:53.472454) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:53.472746) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 10:34:53.473153) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 5 secs) (at 2015-10-23 10:34:53.473460) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team-Non-PGO' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team-Non-PGO'
in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PROPERTIES_FILE=C:\slave\test/buildprops.json
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
10:34:53 INFO - MultiFileLogger online at 20151023 10:34:53 in C:\slave\test
10:34:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO
10:34:53 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
10:34:53 INFO - {'append_to_log': False,
10:34:53 INFO - 'base_work_dir': 'C:\\slave\\test',
10:34:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO',
10:34:53 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
10:34:53 INFO - 'branch': 'Fx-Team-Non-PGO',
10:34:53 INFO - 'buildbot_json_path': 'buildprops.json',
10:34:53 INFO - 'config_files': ('talos/windows_config.py',),
10:34:53 INFO - 'default_actions': ('clobber',
10:34:53 INFO - 'read-buildbot-config',
10:34:53 INFO - 'download-and-extract',
10:34:53 INFO - 'populate-webroot',
10:34:53 INFO - 'create-virtualenv',
10:34:53 INFO - 'install',
10:34:53 INFO - 'run-tests'),
10:34:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
10:34:53 INFO - 'download_minidump_stackwalk': True,
10:34:53 INFO - 'download_symbols': 'ondemand',
10:34:53 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
10:34:53 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
10:34:53 INFO - 'hg': 'c:/mozilla-build/hg/hg',
10:34:53 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
10:34:53 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
10:34:53 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
10:34:53 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
10:34:53 INFO - 'C:/mozilla-build/tooltool.py'),
10:34:53 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
10:34:53 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
10:34:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
10:34:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
10:34:53 INFO - 'installer_path': 'installer.exe',
10:34:53 INFO - 'log_level': 'info',
10:34:53 INFO - 'log_name': 'talos',
10:34:53 INFO - 'log_to_console': True,
10:34:53 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
10:34:53 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
10:34:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
10:34:53 INFO - 'opt_config_files': (),
10:34:53 INFO - 'pip_index': False,
10:34:53 INFO - 'sps_profile': False,
10:34:53 INFO - 'sps_profile_interval': 0,
10:34:53 INFO - 'suite': 'dromaeojs',
10:34:53 INFO - 'system_bits': '32',
10:34:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
10:34:53 INFO - 'title': 'T-W732-IX-105',
10:34:53 INFO - 'use_talos_json': True,
10:34:53 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
10:34:53 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
10:34:53 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
10:34:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
10:34:53 INFO - 'work_dir': 'build'}
10:34:53 INFO - #####
10:34:53 INFO - ##### Running clobber step.
10:34:53 INFO - #####
10:34:53 INFO - Running pre-action listener: _resource_record_pre_action
10:34:53 INFO - Running main action method: clobber
10:34:53 INFO - rmtree: C:\slave\test\build
10:34:53 INFO - Using _rmtree_windows ...
10:34:53 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
10:35:07 INFO - Running post-action listener: _resource_record_post_action
10:35:07 INFO - #####
10:35:07 INFO - ##### Running read-buildbot-config step.
10:35:07 INFO - #####
10:35:07 INFO - Running pre-action listener: _resource_record_pre_action
10:35:07 INFO - Running main action method: read_buildbot_config
10:35:07 INFO - Using buildbot properties:
10:35:07 INFO - {
10:35:07 INFO - "properties": {
10:35:07 INFO - "buildnumber": 718,
10:35:07 INFO - "product": "firefox",
10:35:07 INFO - "script_repo_revision": "production",
10:35:07 INFO - "builddir": "fx-team_win7-ix_test-dromaeojs",
10:35:07 INFO - "repository": "",
10:35:07 INFO - "buildername": "Windows 7 32-bit fx-team talos dromaeojs",
10:35:07 INFO - "buildid": "20151023085550",
10:35:07 INFO - "slavename": "t-w732-ix-105",
10:35:07 INFO - "pgo_build": "False",
10:35:07 INFO - "basedir": "C:\\slave\\test",
10:35:07 INFO - "project": "",
10:35:07 INFO - "platform": "win7-ix",
10:35:07 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/",
10:35:07 INFO - "slavebuilddir": "test",
10:35:07 INFO - "scheduler": "tests-fx-team-win32-talos",
10:35:07 INFO - "branch": "fx-team",
10:35:07 INFO - "repo_path": "integration/fx-team",
10:35:07 INFO - "stage_platform": "win32",
10:35:07 INFO - "builduid": "7ea3b5ede34e41e089b62d922ebd0f2d",
10:35:07 INFO - "revision": "1105f8e2c4857800a91f6b8ead4359f641c3bfb5"
10:35:07 INFO - },
10:35:07 INFO - "sourcestamp": {
10:35:07 INFO - "repository": "",
10:35:07 INFO - "hasPatch": false,
10:35:07 INFO - "project": "",
10:35:07 INFO - "branch": "fx-team-win32-talos",
10:35:07 INFO - "changes": [
10:35:07 INFO - {
10:35:07 INFO - "category": null,
10:35:07 INFO - "files": [
10:35:07 INFO - {
10:35:07 INFO - "url": null,
10:35:07 INFO - "name": "https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip"
10:35:07 INFO - }
10:35:07 INFO - ],
10:35:07 INFO - "repository": "",
10:35:07 INFO - "rev": "1105f8e2c4857800a91f6b8ead4359f641c3bfb5",
10:35:07 INFO - "who": "kcambridge@mozilla.com",
10:35:07 INFO - "when": 1445620826,
10:35:07 INFO - "number": 6567075,
10:35:07 INFO - "comments": "Bug 1212149 - e10s support for opening notification settings. r=wchen",
10:35:07 INFO - "project": "",
10:35:07 INFO - "at": "Fri 23 Oct 2015 10:20:26",
10:35:07 INFO - "branch": "fx-team-win32-talos",
10:35:07 INFO - "revlink": "",
10:35:07 INFO - "properties": [
10:35:07 INFO - [
10:35:07 INFO - "buildid",
10:35:07 INFO - "20151023085550",
10:35:07 INFO - "Change"
10:35:07 INFO - ],
10:35:07 INFO - [
10:35:07 INFO - "builduid",
10:35:07 INFO - "7ea3b5ede34e41e089b62d922ebd0f2d",
10:35:07 INFO - "Change"
10:35:07 INFO - ],
10:35:07 INFO - [
10:35:07 INFO - "pgo_build",
10:35:07 INFO - "False",
10:35:07 INFO - "Change"
10:35:07 INFO - ]
10:35:07 INFO - ],
10:35:07 INFO - "revision": "1105f8e2c4857800a91f6b8ead4359f641c3bfb5"
10:35:07 INFO - }
10:35:07 INFO - ],
10:35:07 INFO - "revision": "1105f8e2c4857800a91f6b8ead4359f641c3bfb5"
10:35:07 INFO - }
10:35:07 INFO - }
10:35:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip.
10:35:07 INFO - Running post-action listener: _resource_record_post_action
10:35:07 INFO - #####
10:35:07 INFO - ##### Running download-and-extract step.
10:35:07 INFO - #####
10:35:07 INFO - Running pre-action listener: _resource_record_pre_action
10:35:07 INFO - Running main action method: download_and_extract
10:35:07 INFO - mkdir: C:\slave\test\build\tests
10:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:35:07 INFO - https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
10:35:07 INFO - trying https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/test_packages.json
10:35:07 INFO - Downloading https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json
10:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1
10:35:08 INFO - Downloaded 1221 bytes.
10:35:08 INFO - Reading from file C:\slave\test\build\test_packages.json
10:35:08 INFO - Using the following test package requirements:
10:35:08 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'],
10:35:08 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
10:35:08 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'],
10:35:08 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
10:35:08 INFO - u'jsshell-win32.zip'],
10:35:08 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
10:35:08 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'],
10:35:08 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'],
10:35:08 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
10:35:08 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'],
10:35:08 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
10:35:08 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'],
10:35:08 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
10:35:08 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'],
10:35:08 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'],
10:35:08 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
10:35:08 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']}
10:35:08 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common
10:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:35:08 INFO - https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net
10:35:08 INFO - trying https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip
10:35:08 INFO - Downloading https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip
10:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1
10:35:10 INFO - Downloaded 18005225 bytes.
10:35:10 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test\build\tests
10:35:10 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip
10:35:10 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760
10:35:42 INFO - Return code: 0
10:35:42 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip', u'firefox-44.0a1.en-US.win32.talos.tests.zip'] for test suite category: talos
10:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:35:42 INFO - https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net
10:35:42 INFO - trying https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip
10:35:42 INFO - Downloading https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip
10:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1
10:35:46 INFO - Downloaded 18005225 bytes.
10:35:46 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test\build\tests
10:35:46 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip
10:35:46 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760
10:36:09 INFO - Return code: 0
10:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:09 INFO - https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net
10:36:09 INFO - trying https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip
10:36:09 INFO - Downloading https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.talos.tests.zip
10:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'}, attempt #1
10:36:14 INFO - Downloaded 11131307 bytes.
10:36:14 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] in C:\slave\test\build\tests
10:36:14 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.talos.tests.zip
10:36:14 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760
10:36:17 INFO - Return code: 0
10:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:17 INFO - https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net
10:36:17 INFO - trying https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
10:36:17 INFO - Downloading https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.zip
10:36:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.zip'}, attempt #1
10:36:21 INFO - Downloaded 51466062 bytes.
10:36:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
10:36:21 INFO - mkdir: C:\slave\test\properties
10:36:21 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
10:36:21 INFO - Writing to file C:\slave\test\properties\build_url
10:36:21 INFO - Contents:
10:36:21 INFO - build_url:https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
10:36:21 INFO - Running post-action listener: _resource_record_post_action
10:36:21 INFO - Running post-action listener: set_extra_try_arguments
10:36:21 INFO - #####
10:36:21 INFO - ##### Running populate-webroot step.
10:36:21 INFO - #####
10:36:21 INFO - Running pre-action listener: _resource_record_pre_action
10:36:21 INFO - Running main action method: populate_webroot
10:36:21 INFO - Guessing talos json url...
10:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:21 INFO - https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net
10:36:21 INFO - trying https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt
10:36:21 INFO - Downloading https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test\build\firefox-44.0a1.en-US.win32.txt
10:36:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.txt'}, attempt #1
10:36:25 INFO - Downloaded 103 bytes.
10:36:25 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win32.txt
10:36:25 INFO - Contents:
10:36:25 INFO - 20151023085550
10:36:25 INFO - https://hg.mozilla.org/integration/fx-team/rev/1105f8e2c4857800a91f6b8ead4359f641c3bfb5
10:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:25 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/1105f8e2c4/testing/talos/talos.json
10:36:25 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/1105f8e2c4/testing/talos/talos.json to C:\slave\test\build\talos.json
10:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/1105f8e2c4/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1
10:36:26 INFO - Downloaded 4264 bytes.
10:36:26 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
10:36:26 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
10:36:26 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs',
10:36:26 INFO - u'../fennec_ids.txt'],
10:36:26 INFO - u'tests': [u'tcheck2']},
10:36:26 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
10:36:26 INFO - u'--tppagecycles',
10:36:26 INFO - u'7'],
10:36:26 INFO - u'tests': [u'tsvgm']}},
10:36:26 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']},
10:36:26 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'tresize', u'tcanvasmark']},
10:36:26 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']},
10:36:26 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'dromaeo_css',
10:36:26 INFO - u'kraken',
10:36:26 INFO - u'v8_7']},
10:36:26 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
10:36:26 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
10:36:26 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'tests': [u'damp', u'tps']},
10:36:26 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'damp', u'tps']},
10:36:26 INFO - u'g3': {u'tests': [u'dromaeo_dom']},
10:36:26 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
10:36:26 INFO - u'other': {u'tests': [u'a11yr',
10:36:26 INFO - u'ts_paint',
10:36:26 INFO - u'tpaint',
10:36:26 INFO - u'sessionrestore',
10:36:26 INFO - u'sessionrestore_no_auto_restore']},
10:36:26 INFO - u'other-e10s': {u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'a11yr',
10:36:26 INFO - u'ts_paint',
10:36:26 INFO - u'tpaint',
10:36:26 INFO - u'sessionrestore',
10:36:26 INFO - u'sessionrestore_no_auto_restore']},
10:36:26 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'a11yr',
10:36:26 INFO - u'ts_paint',
10:36:26 INFO - u'tpaint',
10:36:26 INFO - u'sessionrestore',
10:36:26 INFO - u'sessionrestore_no_auto_restore']},
10:36:26 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'a11yr',
10:36:26 INFO - u'ts_paint',
10:36:26 INFO - u'tpaint',
10:36:26 INFO - u'sessionrestore',
10:36:26 INFO - u'sessionrestore_no_auto_restore']},
10:36:26 INFO - u'other_l64': {u'tests': [u'a11yr',
10:36:26 INFO - u'ts_paint',
10:36:26 INFO - u'tpaint',
10:36:26 INFO - u'sessionrestore',
10:36:26 INFO - u'sessionrestore_no_auto_restore']},
10:36:26 INFO - u'other_nol64': {u'tests': [u'a11yr',
10:36:26 INFO - u'ts_paint',
10:36:26 INFO - u'tpaint',
10:36:26 INFO - u'sessionrestore',
10:36:26 INFO - u'sessionrestore_no_auto_restore']},
10:36:26 INFO - u'svgr': {u'tests': [u'tsvgx',
10:36:26 INFO - u'tsvgr_opacity',
10:36:26 INFO - u'tart',
10:36:26 INFO - u'tscrollx',
10:36:26 INFO - u'cart']},
10:36:26 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'tsvgx',
10:36:26 INFO - u'tsvgr_opacity',
10:36:26 INFO - u'tart',
10:36:26 INFO - u'tscrollx',
10:36:26 INFO - u'cart']},
10:36:26 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'tests': [u'tp5o']},
10:36:26 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'talos_options': [u'--e10s'],
10:36:26 INFO - u'tests': [u'tp5o']},
10:36:26 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'talos_options': [u'--xperf_path',
10:36:26 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
10:36:26 INFO - u'tests': [u'tp5n']},
10:36:26 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
10:36:26 INFO - u'talos_options': [u'--e10s',
10:36:26 INFO - u'--xperf_path',
10:36:26 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"',
10:36:26 INFO - u'C:/slave/talos-data/talos/xperf.config'],
10:36:26 INFO - u'tests': [u'tp5n']}},
10:36:26 INFO - u'talos.zip': {u'path': u'',
10:36:26 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
10:36:26 INFO - Running post-action listener: _resource_record_post_action
10:36:26 INFO - #####
10:36:26 INFO - ##### Running create-virtualenv step.
10:36:26 INFO - #####
10:36:26 INFO - Running pre-action listener: _resource_record_pre_action
10:36:26 INFO - Running main action method: create_virtualenv
10:36:26 INFO - Creating virtualenv C:\slave\test\build/venv
10:36:26 INFO - mkdir: C:\slave\test\build\venv\Scripts
10:36:26 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
10:36:26 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'!
10:36:26 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build
10:36:26 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
10:36:31 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
10:36:36 INFO - Installing distribute......................................................................................................................................................................................done.
10:36:37 INFO - Return code: 0
10:36:37 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
10:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
10:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
10:36:37 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01893B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018E9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017B0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-105', 'USERDOMAIN': 'T-W732-IX-105', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-105', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
10:36:37 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
10:36:37 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
10:36:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:36:37 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:36:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:36:37 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:36:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:36:37 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:36:37 INFO - 'DCLOCATION': 'SCL3',
10:36:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:36:37 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:36:37 INFO - 'HOMEDRIVE': 'C:',
10:36:37 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:36:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:36:37 INFO - 'KTS_VERSION': '1.19c',
10:36:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:36:37 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:36:37 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:36:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:36:37 INFO - 'MOZ_NO_REMOTE': '1',
10:36:37 INFO - 'NO_EM_RESTART': '1',
10:36:37 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:36:37 INFO - 'OS': 'Windows_NT',
10:36:37 INFO - 'OURDRIVE': 'C:',
10:36:37 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:36:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:36:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:36:37 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:36:37 INFO - 'PROCESSOR_LEVEL': '6',
10:36:37 INFO - 'PROCESSOR_REVISION': '1e05',
10:36:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:36:37 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:36:37 INFO - 'PROMPT': '$P$G',
10:36:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:36:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:36:37 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:36:37 INFO - 'PWD': 'C:\\slave\\test',
10:36:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:36:37 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:36:37 INFO - 'SYSTEMDRIVE': 'C:',
10:36:37 INFO - 'SYSTEMROOT': 'C:\\windows',
10:36:37 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:37 INFO - 'TEST1': 'testie',
10:36:37 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:37 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:36:37 INFO - 'USERNAME': 'cltbld',
10:36:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:36:37 INFO - 'WINDIR': 'C:\\windows',
10:36:37 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:36:37 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:36:39 INFO - Ignoring indexes: http://pypi.python.org/simple/
10:36:39 INFO - Downloading/unpacking pip>=1.5
10:36:40 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache
10:36:46 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pub.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz
10:36:46 INFO - Running setup.py egg_info for package pip
10:36:46 INFO - warning: no files found matching 'pip\cacert.pem'
10:36:46 INFO - warning: no files found matching '*.html' under directory 'docs'
10:36:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
10:36:46 INFO - no previously-included directories found matching 'docs\_build\_sources'
10:36:46 INFO - Installing collected packages: pip
10:36:46 INFO - Found existing installation: pip 0.8.2
10:36:46 INFO - Uninstalling pip:
10:36:46 INFO - Successfully uninstalled pip
10:36:46 INFO - Running setup.py install for pip
10:36:46 INFO - warning: no files found matching 'pip\cacert.pem'
10:36:46 INFO - warning: no files found matching '*.html' under directory 'docs'
10:36:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
10:36:46 INFO - no previously-included directories found matching 'docs\_build\_sources'
10:36:46 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
10:36:46 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
10:36:46 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
10:36:46 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
10:36:46 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
10:36:46 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
10:36:46 INFO - Successfully installed pip
10:36:46 INFO - Cleaning up...
10:36:46 INFO - Return code: 0
10:36:46 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv
10:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
10:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
10:36:46 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01893B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018E9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017B0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-105', 'USERDOMAIN': 'T-W732-IX-105', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-105', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
10:36:46 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test\build
10:36:46 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1
10:36:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:36:46 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:36:46 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:36:46 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:36:46 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:36:46 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:36:46 INFO - 'DCLOCATION': 'SCL3',
10:36:46 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:36:46 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:36:46 INFO - 'HOMEDRIVE': 'C:',
10:36:46 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:36:46 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:36:46 INFO - 'KTS_VERSION': '1.19c',
10:36:46 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:36:46 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:36:46 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:36:46 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:36:46 INFO - 'MOZ_NO_REMOTE': '1',
10:36:46 INFO - 'NO_EM_RESTART': '1',
10:36:46 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:36:46 INFO - 'OS': 'Windows_NT',
10:36:46 INFO - 'OURDRIVE': 'C:',
10:36:46 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:36:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:36:46 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:36:46 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:36:46 INFO - 'PROCESSOR_LEVEL': '6',
10:36:46 INFO - 'PROCESSOR_REVISION': '1e05',
10:36:46 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:36:46 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:36:46 INFO - 'PROMPT': '$P$G',
10:36:46 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:36:46 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:36:46 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:36:46 INFO - 'PWD': 'C:\\slave\\test',
10:36:46 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:36:46 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:36:46 INFO - 'SYSTEMDRIVE': 'C:',
10:36:46 INFO - 'SYSTEMROOT': 'C:\\windows',
10:36:46 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:46 INFO - 'TEST1': 'testie',
10:36:46 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:46 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:36:46 INFO - 'USERNAME': 'cltbld',
10:36:46 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:36:46 INFO - 'WINDIR': 'C:\\windows',
10:36:46 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:36:46 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
10:36:47 INFO - Downloading/unpacking psutil>=0.7.1
10:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
10:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
10:36:50 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl
10:36:50 INFO - Installing collected packages: psutil
10:36:50 INFO - Successfully installed psutil
10:36:50 INFO - Cleaning up...
10:36:50 INFO - Return code: 0
10:36:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv
10:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
10:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
10:36:50 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01893B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018E9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017B0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-105', 'USERDOMAIN': 'T-W732-IX-105', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-105', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
10:36:50 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test\build
10:36:50 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0
10:36:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:36:50 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:36:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:36:50 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:36:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:36:50 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:36:50 INFO - 'DCLOCATION': 'SCL3',
10:36:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:36:50 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:36:50 INFO - 'HOMEDRIVE': 'C:',
10:36:50 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:36:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:36:50 INFO - 'KTS_VERSION': '1.19c',
10:36:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:36:50 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:36:50 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:36:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:36:50 INFO - 'MOZ_NO_REMOTE': '1',
10:36:50 INFO - 'NO_EM_RESTART': '1',
10:36:50 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:36:50 INFO - 'OS': 'Windows_NT',
10:36:50 INFO - 'OURDRIVE': 'C:',
10:36:50 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:36:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:36:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:36:50 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:36:50 INFO - 'PROCESSOR_LEVEL': '6',
10:36:50 INFO - 'PROCESSOR_REVISION': '1e05',
10:36:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:36:50 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:36:50 INFO - 'PROMPT': '$P$G',
10:36:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:36:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:36:50 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:36:50 INFO - 'PWD': 'C:\\slave\\test',
10:36:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:36:50 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:36:50 INFO - 'SYSTEMDRIVE': 'C:',
10:36:50 INFO - 'SYSTEMROOT': 'C:\\windows',
10:36:50 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:50 INFO - 'TEST1': 'testie',
10:36:50 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:50 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:36:50 INFO - 'USERNAME': 'cltbld',
10:36:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:36:50 INFO - 'WINDIR': 'C:\\windows',
10:36:50 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:36:50 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
10:36:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
10:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
10:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
10:36:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz
10:36:52 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz
10:36:52 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
10:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0)
10:36:53 INFO - Installing collected packages: mozsystemmonitor
10:36:53 INFO - Running setup.py install for mozsystemmonitor
10:36:53 INFO - Successfully installed mozsystemmonitor
10:36:53 INFO - Cleaning up...
10:36:53 INFO - Return code: 0
10:36:53 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
10:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
10:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
10:36:53 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01893B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018E9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017B0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-105', 'USERDOMAIN': 'T-W732-IX-105', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-105', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
10:36:53 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build
10:36:53 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
10:36:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:36:53 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:36:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:36:53 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:36:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:36:53 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:36:53 INFO - 'DCLOCATION': 'SCL3',
10:36:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:36:53 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:36:53 INFO - 'HOMEDRIVE': 'C:',
10:36:53 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:36:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:36:53 INFO - 'KTS_VERSION': '1.19c',
10:36:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:36:53 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:36:53 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:36:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:36:53 INFO - 'MOZ_NO_REMOTE': '1',
10:36:53 INFO - 'NO_EM_RESTART': '1',
10:36:53 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:36:53 INFO - 'OS': 'Windows_NT',
10:36:53 INFO - 'OURDRIVE': 'C:',
10:36:53 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:36:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:36:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:36:53 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:36:53 INFO - 'PROCESSOR_LEVEL': '6',
10:36:53 INFO - 'PROCESSOR_REVISION': '1e05',
10:36:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:36:53 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:36:53 INFO - 'PROMPT': '$P$G',
10:36:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:36:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:36:53 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:36:53 INFO - 'PWD': 'C:\\slave\\test',
10:36:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:36:53 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:36:53 INFO - 'SYSTEMDRIVE': 'C:',
10:36:53 INFO - 'SYSTEMROOT': 'C:\\windows',
10:36:53 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:53 INFO - 'TEST1': 'testie',
10:36:53 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:36:53 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:36:53 INFO - 'USERNAME': 'cltbld',
10:36:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:36:53 INFO - 'WINDIR': 'C:\\windows',
10:36:53 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:36:53 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/
10:36:53 INFO - Downloading/unpacking blobuploader==1.2.4
10:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
10:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
10:36:58 INFO - Downloading blobuploader-1.2.4.tar.gz
10:36:58 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz
10:36:58 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
10:36:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
10:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
10:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
10:36:58 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz
10:36:58 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
10:36:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
10:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
10:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
10:36:58 INFO - Downloading docopt-0.6.1.tar.gz
10:36:58 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz
10:36:58 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
10:36:58 INFO - Installing collected packages: blobuploader, requests, docopt
10:36:58 INFO - Running setup.py install for blobuploader
10:36:59 INFO - Running setup.py install for requests
10:36:59 INFO - Running setup.py install for docopt
10:36:59 INFO - Successfully installed blobuploader requests docopt
10:36:59 INFO - Cleaning up...
10:37:01 INFO - Return code: 0
10:37:01 INFO - Installing None into virtualenv C:\slave\test\build/venv
10:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
10:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
10:37:01 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01893B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018E9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017B0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-105', 'USERDOMAIN': 'T-W732-IX-105', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-105', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
10:37:01 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
10:37:01 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
10:37:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:37:01 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:37:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:37:01 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:37:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:37:01 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:37:01 INFO - 'DCLOCATION': 'SCL3',
10:37:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:37:01 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:37:01 INFO - 'HOMEDRIVE': 'C:',
10:37:01 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:37:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:37:01 INFO - 'KTS_VERSION': '1.19c',
10:37:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:37:01 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:37:01 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:37:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:37:01 INFO - 'MOZ_NO_REMOTE': '1',
10:37:01 INFO - 'NO_EM_RESTART': '1',
10:37:01 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:37:01 INFO - 'OS': 'Windows_NT',
10:37:01 INFO - 'OURDRIVE': 'C:',
10:37:01 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:37:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:37:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:37:01 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:37:01 INFO - 'PROCESSOR_LEVEL': '6',
10:37:01 INFO - 'PROCESSOR_REVISION': '1e05',
10:37:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:37:01 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:37:01 INFO - 'PROMPT': '$P$G',
10:37:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:37:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:37:01 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:37:01 INFO - 'PWD': 'C:\\slave\\test',
10:37:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:37:01 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:37:01 INFO - 'SYSTEMDRIVE': 'C:',
10:37:01 INFO - 'SYSTEMROOT': 'C:\\windows',
10:37:01 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:01 INFO - 'TEST1': 'testie',
10:37:01 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:01 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:37:01 INFO - 'USERNAME': 'cltbld',
10:37:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:37:01 INFO - 'WINDIR': 'C:\\windows',
10:37:01 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:37:01 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/
10:37:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
10:37:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3g5tro-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
10:37:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
10:37:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-amumpq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
10:37:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
10:37:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1r2vv4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
10:37:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
10:37:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vswycy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
10:37:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
10:37:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qutkzs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-693zh_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ag3sdm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xwwdg1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gvz4de-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zit4ov-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tmvy6s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rxsdbg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
10:37:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
10:37:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tg6sz_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
10:37:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
10:37:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mv3j5s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
10:37:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
10:37:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fgngw7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
10:37:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
10:37:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wievvu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
10:37:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
10:37:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_nks6v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
10:37:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
10:37:03 INFO - Running setup.py install for manifestparser
10:37:03 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
10:37:03 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
10:37:04 INFO - Running setup.py install for mozcrash
10:37:04 INFO - Running setup.py install for mozdebug
10:37:04 INFO - Running setup.py install for mozdevice
10:37:05 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
10:37:05 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
10:37:05 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
10:37:05 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
10:37:05 INFO - Running setup.py install for mozfile
10:37:05 INFO - Running setup.py install for mozhttpd
10:37:06 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Running setup.py install for mozinfo
10:37:06 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Running setup.py install for mozInstall
10:37:06 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
10:37:06 INFO - Running setup.py install for mozleak
10:37:07 INFO - Running setup.py install for mozlog
10:37:07 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
10:37:07 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
10:37:08 INFO - Running setup.py install for moznetwork
10:37:08 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
10:37:08 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
10:37:08 INFO - Running setup.py install for mozprocess
10:37:09 INFO - Running setup.py install for mozprofile
10:37:09 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
10:37:09 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
10:37:09 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
10:37:09 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
10:37:09 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
10:37:09 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
10:37:10 INFO - Running setup.py install for mozrunner
10:37:10 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
10:37:10 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
10:37:10 INFO - Running setup.py install for mozscreenshot
10:37:11 INFO - Running setup.py install for moztest
10:37:11 INFO - Running setup.py install for mozversion
10:37:11 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
10:37:11 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
10:37:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
10:37:11 INFO - Cleaning up...
10:37:11 INFO - Return code: 0
10:37:11 INFO - Installing None into virtualenv C:\slave\test\build/venv
10:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
10:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
10:37:11 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01893B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018E9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017B0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-105', 'USERDOMAIN': 'T-W732-IX-105', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-105', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
10:37:11 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
10:37:11 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
10:37:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:37:11 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:37:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:37:11 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:37:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:37:11 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:37:11 INFO - 'DCLOCATION': 'SCL3',
10:37:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:37:11 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:37:11 INFO - 'HOMEDRIVE': 'C:',
10:37:11 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:37:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:37:11 INFO - 'KTS_VERSION': '1.19c',
10:37:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:37:11 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:37:11 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:37:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:37:11 INFO - 'MOZ_NO_REMOTE': '1',
10:37:11 INFO - 'NO_EM_RESTART': '1',
10:37:11 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:37:11 INFO - 'OS': 'Windows_NT',
10:37:11 INFO - 'OURDRIVE': 'C:',
10:37:11 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:37:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:37:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:37:11 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:37:11 INFO - 'PROCESSOR_LEVEL': '6',
10:37:11 INFO - 'PROCESSOR_REVISION': '1e05',
10:37:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:37:11 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:37:11 INFO - 'PROMPT': '$P$G',
10:37:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:37:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:37:11 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:37:11 INFO - 'PWD': 'C:\\slave\\test',
10:37:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:37:11 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:37:11 INFO - 'SYSTEMDRIVE': 'C:',
10:37:11 INFO - 'SYSTEMROOT': 'C:\\windows',
10:37:11 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:11 INFO - 'TEST1': 'testie',
10:37:11 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:11 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:37:11 INFO - 'USERNAME': 'cltbld',
10:37:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:37:11 INFO - 'WINDIR': 'C:\\windows',
10:37:11 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:37:11 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/
10:37:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
10:37:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tstm1f-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
10:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1))
10:37:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
10:37:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-6cqass-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
10:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
10:37:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
10:37:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mky330-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
10:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
10:37:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
10:37:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uv7hwf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
10:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
10:37:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
10:37:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-z37qjw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
10:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5))
10:37:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
10:37:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dps96p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
10:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6))
10:37:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
10:37:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zhgp5i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
10:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7))
10:37:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
10:37:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5zqah7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
10:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8))
10:37:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
10:37:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wc3kqz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
10:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9))
10:37:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
10:37:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qp8zyc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
10:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
10:37:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
10:37:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-p_pjxo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
10:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11))
10:37:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
10:37:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-eabrzb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12))
10:37:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
10:37:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-p_vj3y-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13))
10:37:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
10:37:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-2j3krq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14))
10:37:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
10:37:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gzoglb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15))
10:37:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
10:37:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9dhi6n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16))
10:37:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
10:37:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_fhryj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17))
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
10:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
10:37:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
10:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
10:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
10:37:16 INFO - Downloading blessings-1.5.1.tar.gz
10:37:16 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz
10:37:16 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
10:37:16 INFO - Installing collected packages: blessings
10:37:16 INFO - Running setup.py install for blessings
10:37:17 INFO - Successfully installed blessings
10:37:17 INFO - Cleaning up...
10:37:19 INFO - Return code: 0
10:37:19 INFO - Done creating virtualenv C:\slave\test\build/venv.
10:37:19 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
10:37:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
10:37:20 INFO - Reading from file tmpfile_stdout
10:37:20 INFO - Using _rmtree_windows ...
10:37:20 INFO - Using _rmtree_windows ...
10:37:20 INFO - Current package versions:
10:37:20 INFO - blessings == 1.5.1
10:37:20 INFO - blobuploader == 1.2.4
10:37:20 INFO - docopt == 0.6.1
10:37:20 INFO - manifestparser == 1.1
10:37:20 INFO - mozInstall == 1.12
10:37:20 INFO - mozcrash == 0.16
10:37:20 INFO - mozdebug == 0.1
10:37:20 INFO - mozdevice == 0.46
10:37:20 INFO - mozfile == 1.2
10:37:20 INFO - mozhttpd == 0.7
10:37:20 INFO - mozinfo == 0.8
10:37:20 INFO - mozleak == 0.1
10:37:20 INFO - mozlog == 3.0
10:37:20 INFO - moznetwork == 0.27
10:37:20 INFO - mozprocess == 0.22
10:37:20 INFO - mozprofile == 0.27
10:37:20 INFO - mozrunner == 6.10
10:37:20 INFO - mozscreenshot == 0.1
10:37:20 INFO - mozsystemmonitor == 0.0
10:37:20 INFO - moztest == 0.7
10:37:20 INFO - mozversion == 1.4
10:37:20 INFO - psutil == 3.1.1
10:37:20 INFO - requests == 1.2.3
10:37:20 INFO - Installing None into virtualenv C:\slave\test\build/venv
10:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
10:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
10:37:20 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01893B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018E9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017B0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-105', 'USERDOMAIN': 'T-W732-IX-105', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-105', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
10:37:20 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos
10:37:20 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
10:37:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:37:20 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:37:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:37:20 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:37:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:37:20 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:37:20 INFO - 'DCLOCATION': 'SCL3',
10:37:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:37:20 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:37:20 INFO - 'HOMEDRIVE': 'C:',
10:37:20 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:37:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:37:20 INFO - 'KTS_VERSION': '1.19c',
10:37:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:37:20 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:37:20 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:37:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:37:20 INFO - 'MOZ_NO_REMOTE': '1',
10:37:20 INFO - 'NO_EM_RESTART': '1',
10:37:20 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:37:20 INFO - 'OS': 'Windows_NT',
10:37:20 INFO - 'OURDRIVE': 'C:',
10:37:20 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:37:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:37:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:37:20 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:37:20 INFO - 'PROCESSOR_LEVEL': '6',
10:37:20 INFO - 'PROCESSOR_REVISION': '1e05',
10:37:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:37:20 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:37:20 INFO - 'PROMPT': '$P$G',
10:37:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:37:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:37:20 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:37:20 INFO - 'PWD': 'C:\\slave\\test',
10:37:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:37:20 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:37:20 INFO - 'SYSTEMDRIVE': 'C:',
10:37:20 INFO - 'SYSTEMROOT': 'C:\\windows',
10:37:20 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:20 INFO - 'TEST1': 'testie',
10:37:20 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:20 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:37:20 INFO - 'USERNAME': 'cltbld',
10:37:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:37:20 INFO - 'WINDIR': 'C:\\windows',
10:37:20 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:37:20 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 3))
10:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
10:37:20 INFO - Cleaning up...
10:37:20 INFO - Return code: 0
10:37:20 INFO - Running post-action listener: _resource_record_post_action
10:37:20 INFO - Running post-action listener: _start_resource_monitoring
10:37:20 INFO - Starting resource monitoring.
10:37:20 INFO - #####
10:37:20 INFO - ##### Running install step.
10:37:20 INFO - #####
10:37:20 INFO - Running pre-action listener: _resource_record_pre_action
10:37:20 INFO - Running main action method: install
10:37:20 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
10:37:20 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
10:37:20 INFO - Reading from file tmpfile_stdout
10:37:20 INFO - Using _rmtree_windows ...
10:37:20 INFO - Using _rmtree_windows ...
10:37:20 INFO - Detecting whether we're running mozinstall >=1.0...
10:37:20 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
10:37:20 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
10:37:21 INFO - Reading from file tmpfile_stdout
10:37:21 INFO - Output received:
10:37:21 INFO - Usage: mozinstall-script.py [options] installer
10:37:21 INFO - Options:
10:37:21 INFO - -h, --help show this help message and exit
10:37:21 INFO - -d DEST, --destination=DEST
10:37:21 INFO - Directory to install application into. [default:
10:37:21 INFO - "C:\slave\test"]
10:37:21 INFO - --app=APP Application being installed. [default: firefox]
10:37:21 INFO - Using _rmtree_windows ...
10:37:21 INFO - Using _rmtree_windows ...
10:37:21 INFO - mkdir: C:\slave\test\build\application
10:37:21 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test\\build\\application']
10:37:21 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-44.0a1.en-US.win32.zip --destination C:\slave\test\build\application
10:37:22 INFO - Reading from file tmpfile_stdout
10:37:22 INFO - Output received:
10:37:22 INFO - C:\slave\test\build\application\firefox\firefox.exe
10:37:22 INFO - Using _rmtree_windows ...
10:37:22 INFO - Using _rmtree_windows ...
10:37:22 INFO - Running post-action listener: _resource_record_post_action
10:37:22 INFO - #####
10:37:22 INFO - ##### Running run-tests step.
10:37:22 INFO - #####
10:37:22 INFO - Running pre-action listener: _resource_record_pre_action
10:37:22 INFO - Running main action method: run_tests
10:37:22 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
10:37:22 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
10:37:22 INFO - Python 2.7.3
10:37:22 INFO - Return code: 0
10:37:22 INFO - grabbing minidump binary from tooltool
10:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
10:37:22 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012A8B48>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012CA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCF660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
10:37:22 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build
10:37:22 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o
10:37:22 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
10:37:26 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpuqev_q
10:37:26 INFO - INFO - File integrity verified, renaming tmpuqev_q to win32-minidump_stackwalk.exe
10:37:26 INFO - Return code: 0
10:37:26 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
10:37:26 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
10:37:26 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
10:37:26 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
10:37:26 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
10:37:26 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-105', '--webServer', 'localhost'] in C:\slave\test\build
10:37:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-105 --webServer localhost
10:37:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
10:37:26 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
10:37:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
10:37:26 INFO - 'COMPUTERNAME': 'T-W732-IX-105',
10:37:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
10:37:26 INFO - 'CYGWINBASE': 'C:\\cygwin',
10:37:26 INFO - 'DCLOCATION': 'SCL3',
10:37:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
10:37:26 INFO - 'FP_NO_HOST_CHECK': 'NO',
10:37:26 INFO - 'HOMEDRIVE': 'C:',
10:37:26 INFO - 'HOMEPATH': '\\Users\\cltbld',
10:37:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
10:37:26 INFO - 'KTS_VERSION': '1.19c',
10:37:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
10:37:26 INFO - 'LOGONSERVER': '\\\\T-W732-IX-105',
10:37:26 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
10:37:26 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
10:37:26 INFO - 'MONDIR': 'C:\\Monitor_config\\',
10:37:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
10:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
10:37:26 INFO - 'MOZ_NO_REMOTE': '1',
10:37:26 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
10:37:26 INFO - 'NO_EM_RESTART': '1',
10:37:26 INFO - 'NUMBER_OF_PROCESSORS': '8',
10:37:26 INFO - 'OS': 'Windows_NT',
10:37:26 INFO - 'OURDRIVE': 'C:',
10:37:26 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
10:37:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
10:37:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
10:37:26 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
10:37:26 INFO - 'PROCESSOR_LEVEL': '6',
10:37:26 INFO - 'PROCESSOR_REVISION': '1e05',
10:37:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
10:37:26 INFO - 'PROGRAMFILES': 'C:\\Program Files',
10:37:26 INFO - 'PROMPT': '$P$G',
10:37:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
10:37:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
10:37:26 INFO - 'PUBLIC': 'C:\\Users\\Public',
10:37:26 INFO - 'PWD': 'C:\\slave\\test',
10:37:26 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
10:37:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
10:37:26 INFO - 'SLAVEDIR': 'C:\\slave\\',
10:37:26 INFO - 'SYSTEMDRIVE': 'C:',
10:37:26 INFO - 'SYSTEMROOT': 'C:\\windows',
10:37:26 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:26 INFO - 'TEST1': 'testie',
10:37:26 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
10:37:26 INFO - 'USERDOMAIN': 'T-W732-IX-105',
10:37:26 INFO - 'USERNAME': 'cltbld',
10:37:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
10:37:26 INFO - 'WINDIR': 'C:\\windows',
10:37:26 INFO - 'WINDOWS_TRACING_FLAGS': '3',
10:37:26 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
10:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
10:37:26 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-105', '--webServer', 'localhost'] with output_timeout 3600
10:37:27 INFO - mozversion INFO | application_buildid: 20151023085550
10:37:27 INFO - mozversion INFO | application_changeset: 1105f8e2c4857800a91f6b8ead4359f641c3bfb5
10:37:27 INFO - mozversion INFO | application_display_name: Nightly
10:37:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
10:37:27 INFO - mozversion INFO | application_name: Firefox
10:37:27 INFO - mozversion INFO | application_remotingname: firefox
10:37:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team
10:37:27 INFO - mozversion INFO | application_vendor: Mozilla
10:37:27 INFO - mozversion INFO | application_version: 44.0a1
10:37:27 INFO - mozversion INFO | platform_buildid: 20151023085550
10:37:27 INFO - mozversion INFO | platform_changeset: 1105f8e2c4857800a91f6b8ead4359f641c3bfb5
10:37:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team
10:37:27 INFO - mozversion INFO | platform_version: 44.0a1
10:37:27 INFO - 2015-10-23 10:37:27,176 DEBUG : using testdate: 1445621847
10:37:27 INFO - 2015-10-23 10:37:27,176 DEBUG : actual date: 1445621847
10:37:27 INFO - 2015-10-23 10:37:27,404 INFO : starting webserver on 'localhost:49721'
10:37:27 INFO - 2015-10-23 10:37:27,405 INFO : Starting test suite T-W732-IX-105
10:37:27 INFO - 2015-10-23 10:37:27,405 INFO : Starting test dromaeo_css
10:37:27 INFO - 2015-10-23 10:37:27,405 DEBUG : operating with platform_type : w7_
10:37:27 INFO - 2015-10-23 10:37:27,407 INFO : Initialising browser for dromaeo_css test...
10:37:27 INFO - 2015-10-23 10:37:27,494 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpholrs6\profile http://localhost:49721/getInfo.html
10:37:36 INFO - 2015-10-23 10:37:36,082 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
10:37:36 INFO - 2015-10-23 10:37:36,082 DEBUG : BROWSER_OUTPUT: colorDepth:24
10:37:36 INFO - 2015-10-23 10:37:36,082 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
10:37:36 INFO - 2015-10-23 10:37:36,082 DEBUG : BROWSER_OUTPUT: __metrics
10:37:36 INFO - 2015-10-23 10:37:36,177 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
10:37:37 INFO - 2015-10-23 10:37:37,795 INFO : Browser initialized.
10:37:37 INFO - 2015-10-23 10:37:37,795 INFO : Running cycle 1/1 for dromaeo_css test...
10:37:37 INFO - 2015-10-23 10:37:37,795 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpholrs6\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
10:37:49 INFO - 2015-10-23 10:37:49,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568
10:37:49 INFO - 2015-10-23 10:37:49,437 DEBUG : BROWSER_OUTPUT:
10:38:40 INFO - 2015-10-23 10:38:40,454 DEBUG : BROWSER_OUTPUT: 1445621920437 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no]
10:40:54 INFO - 2015-10-23 10:40:54,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49721/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49721/tests/dromaeo/cssquery-ext.html)
10:40:55 INFO - 2015-10-23 10:40:55,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 165810176
10:40:55 INFO - 2015-10-23 10:40:55,244 DEBUG : BROWSER_OUTPUT:
10:43:58 INFO - 2015-10-23 10:43:58,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49721/tests/dromaeo/cssquery-ext.html (next: http://localhost:49721/tests/dromaeo/cssquery-jquery.html)
10:43:58 INFO - 2015-10-23 10:43:58,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 197627904
10:43:58 INFO - 2015-10-23 10:43:58,595 DEBUG : BROWSER_OUTPUT:
10:47:01 INFO - 2015-10-23 10:47:00,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49721/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49721/tests/dromaeo/cssquery-mootools.html)
10:47:01 INFO - 2015-10-23 10:47:01,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 151207936
10:47:01 INFO - 2015-10-23 10:47:01,552 DEBUG : BROWSER_OUTPUT:
10:50:03 INFO - 2015-10-23 10:50:03,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49721/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49721/tests/dromaeo/cssquery-prototype.html)
10:50:04 INFO - 2015-10-23 10:50:04,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 143491072
10:50:04 INFO - 2015-10-23 10:50:04,332 DEBUG : BROWSER_OUTPUT:
10:53:07 INFO - 2015-10-23 10:53:07,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49721/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49721/tests/dromaeo/cssquery-yui.html)
10:53:07 INFO - 2015-10-23 10:53:07,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584
10:53:07 INFO - 2015-10-23 10:53:07,891 DEBUG : BROWSER_OUTPUT:
10:56:10 INFO - 2015-10-23 10:56:10,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49721/tests/dromaeo/cssquery-yui.html (next: http://localhost:49721/tests/dromaeo/cssquery-dojo.html)
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 190492672
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT: __start_tp_report
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2357.8585284882906;2415.613501839706;2416.250962201717;2429.769171928667;2436.9521105924446;4172.5410204877435;4228.154369126176;4233.640140588046;4244.023874508857;4254.191703576318;4215.135897141086;4300.784960751966;4306.310990241562;4307.160103779756;4313.503947046091;3638.909027274313;3708.295423869463;3746.1571146492092;3749.531308586427;3798.810059497028;3612.548431446069;3619.9095022624383;3665.890023299305;3729.6643302102807;3743.47591337213;3718.0704823794053;3742.419924911643;3759.5300587426573;3805.448210009547;3817.331966905794;3619.457081437779;3690.5017822593873;3762.2663580601793;3779.8299076541484;3783.9783258520047;3639.290338384016;3693.2244228712;3708.2583483303447;3721.0325315417917;3730.421784623388;4111.691623128278;4156.729812562204;4163.854265100707;4214.536400995888;4219.11398606293;4399.824007039714;4473.9552604473865;4549.3176023596725;4563.680542362036;4575.748333841638;4556.157110934488;4581.083783243364;4594.563516465931;4654.837080702193;4684.882877928045;4216.978915105436;4224.007358270804;4300.118475712471;4301.354796780508;4312.611864932172;4479.55204479556;4610.907781844345;4618.792154353062;4707.835225767081;4708.317293992421;4391.099824535962;4438.511763705989;4453.487848897354;4482.417285752831;4493;4433.756143412079;4520.434945631796;4588.587027167571;4601.3558101865765;4620.653450991189;4308.332208507686;4485.955140448619;4492.415985921874;4561.543845615478;4561.749103799323;4450.376947227391;4455.554444555583;4509.413776209072;4579.084183163314;4595.816167353335;3123.422166899131;3123.984380078085;3175.6983086606733;3182.586263785693;3182.8885988990273;2826.759725423362;2925.063979526574;2927.8828846846313;2931.120663800851;2947.1600593830653;4189.350650649154;4196.748195108304;4221.91556168881;4356.520782713899;4363.454568178978;4526.207913615104;4531.207038768202;4638.373819534319;4639.652026097989;4651.558101980307;4130.669546436278;4227.429297044921;4240.872773816791;4318.725975837136;4322.805473753689;3775.301569209705;3886.6696330811633;3900.6099390060767;3904.492415985904;3919.862804801818;4658.184817656965;4695.201815691273;4705;4801.639877009308;4804.567588917014;4341.435613370241;4572.4055872736335;4593.678442508993;4656.604188644003;4668.229742092517;4549.818007279671;4597.241455159995;4660.743659098782;4668.743219122845;4676.0414115107005;4443.600075993176;4453.153900758845;4503.099380124054;4538.160440318552;4552.499225085172;4443.822247110079;4452.398926144929;4511.616512596466;4527.479339875957;4625.213713668617;4352.956470435255;4373.300271956472;4381.2332841753205;4449.154660614473;4469.620082293041;4339.978300108605;4387.978060109806;4448.599626033672;4471.150481408522;4486.977565112154;3963.56400795918;4303.935440968326;4365.628921541705;4388.29787234041;4388.956110438855;4308.569143085791;4393.165298593257;4407.360932664682;4427.136708341843;4495.640348772025;4356.194104090753;4361.171377438277;4368.650507959292;4457.888552786077;4468.2180618391
10:56:11 INFO - 2015-10-23 10:56:11,101 DEBUG : BROWSER_OUTPUT: |1;ext.html;463.5318328488226;470.5459231841273;482.0647942990599;493.5582653525093;497.47764846910746;25651.10221142258;31627;34330.656693433055;34831.65168348316;34895.127621809464;37592.81203593985;38312;38348;38420.58695619577;38424.80787596065;6090.634561926277;6128.20333356663;7929.484583502069;8112.269895709385;8136.6338514766685;9966.950165249164;9970.900290997106;10211;10253.231007674416;10265.692029239135;9283.257339412865;9633;9705.369151005161;9757.707268781947;9772.804543909118;6302.590331628476;6383.77656782015;9871.654492092779;10065.043820837009;10339.069483746423;9639.891412487514;9676.612935482572;9692.224622030291;9798.804023919552;9805.264605154642;35215.82392088023;35354;35715.464268036;35791.4631280531;35963.64036359629;2632.420867409167;2740.5478096114116;2810.353618667718;2835.8298502089733;3304.5043243513664;26887.731122688718;26913;27174.45651086987;27373.452530949467;27466.58800118;2098.7271654684946;2119.3535971528677;2151.8170955468804;2178.3356076396694;2198.923037693673;218840;223936.880315599;228009;229993;231598;47376;48109;48576.757116214896;48592.51407485951;48675.5132448671;44384.55615443804;45881.311780323325;55288.44711552833;56963.715181423824;56982.7150864243;10651.84022239667;10826.35041897473;10883.292585981886;10886.727831804268;10902.96421839924;7731;7772.145064042951;7779.105402878628;7790.610469476504;7819.491733037335;15983.280752366172;16013.839861601235;16042.679146417006;16076.196190190678;16129.354825806837;6959.434127321312;6973.965130174317;7119.181294151135;7164.749233776897;7165.89251161233;778.5873487051758;869.852125138728;871.3943809052774;959.9632397011351;976.5965609849668;24538.386540336276;25746.227613171635;26257.343566410993;26334.209973700436;26558.336041599116;887.0331338840695;920.1074957291416;929.7350255177242;940.8965013848472;1008.1027885182194;12471.75056498865;12840.61478155657;13006.159348301137;13069.803952940714;13214.33928303581;274753;276374;280551.8896220764;282671;284054;42705.78647106745;43069;43349.56650433455;43354.783226083666;43484.56515434805;1012.4735137728487;1013.159077965287;1110.7056629993058;1130.423484023154;1145.5360578965199;23881.522369552164;24021.879890600434;24272.1504747333;24349.513009739352;25202.873985629954;36690.26619467649;36909.26181476409;37026;37066;37114.44328335131;224099;232593;351695;353970;356763;24187.879060604584;25235.369115772253;25349.43710132194;25358.870806509272;25402.618960715972;36629.26741465209;36843.447348289264;37321;37500;37626.43560346542;30745.538816917317;31256;31699.36601268008;32052.19869503281;32613;29447.263818403855;31729.365412692077;31881.20296992501;32177.517337240428;32354.35291294208;31165.220869478446;31582.526262105628;31810.522842156923;31834.204144896565;31882.68117318797;28012.71987280101;28968.130956071353;29011.274718132216;29241.415171696874;30624.846875765477;22653;22675;22859.54280914339;23090.41367351994;23108.29451630353
10:56:11 INFO - 2015-10-23 10:56:11,111 DEBUG : BROWSER_OUTPUT: |2;jquery.html;289.4832723588395;292.2299740184613;293.55966050923615;296.5448037262802;302.8024164429681;11414.372209528472;11949.522019119226;15271.389144434223;15390.384384624616;15705.136217508032;11915.974284371656;13633.454661813515;13756.38096285667;13819.101758385697;13857.23785191814;5115.744212789355;5120.564751996085;5235.2147177923425;5241.397239317489;5244.973775131119;3436.2612038411735;3534.169470174507;5056.469070747574;5555.972220138914;5702.718912435018;5624.662520248778;5648.632838865481;5653.462921022497;5656.943430565703;5659.745311460994;5200.21996700496;5663.405342439047;5664.0937450008005;5744.655320680772;5762.279715035621;4956.355673762388;4959.156943319645;4960.603151747851;4965.106280869442;4974.1543937530705;18256.817431825777;18471.445856624323;18678.46253811155;18750.90624546882;18772.3718679385;1831.111910723298;1848.473185142228;1889.1782074797507;1928.4889504281377;1941.9223231070741;12488.93844023259;12660.68348291291;12677.74644507114;12875.935620321932;13005.349732513336;1714.4770844892303;1719.759233707282;1726.1283052058754;1764.7352897065543;1776.0498133498645;54975.53341125656;55217.89564208734;56729;57127.71436142793;57171.71414142902;8772.692955746517;8838.160374764388;9006.774830629287;9007.369484136048;9018.413803102778;10686.839697404544;11097.056750176325;11141.387223702612;11187.440627968568;11204.462192811925;6197.938020619736;6201.56589038772;6264.21697287839;6274.905876411857;6307.148534947723;5815;5865.501432378295;5943.55423343251;5956.16613674086;5976.193213916153;5154.7938082476285;5220.947790522122;5244.7902083916215;5250.789968401221;5306.204069389622;1473.1602986297708;1532.6321682796272;1575.243882936174;1607.638281386702;1617.5390013845997;715.2418436457372;735.1435577552198;755.5126943121766;758.0940775773008;782.2724865874677;15012.924935375471;15660.765088523682;15799.289031993589;15815.683686326209;15868.761968570481;326.76655062647075;352.68963312285024;354.5886771345227;387.9437481565157;762.8207371267748;5651.406602306781;5677.205191273225;5811.389804070596;5814.476697097197;6063.636181829104;294025;295923;297578;297618;299093;64274.67862660657;64632.676836615516;65245;66254.66872665702;66870.66564667145;427.9507856596469;432.1292595420231;437.4553680667653;438.51544043831746;439.3102828559195;10087.243456740627;10089.293749437762;10095.89904100979;10151.847722284025;10368.429736364573;33908.321833563685;34354.48468272928;35113.122171945906;35271.64728352786;35762.28475430529;44825.55174448214;45605.54394456013;45917.77041114773;46033.30950035685;46486.76756616195;5634.774609015593;5715;5717.656940583578;5727.97136014334;5733.684647344436;10444.321119127233;10771.353718776898;11025.283356581796;11076.335419874833;11199.72000699989;7840.490368126054;8008.879866801886;9081.863772043556;9423.434593924387;9474.38416502925;9184.173424391836;9246.676366327147;9422.905770942203;9455.101765332283;9457.24342052648;9344.766380840534;9553.426794392359;9701.805963880824;9729.075737804897;9743.269254805777;5575.776968921197;5595.440455954372;5602.159676048625;5613.242212301287;5618.381977982337;9293.163615274658;9407.670731524364;9503.19222866064;9525.190358819578;9546.522673866419
10:56:11 INFO - 2015-10-23 10:56:11,112 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1143.1540659911668;1267.1763353820015;1309.3387839141237;1416.7308211439827;1495.7532007218804;7008;7437;7717.151113377538;7758.456908016441;7764.689412423496;7769.961150194255;8158;8159.102498725136;8174.550399728013;8180.713675021376;2030.8679935804162;2056.928007519737;2057.77364489906;2058.4236413804083;2060.5878824235215;2033.247698351612;2052.901697591789;2054.7123402723632;2073.1914553324214;2078.158345869925;1984.4046785964226;2001.1295086637288;2022.686483595045;2036.511237303044;2043.38698390483;2011.0246530432728;2052.3842847145797;2063.7420322459543;2064.876107433544;2065.75210974684;1990.6814909614393;2018.606371757508;2028.8275496582808;2038.5311378382908;2038.8980550972392;6754.290799466084;6846.383825455683;7672.1560628330835;7727;7813;4326.199653064194;4456.977715111436;4459.487158976727;4462.352958820953;4466.0844526871915;2596.2989992702055;2660.76053155215;2675.598660200966;2675.8260713053587;2689.4755522673086;740.6926125657899;769.3114662377141;778.8442311537715;779.8869163971249;780.7813812132555;11158.386288754115;11247.831282530688;11249.55001799927;11259.662210133709;11299;4018.2767101921936;4067.3695577185586;4069.6337329640473;4094.160697057096;4112.670986321087;9505.04949505044;9520.8571871422;9527.952360238292;9532.666356677482;9535.427874327563;4261.808218630169;4267.423897773823;4270.871873843727;4271.1671224111;4277.059047009653;3803.1633040730994;3803.4675145479655;3810.218905124498;3818.9618103818607;3821.3503704370323;3130.2174456385906;3225.854836532362;3241.8379081045855;3250.723688486458;3259.1689119274433;1030.9123724483352;1049.7665243339045;1058.7035630023606;1065.1798115451058;1070.7537266428765;860.2214995429022;871.372611719561;879.6525372477836;883.1212943121635;883.7304622090196;7243.818904527429;7294.124705035323;7309.707611695472;7316.414686825041;7579.5073320234005;894.4230971023653;894.6108442827391;939.4457270210609;968.4092703450889;986.4820968991337;5594.300712410949;5660.094384898396;5664.773409063591;5670.773169073191;5671.914921276184;8596.484210947363;8938.86591701125;9428.481433521221;9542.52287385628;9579.616815327448;9269.212116970133;9292.303077269233;9351.39215950961;9449.716508504756;9471.621135154517;7006.754763583352;7087.468439867133;7091.680874360666;7093.467989900778;7111.715531378687;6846.486513511407;6957.4086202671315;7012.6844292008;7016.684249208696;7059.611721355374;8276.958615206886;8340.582970851554;8388.454750441202;8389.203025712548;8394.874076888973;8287.419880608299;8578.65685372578;8626.82746345057;8632.223099921037;8648.351373647127;6920.100386949664;6985.126859142607;6986.755463558751;7003.299670032956;7005.439564834903;7602.885956710765;7647.847043059219;7672.769816905502;7729.111152217342;7738.9104941666565;6941.47938904574;7104.827703428877;7215.242399547972;7262.491625586158;7281.672324745293;6959.791206263821;6971.024056631974;7124.358807707124;7151;7201.3158749918675;6881.071055407456;6911.101556797584;6927.89608155868;6928.44572434194;6932.202796678245;6065.878682426415;6146.78486252979;6253.155823963707;6348.492120630246;6401.807945761635;6442;6455.644939528371;6477.870442591027;6503.317151699003;6505.154329937078
10:56:11 INFO - 2015-10-23 10:56:11,167 DEBUG : BROWSER_OUTPUT: |4;prototype.html;270.9092454027901;271.8015848430647;277.795820072247;279.1388566273048;281.1523257379001;4609.67732258742;4678.672492925497;4683.297505374191;4684.414448193976;4686.953130468699;4377;4509.458864936204;4547.590716835484;4606.193916064683;4622.514635963226;3500.7374446916456;3524.330377228331;3541.9020103767784;3544.5746510418785;3545.804980726059;3408.539847120644;3459.7924124552483;3468.479728040789;3518.753687241894;3529.435290353544;3492.7729697569703;3495.2310491691787;3496.702780263681;3498.825058747065;3500.8074555899416;3485.9128521786906;3493.388656985043;3496.230829217568;3496.965030349689;3502.8949131526097;3049.130997665655;3098.442280389529;3099.039297817661;3100.379924015206;3100.627924649034;4304.78476076195;4441.578050085237;4470.597646211824;4472.798724057425;4496.055828276066;4146.295129827937;4156.397322388267;4166.708330416872;4166.895827604304;4172.248995180867;4815.66290359675;4931.137051016094;4977.303177555145;4981.352424184869;4984.053029924339;3490.2844916791996;3540.486629438717;3544.8227588620466;3547.7693949893173;3549.4143466328023;5180.740962951837;5182.404023537304;5184.637075404723;5184.818531351385;5188.325517682715;3467.8439470223398;3473.8610455581493;3520.2607452435277;3557.857685692595;3597.388443964532;3397.8980630581123;3612.8619484862184;3636.563612366533;3644.817759112034;3645.8177091145335;4121.670266378683;4154.979225103855;4159.272127377697;4161.500619925568;4161.750294982311;4515.864524064284;4912.680675756064;4917.483664215206;4920.778564964585;4939.654224204343;1306.5753630070265;1322.6428864206803;1328.103530117167;1328.747537967783;1329.2290471526492;907.3603109807569;931.2782593489964;933.7758937855002;944.197432182653;946.7254496196164;4733.124371991193;4766.4995175506765;4773.069251495995;4777.378940737682;4782.52174782519;5140.254663073908;5143.177091665316;5151.639385243072;5156.252343410185;5157.948420515821;4681.50844161365;4746.43042834862;4748.216544270226;4760.547747963938;4769.236922092448;2774.375765452797;2787.2753084198253;2799.384135490189;2801.537746271883;2807.03157410693;5195.168772996378;5237.869053273698;5239.685618862804;5245.921311180336;5251.816186433456;5265.210218467184;5273.182656688219;5275.076861549213;5282.366116066097;5284.656497327738;5288.127458969304;5291.100512912814;5294.338207724035;5295.788168473295;5296.973515132399;5063.544281014579;5089.541941225308;5114.360704911886;5139.92290115656;5161.3032240647035;5043.344365232496;5059.696418214919;5077.162268225849;5119.257707632447;5124.128898087409;5030.8239211627415;5314.415414304346;5316.494932981361;5331.1470164773455;5352.464753524772;3585.551806024247;3601.459781032866;3613.9638603613625;3619.601843797233;3630.927381452409;4972.751362431936;5040.243963405518;5066.873328166826;5186.6369354144845;5190.2214667800135;4775.928361074517;4805.111054454797;4882.511748825089;4952.257161425671;4964.950350496593;4581.954180458286;4822.71063736177;4908.730019848943;4937.086638971802;4952.653314267966;4809.422869255712;4833.32333473307;4834.492378300369;4843.885906241655;4855.053264613508;4933.851984440473;4959.528844759742;4974.5771609413605;4983.9501604984935;5028.974855125847;4473.731576105314;4709.788059537261;4783.95216047835;4784.784684689267;4876.073546026244
10:56:11 INFO - 2015-10-23 10:56:11,167 DEBUG : BROWSER_OUTPUT: |5;yui.html;621.4562258024229;674.9021391898175;705.1432509500959;706.6219572528696;722.1298335505716;11228.6631401058;11389.487473063711;11391.715207119827;11403.640289064126;11404.258723182998;9416.764580885481;9608.087231712976;9614.615415383376;9625.903740962589;9674.080962308588;610.5390430225185;624.1137584629814;626.0421555020803;628.5788521690456;628.9025201093838;484.9660523763338;492.32059757534734;625.6652690810417;631.5452873930763;631.974721011159;605.7819185093363;653.4478365780931;654.2737561306946;654.6726636681659;655.5018186178514;638.9201349831271;648.3613640564041;649.0361812708124;650.5348675696852;651.9706613202417;370.0785045237366;374.74704574412164;471.1378177934372;472.78724573941867;475.94288685357634;9694.660686875926;10391.37651740898;10434.37393756377;10463;10481.109105726022;9740.366876153099;9795.755106122333;10269.691909242734;10317.535710892953;10597.311174773615;8716.477011379338;8788.384813063089;8961;8987.670021560094;9194.08059194082;3123.9531407028912;3166.066010526877;3172.4924012158176;3175.666555011737;3210.7110360067704;34016.48975265373;34200;34233.4864977023;34245.486317705254;34314.14214644629;8321.625526851307;8531.74404767858;8558.101399353103;8595.968483781986;8876.068012858686;14715.337809798584;14725.116493010453;14759.852401475848;14763.114213147246;14773.704525909636;5493.862653433696;5618.606697531133;6067.605605635619;6279.748810047547;6347.936520634827;3424.5558469837483;3426.468897320919;3474.0219364787627;3485.5294535237927;3488.145404375944;2155.202575047211;2162.1243396424475;2177.466520702438;2182.5853087913247;2184.868907865533;347.36258964799873;351.9648035196511;357.8604344305723;361.2702341270619;361.67449295633617;561.3796754586124;569.2770181869085;570.1533223163599;585.2567239605677;585.5110982329802;6656.434203092695;6831.795046148623;6956.339147780953;6963.547369420971;6993.370596646327;391.17462154853234;439.9296112621965;451.4988362917159;571.5456212311223;621.7202258983475;3336.716379107803;3364.3775901458307;3442.9827850860584;3454.464557993515;3478.652134786552;40060.59939400569;42228.36657450141;42302.57697423048;42302.788486057376;42314.365284520754;34737.65262347395;34838.82580587132;35022.649773502446;35125;36008;31143.68856311453;31562.526562102044;32733;32832.343353132805;32919.17702057468;6553.148090748363;7015.193252775996;7029.156501219886;7109.715611375487;7253.927460725537;22424.439389015406;22903.656445153003;22927.426814329774;22973.310800676005;22976.655350170095;31597.8420107898;32303.030909072764;32754.344913102083;32785.836070819496;32844.1788955278;6540.934590654033;6544.411003009752;6588.209414870246;6712.83217919556;6745.089412929388;10617.203709721647;10672.8932710675;10682.412467314372;10857.565697372333;10890.564377425131;9292.39599426035;9441.622335106518;9468;9625.422474651543;9741;10111.64609238673;10283.485825708534;10284.691459256233;10304.639337623148;10706.411147386969;9179.954100229455;9194.724158275263;9242.306826987868;9425;9496.667616633385;8991.119696901638;9009.414388064755;9077.636894524145;9319.673811416567;9564.33049686543;7854.960725196337;8092.312153467021;8141.8778718320455;8234.835303293781;8402.579871006303
10:56:11 INFO - 2015-10-23 10:56:11,168 DEBUG : BROWSER_OUTPUT: __end_tp_report
10:56:11 INFO - 2015-10-23 10:56:11,168 DEBUG : BROWSER_OUTPUT: __start_cc_report
10:56:11 INFO - 2015-10-23 10:56:11,168 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,874
10:56:11 INFO - 2015-10-23 10:56:11,168 DEBUG : BROWSER_OUTPUT: __end_cc_report
10:56:11 INFO - 2015-10-23 10:56:11,168 DEBUG : BROWSER_OUTPUT: __startTimestamp1445622971105__endTimestamp
10:56:11 INFO - 2015-10-23 10:56:11,168 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT: Number of tests: 6
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4171.06 Median:4361.17 stddev:532.12 (12.2%) stddev-sans-first:514.39
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT: Values: 2357.9 2415.6 2416.3 2429.8 2437.0 4172.5 4228.2 4233.6 4244.0 4254.2 4215.1 4300.8 4306.3 4307.2 4313.5 3638.9 3708.3 3746.2 3749.5 3798.8 3612.5 3619.9 3665.9 3729.7 3743.5 3718.1 3742.4 3759.5 3805.4 3817.3 3619.5 3690.5 3762.3 3779.8 3784.0 3639.3 3693.2 3708.3 3721.0 3730.4 4111.7 4156.7 4163.9 4214.5 4219.1 4399.8 4474.0 4549.3 4563.7 4575.7 4556.2 4581.1 4594.6 4654.8 4684.9 4217.0 4224.0 4300.1 4301.4 4312.6 4479.6 4610.9 4618.8 4707.8 4708.3 4391.1 4438.5 4453.5 4482.4 4493.0 4433.8 4520.4 4588.6 4601.4 4620.7 4308.3 4486.0 4492.4 4561.5 4561.7 4450.4 4455.6 4509.4 4579.1 4595.8 3123.4 3124.0 3175.7 3182.6 3182.9 2826.8 2925.1 2927.9 2931.1 2947.2 4189.4 4196.7 4221.9 4356.5 4363.5 4526.2 4531.2 4638.4 4639.7 4651.6 4130.7 4227.4 4240.9 4318.7 4322.8 3775.3 3886.7 3900.6 3904.5 3919.9 4658.2 4695.2 4705.0 4801.6 4804.6 4341.4 4572.4 4593.7 4656.6 4668.2 4549.8 4597.2 4660.7 4668.7 4676.0 4443.6 4453.2 4503.1 4538.2 4552.5 4443.8 4452.4 4511.6 4527.5 4625.2 4353.0 4373.3 4381.2 4449.2 4469.6 4340.0 4388.0 4448.6 4471.2 4487.0 3963.6 4303.9 4365.6 4388.3 4389.0 4308.6 4393.2 4407.4 4427.1 4495.6 4356.2 4361.2 4368.7 4457.9 4468.2
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41427.68 Median:32114.86 stddev:71968.85 (224.1%) stddev-sans-first:72105.02
10:56:11 INFO - 2015-10-23 10:56:11,170 DEBUG : BROWSER_OUTPUT: Values: 463.5 470.5 482.1 493.6 497.5 25651.1 31627.0 34330.7 34831.7 34895.1 37592.8 38312.0 38348.0 38420.6 38424.8 6090.6 6128.2 7929.5 8112.3 8136.6 9967.0 9970.9 10211.0 10253.2 10265.7 9283.3 9633.0 9705.4 9757.7 9772.8 6302.6 6383.8 9871.7 10065.0 10339.1 9639.9 9676.6 9692.2 9798.8 9805.3 35215.8 35354.0 35715.5 35791.5 35963.6 2632.4 2740.5 2810.4 2835.8 3304.5 26887.7 26913.0 27174.5 27373.5 27466.6 2098.7 2119.4 2151.8 2178.3 2198.9 218840.0 223936.9 228009.0 229993.0 231598.0 47376.0 48109.0 48576.8 48592.5 48675.5 44384.6 45881.3 55288.4 56963.7 56982.7 10651.8 10826.4 10883.3 10886.7 10903.0 7731.0 7772.1 7779.1 7790.6 7819.5 15983.3 16013.8 16042.7 16076.2 16129.4 6959.4 6974.0 7119.2 7164.7 7165.9 778.6 869.9 871.4 960.0 976.6 24538.4 25746.2 26257.3 26334.2 26558.3 887.0 920.1 929.7 940.9 1008.1 12471.8 12840.6 13006.2 13069.8 13214.3 274753.0 276374.0 280551.9 282671.0 284054.0 42705.8 43069.0 43349.6 43354.8 43484.6 1012.5 1013.2 1110.7 1130.4 1145.5 23881.5 24021.9 24272.2 24349.5 25202.9 36690.3 36909.3 37026.0 37066.0 37114.4 224099.0 232593.0 351695.0 353970.0 356763.0 24187.9 25235.4 25349.4 25358.9 25402.6 36629.3 36843.4 37321.0 37500.0 37626.4 30745.5 31256.0 31699.4 32052.2 32613.0 29447.3 31729.4 31881.2 32177.5 32354.4 31165.2 31582.5 31810.5 31834.2 31882.7 28012.7 28968.1 29011.3 29241.4 30624.8 22653.0 22675.0 22859.5 23090.4 23108.3
10:56:11 INFO - 2015-10-23 10:56:11,171 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,171 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19984.08 Median:5015.31 stddev:49227.22 (981.5%) stddev-sans-first:49343.11
10:56:11 INFO - 2015-10-23 10:56:11,171 DEBUG : BROWSER_OUTPUT: Values: 289.5 292.2 293.6 296.5 302.8 11414.4 11949.5 15271.4 15390.4 15705.1 11916.0 13633.5 13756.4 13819.1 13857.2 5115.7 5120.6 5235.2 5241.4 5245.0 3436.3 3534.2 5056.5 5556.0 5702.7 5624.7 5648.6 5653.5 5656.9 5659.7 5200.2 5663.4 5664.1 5744.7 5762.3 4956.4 4959.2 4960.6 4965.1 4974.2 18256.8 18471.4 18678.5 18750.9 18772.4 1831.1 1848.5 1889.2 1928.5 1941.9 12488.9 12660.7 12677.7 12875.9 13005.3 1714.5 1719.8 1726.1 1764.7 1776.0 54975.5 55217.9 56729.0 57127.7 57171.7 8772.7 8838.2 9006.8 9007.4 9018.4 10686.8 11097.1 11141.4 11187.4 11204.5 6197.9 6201.6 6264.2 6274.9 6307.1 5815.0 5865.5 5943.6 5956.2 5976.2 5154.8 5220.9 5244.8 5250.8 5306.2 1473.2 1532.6 1575.2 1607.6 1617.5 715.2 735.1 755.5 758.1 782.3 15012.9 15660.8 15799.3 15815.7 15868.8 326.8 352.7 354.6 387.9 762.8 5651.4 5677.2 5811.4 5814.5 6063.6 294025.0 295923.0 297578.0 297618.0 299093.0 64274.7 64632.7 65245.0 66254.7 66870.7 428.0 432.1 437.5 438.5 439.3 10087.2 10089.3 10095.9 10151.8 10368.4 33908.3 34354.5 35113.1 35271.6 35762.3 44825.6 45605.5 45917.8 46033.3 46486.8 5634.8 5715.0 5717.7 5728.0 5733.7 10444.3 10771.4 11025.3 11076.3 11199.7 7840.5 8008.9 9081.9 9423.4 9474.4 9184.2 9246.7 9422.9 9455.1 9457.2 9344.8 9553.4 9701.8 9729.1 9743.3 5575.8 5595.4 5602.2 5613.2 5618.4 9293.2 9407.7 9503.2 9525.2 9546.5
10:56:11 INFO - 2015-10-23 10:56:11,173 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,173 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5346.76 Median:6924.00 stddev:2969.73 (42.9%) stddev-sans-first:2961.26
10:56:11 INFO - 2015-10-23 10:56:11,173 DEBUG : BROWSER_OUTPUT: Values: 1143.2 1267.2 1309.3 1416.7 1495.8 7008.0 7437.0 7717.2 7758.5 7764.7 7770.0 8158.0 8159.1 8174.6 8180.7 2030.9 2056.9 2057.8 2058.4 2060.6 2033.2 2052.9 2054.7 2073.2 2078.2 1984.4 2001.1 2022.7 2036.5 2043.4 2011.0 2052.4 2063.7 2064.9 2065.8 1990.7 2018.6 2028.8 2038.5 2038.9 6754.3 6846.4 7672.2 7727.0 7813.0 4326.2 4457.0 4459.5 4462.4 4466.1 2596.3 2660.8 2675.6 2675.8 2689.5 740.7 769.3 778.8 779.9 780.8 11158.4 11247.8 11249.6 11259.7 11299.0 4018.3 4067.4 4069.6 4094.2 4112.7 9505.0 9520.9 9528.0 9532.7 9535.4 4261.8 4267.4 4270.9 4271.2 4277.1 3803.2 3803.5 3810.2 3819.0 3821.4 3130.2 3225.9 3241.8 3250.7 3259.2 1030.9 1049.8 1058.7 1065.2 1070.8 860.2 871.4 879.7 883.1 883.7 7243.8 7294.1 7309.7 7316.4 7579.5 894.4 894.6 939.4 968.4 986.5 5594.3 5660.1 5664.8 5670.8 5671.9 8596.5 8938.9 9428.5 9542.5 9579.6 9269.2 9292.3 9351.4 9449.7 9471.6 7006.8 7087.5 7091.7 7093.5 7111.7 6846.5 6957.4 7012.7 7016.7 7059.6 8277.0 8340.6 8388.5 8389.2 8394.9 8287.4 8578.7 8626.8 8632.2 8648.4 6920.1 6985.1 6986.8 7003.3 7005.4 7602.9 7647.8 7672.8 7729.1 7738.9 6941.5 7104.8 7215.2 7262.5 7281.7 6959.8 6971.0 7124.4 7151.0 7201.3 6881.1 6911.1 6927.9 6928.4 6932.2 6065.9 6146.8 6253.2 6348.5 6401.8 6442.0 6455.6 6477.9 6503.3 6505.2
10:56:11 INFO - 2015-10-23 10:56:11,174 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,174 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4135.02 Median:4739.78 stddev:1229.06 (25.9%) stddev-sans-first:1197.80
10:56:11 INFO - 2015-10-23 10:56:11,174 DEBUG : BROWSER_OUTPUT: Values: 270.9 271.8 277.8 279.1 281.2 4609.7 4678.7 4683.3 4684.4 4687.0 4377.0 4509.5 4547.6 4606.2 4622.5 3500.7 3524.3 3541.9 3544.6 3545.8 3408.5 3459.8 3468.5 3518.8 3529.4 3492.8 3495.2 3496.7 3498.8 3500.8 3485.9 3493.4 3496.2 3497.0 3502.9 3049.1 3098.4 3099.0 3100.4 3100.6 4304.8 4441.6 4470.6 4472.8 4496.1 4146.3 4156.4 4166.7 4166.9 4172.2 4815.7 4931.1 4977.3 4981.4 4984.1 3490.3 3540.5 3544.8 3547.8 3549.4 5180.7 5182.4 5184.6 5184.8 5188.3 3467.8 3473.9 3520.3 3557.9 3597.4 3397.9 3612.9 3636.6 3644.8 3645.8 4121.7 4155.0 4159.3 4161.5 4161.8 4515.9 4912.7 4917.5 4920.8 4939.7 1306.6 1322.6 1328.1 1328.7 1329.2 907.4 931.3 933.8 944.2 946.7 4733.1 4766.5 4773.1 4777.4 4782.5 5140.3 5143.2 5151.6 5156.3 5157.9 4681.5 4746.4 4748.2 4760.5 4769.2 2774.4 2787.3 2799.4 2801.5 2807.0 5195.2 5237.9 5239.7 5245.9 5251.8 5265.2 5273.2 5275.1 5282.4 5284.7 5288.1 5291.1 5294.3 5295.8 5297.0 5063.5 5089.5 5114.4 5139.9 5161.3 5043.3 5059.7 5077.2 5119.3 5124.1 5030.8 5314.4 5316.5 5331.1 5352.5 3585.6 3601.5 3614.0 3619.6 3630.9 4972.8 5040.2 5066.9 5186.6 5190.2 4775.9 4805.1 4882.5 4952.3 4965.0 4582.0 4822.7 4908.7 4937.1 4952.7 4809.4 4833.3 4834.5 4843.9 4855.1 4933.9 4959.5 4974.6 4984.0 5029.0 4473.7 4709.8 4784.0 4784.8 4876.1
10:56:11 INFO - 2015-10-23 10:56:11,176 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,176 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10370.05 Median:488.64 stddev:11173.28 (2286.6%) stddev-sans-first:11180.63
10:56:11 INFO - 2015-10-23 10:56:11,176 DEBUG : BROWSER_OUTPUT: Values: 621.5 674.9 705.1 706.6 722.1 11228.7 11389.5 11391.7 11403.6 11404.3 9416.8 9608.1 9614.6 9625.9 9674.1 610.5 624.1 626.0 628.6 628.9 485.0 492.3 625.7 631.5 632.0 605.8 653.4 654.3 654.7 655.5 638.9 648.4 649.0 650.5 652.0 370.1 374.7 471.1 472.8 475.9 9694.7 10391.4 10434.4 10463.0 10481.1 9740.4 9795.8 10269.7 10317.5 10597.3 8716.5 8788.4 8961.0 8987.7 9194.1 3124.0 3166.1 3172.5 3175.7 3210.7 34016.5 34200.0 34233.5 34245.5 34314.1 8321.6 8531.7 8558.1 8596.0 8876.1 14715.3 14725.1 14759.9 14763.1 14773.7 5493.9 5618.6 6067.6 6279.7 6347.9 3424.6 3426.5 3474.0 3485.5 3488.1 2155.2 2162.1 2177.5 2182.6 2184.9 347.4 352.0 357.9 361.3 361.7 561.4 569.3 570.2 585.3 585.5 6656.4 6831.8 6956.3 6963.5 6993.4 391.2 439.9 451.5 571.5 621.7 3336.7 3364.4 3443.0 3454.5 3478.7 40060.6 42228.4 42302.6 42302.8 42314.4 34737.7 34838.8 35022.6 35125.0 36008.0 31143.7 31562.5 32733.0 32832.3 32919.2 6553.1 7015.2 7029.2 7109.7 7253.9 22424.4 22903.7 22927.4 22973.3 22976.7 31597.8 32303.0 32754.3 32785.8 32844.2 6540.9 6544.4 6588.2 6712.8 6745.1 10617.2 10672.9 10682.4 10857.6 10890.6 9292.4 9441.6 9468.0 9625.4 9741.0 10111.6 10283.5 10284.7 10304.6 10706.4 9180.0 9194.7 9242.3 9425.0 9496.7 8991.1 9009.4 9077.6 9319.7 9564.3 7855.0 8092.3 8141.9 8234.8 8402.6
10:56:11 INFO - 2015-10-23 10:56:11,177 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
10:56:11 INFO - 2015-10-23 10:56:11,177 DEBUG : BROWSER_OUTPUT:
10:56:11 INFO - 2015-10-23 10:56:11,704 INFO : Browser exited with error code: 0
10:56:12 INFO - 2015-10-23 10:56:12,536 INFO : Completed test dromaeo_css (00:18:45)
10:56:12 INFO - 2015-10-23 10:56:12,536 INFO : Starting test kraken
10:56:12 INFO - 2015-10-23 10:56:12,536 DEBUG : operating with platform_type : w7_
10:56:12 INFO - 2015-10-23 10:56:12,536 INFO : Initialising browser for kraken test...
10:56:12 INFO - 2015-10-23 10:56:12,562 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpuw7xpt\profile http://localhost:49721/getInfo.html
10:56:17 INFO - 2015-10-23 10:56:17,552 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
10:56:17 INFO - 2015-10-23 10:56:17,552 DEBUG : BROWSER_OUTPUT: colorDepth:24
10:56:17 INFO - 2015-10-23 10:56:17,552 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
10:56:17 INFO - 2015-10-23 10:56:17,552 DEBUG : BROWSER_OUTPUT: __metrics
10:56:17 INFO - 2015-10-23 10:56:17,615 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
10:56:18 INFO - 2015-10-23 10:56:18,275 DEBUG : BROWSER_OUTPUT: console.error:
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no]
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: Stack:
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12
10:56:18 INFO - 2015-10-23 10:56:18,278 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 5752.24
10:57:57 INFO - RETURN: kraken: 1627.00
10:57:57 INFO - RETURN: v8_7: 20223.05
10:57:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,25]]", "result": "20223.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,25]]", "result": "1627.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,25]]", "result": "5752.24"}}}
10:57:57 INFO - Return code: 0
10:57:57 INFO - # TBPL SUCCESS #
10:57:57 INFO - Running post-action listener: _resource_record_post_action
10:57:57 INFO - Running post-run listener: _resource_record_post_run
10:57:59 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 79728128; Write bytes: 425343488; Read time: 1008990; Write time: 4889630
10:57:59 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 390144; Read time: 0; Write time: 7440
10:57:59 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 79728128; Write bytes: 403813888; Read time: 1008990; Write time: 4862150
10:57:59 INFO - Running post-run listener: _upload_blobber_files
10:57:59 INFO - Blob upload gear active.
10:57:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ...
10:57:59 INFO - Copying logs to upload dir...
10:57:59 INFO - mkdir: C:\slave\test\build\upload\logs
program finished with exit code 0
elapsedTime=1385.789000
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 5 secs) (at 2015-10-23 10:57:59.226190) =========
========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 10:57:59.230142) =========
'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f'
in dir C:\slave\test\properties (timeout 1200 secs)
watching logfiles {}
argv: ['cmd', '/C', 'for', '%f', 'in', '(*)', 'do', '@type', '%f']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test\properties
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
build_url:https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/jlL1EP-kRC-rWsR-w8_IDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip'
========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 10:57:59.348437) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 10:57:59.348861) =========
'rm' '-f' 'oauth.txt'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-105
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-105
MONDIR=C:\Monitor_config\
MOZBUILDDIR=C:\mozilla-build\
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NUMBER_OF_PROCESSORS=8
OS=Windows_NT
OURDRIVE=C:
PATH=C:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files
PROMPT=$P$G
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
RUNLOGFILE=C:\slave\\runslave.log
SLAVEDIR=C:\slave\
SYSTEMDRIVE=C:
SYSTEMROOT=C:\windows
TEMP=C:\Users\cltbld\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-105
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 10:57:59.466144) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-23 10:57:59.466563) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-23 10:58:00.094800) =========