builder: larch_win8_64_test-dromaeojs
slave: t-w864-ix-093
starttime: 1477509456.84
results: success (0)
buildid: 20161026095323
builduid: 0dfb9581140a4946af088611ee604e40
revision: 8e23fb23036b1d49ab9b39c5d79fbf12d4336a8b
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:36.843830) =========
master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:36.844252) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:36.844532) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:36.942378) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 12:17:36.942744) =========
'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.T-W864-IX-093\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-093
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-093
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Local
LOGONSERVER=\\T-W864-IX-093
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-093
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-093
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-093
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--12:17:38-- 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.
WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,179 (12K) [text/x-python]
0K .......... . 100% 1.85 GB/s
12:17:38 (1.85 GB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=1.260000
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 12:17:38.262807) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 12:17:38.263325) =========
'rm' '-rf' 'scripts' 'properties'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts', 'properties']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-093
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-093
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Local
LOGONSERVER=\\T-W864-IX-093
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-093
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-093
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-093
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=2.606000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 12:17:40.890681) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 12:17:40.891051) =========
'bash' '-c' u'python archiver_client.py mozharness --repo projects/larch --rev 8e23fb23036b1d49ab9b39c5d79fbf12d4336a8b --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 8e23fb23036b1d49ab9b39c5d79fbf12d4336a8b --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-093
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-093
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Local
LOGONSERVER=\\T-W864-IX-093
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-093
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-093
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-093
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-10-26 12:17:41,861 truncating revision to first 12 chars
2016-10-26 12:17:41,861 Setting DEBUG logging.
2016-10-26 12:17:41,861 attempt 1/10
2016-10-26 12:17:41,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/8e23fb23036b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-10-26 12:17:43,671 unpacking tar archive at: larch-8e23fb23036b/testing/mozharness/
2016-10-26 12:17:43,767 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=2.440000
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 12:17:43.391243) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:43.391617) =========
script_repo_revision: 8e23fb23036b1d49ab9b39c5d79fbf12d4336a8b
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:43.392000) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:43.392268) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 12:17:43.409964) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 15 secs) (at 2016-10-26 12:17:43.410401) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Larch-Non-PGO' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Larch-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', 'Larch-Non-PGO', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-093
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-093
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Local
LOGONSERVER=\\T-W864-IX-093
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-093
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-093
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-093
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
12:17:44 INFO - MultiFileLogger online at 20161026 12:17:44 in C:\slave\test
12:17:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO
12:17:44 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
12:17:44 INFO - {'append_to_log': False,
12:17:44 INFO - 'base_work_dir': 'C:\\slave\\test',
12:17:44 INFO - 'blob_upload_branch': 'Larch-Non-PGO',
12:17:44 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
12:17:44 INFO - 'branch': 'Larch-Non-PGO',
12:17:44 INFO - 'buildbot_json_path': 'buildprops.json',
12:17:44 INFO - 'config_files': ('talos/windows_config.py',),
12:17:44 INFO - 'default_actions': ('clobber',
12:17:44 INFO - 'read-buildbot-config',
12:17:44 INFO - 'download-and-extract',
12:17:44 INFO - 'populate-webroot',
12:17:44 INFO - 'create-virtualenv',
12:17:44 INFO - 'install',
12:17:44 INFO - 'run-tests'),
12:17:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
12:17:44 INFO - 'download_minidump_stackwalk': True,
12:17:44 INFO - 'download_symbols': 'ondemand',
12:17:44 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
12:17:44 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
12:17:44 INFO - 'hg': 'c:/mozilla-build/hg/hg',
12:17:44 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
12:17:44 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
12:17:44 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
12:17:44 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
12:17:44 INFO - 'C:/mozilla-build/tooltool.py'),
12:17:44 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
12:17:44 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
12:17:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
12:17:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
12:17:44 INFO - 'installer_path': 'installer.exe',
12:17:44 INFO - 'log_level': 'info',
12:17:44 INFO - 'log_name': 'talos',
12:17:44 INFO - 'log_to_console': True,
12:17:44 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
12:17:44 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
12:17:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
12:17:44 INFO - 'opt_config_files': (),
12:17:44 INFO - 'pip_index': False,
12:17:44 INFO - 'sps_profile': False,
12:17:44 INFO - 'sps_profile_interval': 0,
12:17:44 INFO - 'suite': 'dromaeojs',
12:17:44 INFO - 'system_bits': '32',
12:17:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
12:17:44 INFO - 'title': 'T-W864-IX-093',
12:17:44 INFO - 'use_talos_json': True,
12:17:44 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
12:17:44 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
12:17:44 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
12:17:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
12:17:44 INFO - 'work_dir': 'build'}
12:17:44 INFO - [mozharness: 2016-10-26 19:17:44.590000Z] Running clobber step.
12:17:44 INFO - Running pre-action listener: _resource_record_pre_action
12:17:44 INFO - Running main action method: clobber
12:17:44 INFO - rmtree: C:\slave\test\build
12:17:44 INFO - Using _rmtree_windows ...
12:17:44 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
12:20:17 INFO - Running post-action listener: _resource_record_post_action
12:20:17 INFO - [mozharness: 2016-10-26 19:20:17.149000Z] Finished clobber step (success)
12:20:17 INFO - [mozharness: 2016-10-26 19:20:17.149000Z] Running read-buildbot-config step.
12:20:17 INFO - Running pre-action listener: _resource_record_pre_action
12:20:17 INFO - Running main action method: read_buildbot_config
12:20:17 INFO - Using buildbot properties:
12:20:17 INFO - {
12:20:17 INFO - "project": "",
12:20:17 INFO - "product": "firefox",
12:20:17 INFO - "script_repo_revision": "production",
12:20:17 INFO - "builddir": "larch_win8_64_test-dromaeojs",
12:20:17 INFO - "repository": "",
12:20:17 INFO - "buildername": "Windows 8 64-bit larch talos dromaeojs",
12:20:17 INFO - "buildid": "20161026095323",
12:20:17 INFO - "pgo_build": "False",
12:20:17 INFO - "basedir": "C:\\slave\\test",
12:20:17 INFO - "buildnumber": 7,
12:20:17 INFO - "slavename": "t-w864-ix-093",
12:20:17 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/",
12:20:17 INFO - "platform": "win8_64",
12:20:17 INFO - "scheduler": "tests-larch-win64-talos",
12:20:17 INFO - "branch": "larch",
12:20:17 INFO - "repo_path": "projects/larch",
12:20:17 INFO - "revision": "8e23fb23036b1d49ab9b39c5d79fbf12d4336a8b",
12:20:17 INFO - "stage_platform": "win64",
12:20:17 INFO - "builduid": "0dfb9581140a4946af088611ee604e40",
12:20:17 INFO - "slavebuilddir": "test"
12:20:17 INFO - }
12:20:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip.
12:20:17 INFO - Running post-action listener: _resource_record_post_action
12:20:17 INFO - [mozharness: 2016-10-26 19:20:17.152000Z] Finished read-buildbot-config step (success)
12:20:17 INFO - [mozharness: 2016-10-26 19:20:17.153000Z] Running download-and-extract step.
12:20:17 INFO - Running pre-action listener: _resource_record_pre_action
12:20:17 INFO - Running main action method: download_and_extract
12:20:17 INFO - mkdir: C:\slave\test\build\tests
12:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:20:17 INFO - trying https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json
12:20:17 INFO - Downloading https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
12:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1
12:20:17 INFO - Downloaded 1274 bytes.
12:20:17 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
12:20:17 INFO - Using the following test package requirements:
12:20:17 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
12:20:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'],
12:20:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'firefox-52.0a1.en-US.win64.gtest.tests.zip'],
12:20:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'jsshell-win64.zip'],
12:20:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'],
12:20:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
12:20:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'],
12:20:17 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'],
12:20:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'],
12:20:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
12:20:17 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']}
12:20:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common
12:20:17 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
12:20:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
12:20:17 INFO - Fetch https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
12:20:18 INFO - Http code: 200
12:20:18 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront)
12:20:18 INFO - x-amz-cf-id: ANKb60FgD9CAdAIvs5F-mt-3IE2qm_vBX_I8fDRGrzk6eRVGU6FeiA==
12:20:18 INFO - x-amz-version-id: FR4ms5yYPT4fUoLjqNGySCicCg8z3GiK
12:20:19 INFO - Expected file size: 17456422
12:20:19 INFO - Obtained file size: 17456422
12:20:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
12:20:45 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
12:20:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
12:20:45 INFO - Fetch https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
12:20:45 INFO - Http code: 200
12:20:45 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront)
12:20:45 INFO - x-amz-cf-id: zcgjILN-9W1zCS2oZ15_133vkt42FRpru8l6ZS9DOqrVWqflWZzIxw==
12:20:45 INFO - x-amz-version-id: FR4ms5yYPT4fUoLjqNGySCicCg8z3GiK
12:20:45 INFO - Expected file size: 17456422
12:20:45 INFO - Obtained file size: 17456422
12:20:54 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip
12:20:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1
12:20:54 INFO - Fetch https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory
12:20:54 INFO - Http code: 200
12:20:54 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront)
12:20:54 INFO - x-amz-cf-id: BWXbuMo31CgC3tnxbTSYOXkJJDGoAJWhzXFgJFEx4_Zxv77QwkIb5w==
12:20:54 INFO - x-amz-version-id: jWVBWJcBE49Q7KIH_j6CGFli45ia0l0B
12:20:55 INFO - Expected file size: 14409028
12:20:55 INFO - Obtained file size: 14409028
12:21:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:04 INFO - trying https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
12:21:04 INFO - Downloading https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip
12:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1
12:21:05 INFO - Downloaded 56949757 bytes.
12:21:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
12:21:05 INFO - mkdir: C:\slave\test\properties
12:21:05 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
12:21:05 INFO - Writing to file C:\slave\test\properties\build_url
12:21:05 INFO - Contents:
12:21:05 INFO - build_url:https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
12:21:06 INFO - Running post-action listener: _resource_record_post_action
12:21:06 INFO - Running post-action listener: set_extra_try_arguments
12:21:06 INFO - [mozharness: 2016-10-26 19:21:06.661000Z] Finished download-and-extract step (success)
12:21:06 INFO - [mozharness: 2016-10-26 19:21:06.661000Z] Running populate-webroot step.
12:21:06 INFO - Running pre-action listener: _resource_record_pre_action
12:21:06 INFO - Running main action method: populate_webroot
12:21:06 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
12:21:06 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
12:21:06 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
12:21:06 INFO - u'--tppagecycles',
12:21:06 INFO - u'7'],
12:21:06 INFO - u'tests': [u'tsvgm']}},
12:21:06 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'tresize', u'tcanvasmark']},
12:21:06 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
12:21:06 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'dromaeo_css', u'kraken']},
12:21:06 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
12:21:06 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
12:21:06 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
12:21:06 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'damp', u'tps']},
12:21:06 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'tests': [u'damp', u'tps']},
12:21:06 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'dromaeo_dom']},
12:21:06 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
12:21:06 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'basic_compositor_video']},
12:21:06 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
12:21:06 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'a11yr',
12:21:06 INFO - u'ts_paint',
12:21:06 INFO - u'tpaint',
12:21:06 INFO - u'sessionrestore',
12:21:06 INFO - u'sessionrestore_no_auto_restore',
12:21:06 INFO - u'tabpaint']},
12:21:06 INFO - u'other-e10s': {u'tests': [u'a11yr',
12:21:06 INFO - u'ts_paint',
12:21:06 INFO - u'tpaint',
12:21:06 INFO - u'sessionrestore',
12:21:06 INFO - u'sessionrestore_no_auto_restore',
12:21:06 INFO - u'tabpaint']},
12:21:06 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
12:21:06 INFO - u'ts_paint',
12:21:06 INFO - u'tpaint',
12:21:06 INFO - u'sessionrestore',
12:21:06 INFO - u'sessionrestore_no_auto_restore',
12:21:06 INFO - u'tabpaint']},
12:21:06 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
12:21:06 INFO - u'ts_paint',
12:21:06 INFO - u'tpaint',
12:21:06 INFO - u'sessionrestore',
12:21:06 INFO - u'sessionrestore_no_auto_restore',
12:21:06 INFO - u'tabpaint']},
12:21:06 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'a11yr',
12:21:06 INFO - u'ts_paint',
12:21:06 INFO - u'tpaint',
12:21:06 INFO - u'sessionrestore',
12:21:06 INFO - u'sessionrestore_no_auto_restore',
12:21:06 INFO - u'tabpaint']},
12:21:06 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'a11yr',
12:21:06 INFO - u'ts_paint',
12:21:06 INFO - u'tpaint',
12:21:06 INFO - u'sessionrestore',
12:21:06 INFO - u'sessionrestore_no_auto_restore',
12:21:06 INFO - u'tabpaint']},
12:21:06 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'tsvgx',
12:21:06 INFO - u'tsvgr_opacity',
12:21:06 INFO - u'tart',
12:21:06 INFO - u'tscrollx',
12:21:06 INFO - u'cart']},
12:21:06 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
12:21:06 INFO - u'tsvgr_opacity',
12:21:06 INFO - u'tart',
12:21:06 INFO - u'tscrollx',
12:21:06 INFO - u'cart']},
12:21:06 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'talos_options': [u'--disable-e10s'],
12:21:06 INFO - u'tests': [u'tp5o']},
12:21:06 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'tests': [u'tp5o']},
12:21:06 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'talos_options': [u'--disable-e10s',
12:21:06 INFO - u'--xperf_path',
12:21:06 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
12:21:06 INFO - u'tests': [u'tp5n']},
12:21:06 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
12:21:06 INFO - u'talos_options': [u'--xperf_path',
12:21:06 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
12:21:06 INFO - u'tests': [u'tp5n']}},
12:21:06 INFO - u'talos.zip': {u'path': u'',
12:21:06 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
12:21:06 INFO - Running post-action listener: _resource_record_post_action
12:21:06 INFO - [mozharness: 2016-10-26 19:21:06.725000Z] Finished populate-webroot step (success)
12:21:06 INFO - [mozharness: 2016-10-26 19:21:06.725000Z] Running create-virtualenv step.
12:21:06 INFO - Running pre-action listener: _resource_record_pre_action
12:21:06 INFO - Running main action method: create_virtualenv
12:21:06 INFO - Creating virtualenv C:\slave\test\build/venv
12:21:06 INFO - mkdir: C:\slave\test\build\venv\Scripts
12:21:07 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
12:21:07 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'!
12:21:07 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
12:21:07 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
12:21:14 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
12:21:17 INFO - Installing distribute......................................................................................................................................................................................done.
12:21:19 INFO - Return code: 0
12:21:19 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
12:21:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
12:21:19 INFO - Reading from file tmpfile_stdout
12:21:19 INFO - Output received:
12:21:19 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
12:21:19 INFO - Using _rmtree_windows ...
12:21:19 INFO - Using _rmtree_windows ...
12:21:19 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
12:21:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:19 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:19 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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
12:21:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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
12:21:19 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:19 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:19 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:19 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:19 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:19 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:19 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:19 INFO - 'DCLOCATION': 'SCL3',
12:21:19 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:19 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:19 INFO - 'HOMEDRIVE': 'C:',
12:21:19 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:19 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:19 INFO - 'KTS_VERSION': '1.19c',
12:21:19 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:19 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:19 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:19 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:19 INFO - 'MOZ_NO_REMOTE': '1',
12:21:19 INFO - 'NO_EM_RESTART': '1',
12:21:19 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:19 INFO - 'OS': 'Windows_NT',
12:21:19 INFO - 'OURDRIVE': 'C:',
12:21:19 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:19 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:19 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:19 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:19 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:19 INFO - 'PROCESSOR_LEVEL': '6',
12:21:19 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:19 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:19 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:19 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:19 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:19 INFO - 'PROMPT': '$P$G',
12:21:19 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:19 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:19 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:19 INFO - 'PWD': 'C:\\slave\\test',
12:21:19 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:19 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:19 INFO - 'SYSTEMDRIVE': 'C:',
12:21:19 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:19 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:19 INFO - 'TEST1': 'testie',
12:21:19 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:19 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:19 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:19 INFO - 'USERNAME': 'cltbld',
12:21:19 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:19 INFO - 'WINDIR': 'C:\\windows',
12:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:20 INFO - Ignoring indexes: http://pypi.python.org/simple/
12:21:20 INFO - Downloading/unpacking pip>=1.5
12:21:25 INFO - Running setup.py egg_info for package pip
12:21:25 INFO - warning: no files found matching 'pip\cacert.pem'
12:21:25 INFO - warning: no files found matching '*.html' under directory 'docs'
12:21:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
12:21:25 INFO - no previously-included directories found matching 'docs\_build\_sources'
12:21:25 INFO - Installing collected packages: pip
12:21:25 INFO - Found existing installation: pip 0.8.2
12:21:25 INFO - Uninstalling pip:
12:21:25 INFO - Successfully uninstalled pip
12:21:25 INFO - Running setup.py install for pip
12:21:25 INFO - warning: no files found matching 'pip\cacert.pem'
12:21:25 INFO - warning: no files found matching '*.html' under directory 'docs'
12:21:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
12:21:25 INFO - no previously-included directories found matching 'docs\_build\_sources'
12:21:25 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
12:21:25 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
12:21:25 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
12:21:25 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
12:21:25 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
12:21:25 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
12:21:25 INFO - Successfully installed pip
12:21:25 INFO - Cleaning up...
12:21:25 INFO - Return code: 0
12:21:25 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
12:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:25 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:25 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build
12:21:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
12:21:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:25 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:25 INFO - 'DCLOCATION': 'SCL3',
12:21:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:25 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:25 INFO - 'HOMEDRIVE': 'C:',
12:21:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:25 INFO - 'KTS_VERSION': '1.19c',
12:21:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:25 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:25 INFO - 'MOZ_NO_REMOTE': '1',
12:21:25 INFO - 'NO_EM_RESTART': '1',
12:21:25 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:25 INFO - 'OS': 'Windows_NT',
12:21:25 INFO - 'OURDRIVE': 'C:',
12:21:25 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:25 INFO - 'PROCESSOR_LEVEL': '6',
12:21:25 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:25 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:25 INFO - 'PROMPT': '$P$G',
12:21:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:25 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:25 INFO - 'PWD': 'C:\\slave\\test',
12:21:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:25 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:25 INFO - 'SYSTEMDRIVE': 'C:',
12:21:25 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:25 INFO - 'TEST1': 'testie',
12:21:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:25 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:25 INFO - 'USERNAME': 'cltbld',
12:21:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:25 INFO - 'WINDIR': 'C:\\windows',
12:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:26 INFO - Downloading/unpacking psutil>=3.1.1
12:21:26 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
12:21:26 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
12:21:27 INFO - Installing collected packages: psutil
12:21:28 INFO - Successfully installed psutil
12:21:28 INFO - Cleaning up...
12:21:28 INFO - Return code: 0
12:21:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
12:21:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:28 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:28 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build
12:21:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
12:21:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:28 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:28 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:28 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:28 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:28 INFO - 'DCLOCATION': 'SCL3',
12:21:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:28 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:28 INFO - 'HOMEDRIVE': 'C:',
12:21:28 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:28 INFO - 'KTS_VERSION': '1.19c',
12:21:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:28 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:28 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:28 INFO - 'MOZ_NO_REMOTE': '1',
12:21:28 INFO - 'NO_EM_RESTART': '1',
12:21:28 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:28 INFO - 'OS': 'Windows_NT',
12:21:28 INFO - 'OURDRIVE': 'C:',
12:21:28 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:28 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:28 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:28 INFO - 'PROCESSOR_LEVEL': '6',
12:21:28 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:28 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:28 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:28 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:28 INFO - 'PROMPT': '$P$G',
12:21:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:28 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:28 INFO - 'PWD': 'C:\\slave\\test',
12:21:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:28 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:28 INFO - 'SYSTEMDRIVE': 'C:',
12:21:28 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:28 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:28 INFO - 'TEST1': 'testie',
12:21:28 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:28 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:28 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:28 INFO - 'USERNAME': 'cltbld',
12:21:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:28 INFO - 'WINDIR': 'C:\\windows',
12:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:29 INFO - Downloading/unpacking mozsystemmonitor==0.3
12:21:29 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
12:21:29 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
12:21:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz
12:21:30 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
12:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3)
12:21:30 INFO - Installing collected packages: mozsystemmonitor
12:21:30 INFO - Running setup.py install for mozsystemmonitor
12:21:30 INFO - Successfully installed mozsystemmonitor
12:21:30 INFO - Cleaning up...
12:21:30 INFO - Return code: 0
12:21:30 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
12:21:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:30 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:30 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build
12:21:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
12:21:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:30 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:30 INFO - 'DCLOCATION': 'SCL3',
12:21:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:30 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:30 INFO - 'HOMEDRIVE': 'C:',
12:21:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:30 INFO - 'KTS_VERSION': '1.19c',
12:21:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:30 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:30 INFO - 'MOZ_NO_REMOTE': '1',
12:21:30 INFO - 'NO_EM_RESTART': '1',
12:21:30 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:30 INFO - 'OS': 'Windows_NT',
12:21:30 INFO - 'OURDRIVE': 'C:',
12:21:30 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:30 INFO - 'PROCESSOR_LEVEL': '6',
12:21:30 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:30 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:30 INFO - 'PROMPT': '$P$G',
12:21:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:30 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:30 INFO - 'PWD': 'C:\\slave\\test',
12:21:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:30 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:30 INFO - 'SYSTEMDRIVE': 'C:',
12:21:30 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:30 INFO - 'TEST1': 'testie',
12:21:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:30 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:30 INFO - 'USERNAME': 'cltbld',
12:21:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:30 INFO - 'WINDIR': 'C:\\windows',
12:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:30 INFO - Downloading/unpacking jsonschema==2.5.1
12:21:30 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
12:21:30 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
12:21:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
12:21:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
12:21:31 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
12:21:31 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
12:21:32 INFO - Downloading functools32-3.2.3-2.tar.gz
12:21:32 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
12:21:32 INFO - warning: no files found matching '*.txt'
12:21:32 INFO - no previously-included directories found matching 'build'
12:21:32 INFO - no previously-included directories found matching 'dist'
12:21:32 INFO - no previously-included directories found matching '.git*'
12:21:32 INFO - Installing collected packages: jsonschema, functools32
12:21:32 INFO - Running setup.py install for functools32
12:21:32 INFO - warning: no files found matching '*.txt'
12:21:32 INFO - no previously-included directories found matching 'build'
12:21:32 INFO - no previously-included directories found matching 'dist'
12:21:32 INFO - no previously-included directories found matching '.git*'
12:21:32 INFO - Successfully installed jsonschema functools32
12:21:32 INFO - Cleaning up...
12:21:33 INFO - Return code: 0
12:21:33 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
12:21:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:33 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:33 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build
12:21:33 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
12:21:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:33 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:33 INFO - 'DCLOCATION': 'SCL3',
12:21:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:33 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:33 INFO - 'HOMEDRIVE': 'C:',
12:21:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:33 INFO - 'KTS_VERSION': '1.19c',
12:21:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:33 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:33 INFO - 'MOZ_NO_REMOTE': '1',
12:21:33 INFO - 'NO_EM_RESTART': '1',
12:21:33 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:33 INFO - 'OS': 'Windows_NT',
12:21:33 INFO - 'OURDRIVE': 'C:',
12:21:33 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:33 INFO - 'PROCESSOR_LEVEL': '6',
12:21:33 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:33 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:33 INFO - 'PROMPT': '$P$G',
12:21:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:33 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:33 INFO - 'PWD': 'C:\\slave\\test',
12:21:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:33 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:33 INFO - 'SYSTEMDRIVE': 'C:',
12:21:33 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:33 INFO - 'TEST1': 'testie',
12:21:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:33 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:33 INFO - 'USERNAME': 'cltbld',
12:21:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:33 INFO - 'WINDIR': 'C:\\windows',
12:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
12:21:33 INFO - Cleaning up...
12:21:33 INFO - Return code: 0
12:21:33 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
12:21:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:33 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:33 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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
12:21:33 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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
12:21:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:33 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:33 INFO - 'DCLOCATION': 'SCL3',
12:21:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:33 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:33 INFO - 'HOMEDRIVE': 'C:',
12:21:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:33 INFO - 'KTS_VERSION': '1.19c',
12:21:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:33 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:33 INFO - 'MOZ_NO_REMOTE': '1',
12:21:33 INFO - 'NO_EM_RESTART': '1',
12:21:33 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:33 INFO - 'OS': 'Windows_NT',
12:21:33 INFO - 'OURDRIVE': 'C:',
12:21:33 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:33 INFO - 'PROCESSOR_LEVEL': '6',
12:21:33 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:33 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:33 INFO - 'PROMPT': '$P$G',
12:21:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:33 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:33 INFO - 'PWD': 'C:\\slave\\test',
12:21:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:33 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:33 INFO - 'SYSTEMDRIVE': 'C:',
12:21:33 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:33 INFO - 'TEST1': 'testie',
12:21:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:33 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:33 INFO - 'USERNAME': 'cltbld',
12:21:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:33 INFO - 'WINDIR': 'C:\\windows',
12:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:33 INFO - Downloading/unpacking blobuploader==1.2.4
12:21:33 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
12:21:33 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
12:21:34 INFO - Downloading blobuploader-1.2.4.tar.gz
12:21:34 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
12:21:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
12:21:35 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
12:21:35 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
12:21:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
12:21:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
12:21:35 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
12:21:35 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
12:21:35 INFO - Downloading docopt-0.6.1.tar.gz
12:21:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
12:21:35 INFO - Installing collected packages: blobuploader, requests, docopt
12:21:35 INFO - Running setup.py install for blobuploader
12:21:35 INFO - Running setup.py install for requests
12:21:36 INFO - Running setup.py install for docopt
12:21:36 INFO - Successfully installed blobuploader requests docopt
12:21:36 INFO - Cleaning up...
12:21:37 INFO - Return code: 0
12:21:37 INFO - Installing None into virtualenv C:\slave\test\build/venv
12:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:37 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:37 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--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
12:21:37 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --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
12:21:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:37 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:37 INFO - 'DCLOCATION': 'SCL3',
12:21:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:37 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:37 INFO - 'HOMEDRIVE': 'C:',
12:21:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:37 INFO - 'KTS_VERSION': '1.19c',
12:21:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:37 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:37 INFO - 'MOZ_NO_REMOTE': '1',
12:21:37 INFO - 'NO_EM_RESTART': '1',
12:21:37 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:37 INFO - 'OS': 'Windows_NT',
12:21:37 INFO - 'OURDRIVE': 'C:',
12:21:37 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:37 INFO - 'PROCESSOR_LEVEL': '6',
12:21:37 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:37 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:37 INFO - 'PROMPT': '$P$G',
12:21:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:37 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:37 INFO - 'PWD': 'C:\\slave\\test',
12:21:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:37 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:37 INFO - 'SYSTEMDRIVE': 'C:',
12:21:37 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:37 INFO - 'TEST1': 'testie',
12:21:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:37 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:37 INFO - 'USERNAME': 'cltbld',
12:21:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:37 INFO - 'WINDIR': 'C:\\windows',
12:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qpusuw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3vr7r1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v3l27g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pi6bat-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wpzw68-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7bxmzg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-szbgcy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cco4yg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
12:21:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mlmqm7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
12:21:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ojxpic-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
12:21:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-blzb0s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
12:21:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8kax6t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
12:21:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-su69yd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
12:21:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wxguby-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
12:21:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ffmczg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
12:21:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2i1r8t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
12:21:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
12:21:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nrkiue-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
12:21:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
12:21:39 INFO - Running setup.py install for manifestparser
12:21:40 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
12:21:40 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
12:21:40 INFO - Running setup.py install for mozcrash
12:21:41 INFO - Running setup.py install for mozdebug
12:21:41 INFO - Running setup.py install for mozdevice
12:21:41 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
12:21:41 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
12:21:41 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
12:21:41 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
12:21:41 INFO - Running setup.py install for mozfile
12:21:42 INFO - Running setup.py install for mozhttpd
12:21:42 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
12:21:42 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
12:21:42 INFO - Running setup.py install for mozinfo
12:21:42 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
12:21:42 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Running setup.py install for mozInstall
12:21:43 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
12:21:43 INFO - Running setup.py install for mozleak
12:21:44 INFO - Running setup.py install for mozlog
12:21:44 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
12:21:44 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
12:21:45 INFO - Running setup.py install for moznetwork
12:21:45 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
12:21:45 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
12:21:45 INFO - Running setup.py install for mozprocess
12:21:46 INFO - Running setup.py install for mozprofile
12:21:46 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
12:21:46 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
12:21:46 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
12:21:46 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
12:21:46 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
12:21:46 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
12:21:46 INFO - Running setup.py install for mozrunner
12:21:47 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
12:21:47 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
12:21:47 INFO - Running setup.py install for mozscreenshot
12:21:48 INFO - Running setup.py install for moztest
12:21:48 INFO - Running setup.py install for mozversion
12:21:48 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
12:21:48 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
12:21:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
12:21:48 INFO - Cleaning up...
12:21:48 INFO - Return code: 0
12:21:48 INFO - Installing None into virtualenv C:\slave\test\build/venv
12:21:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:48 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:48 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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
12:21:48 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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
12:21:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:48 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:48 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:48 INFO - 'DCLOCATION': 'SCL3',
12:21:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:48 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:48 INFO - 'HOMEDRIVE': 'C:',
12:21:48 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:48 INFO - 'KTS_VERSION': '1.19c',
12:21:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:48 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:48 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:48 INFO - 'MOZ_NO_REMOTE': '1',
12:21:48 INFO - 'NO_EM_RESTART': '1',
12:21:48 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:48 INFO - 'OS': 'Windows_NT',
12:21:48 INFO - 'OURDRIVE': 'C:',
12:21:48 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:48 INFO - 'PROCESSOR_LEVEL': '6',
12:21:48 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:48 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:48 INFO - 'PROMPT': '$P$G',
12:21:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:48 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:48 INFO - 'PWD': 'C:\\slave\\test',
12:21:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:48 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:48 INFO - 'SYSTEMDRIVE': 'C:',
12:21:48 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:48 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:48 INFO - 'TEST1': 'testie',
12:21:48 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:48 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:48 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:48 INFO - 'USERNAME': 'cltbld',
12:21:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:48 INFO - 'WINDIR': 'C:\\windows',
12:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
12:21:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_4g7lb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
12:21:49 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))
12:21:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
12:21:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7w2avk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
12:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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))
12:21:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
12:21:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-atlijg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
12:21:49 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))
12:21:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
12:21:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-at9uzn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
12:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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))
12:21:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
12:21:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oytu_y-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
12:21:49 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))
12:21:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
12:21:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ol3o8a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
12:21:49 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))
12:21:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
12:21:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lwdcs_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
12:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-clzpu8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
12:21:50 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lcy9dp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
12:21:50 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t9rt15-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
12:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ergzxw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
12:21:50 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jdtiod-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
12:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y5u_yu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
12:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sgdnlr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
12:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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))
12:21:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
12:21:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o6trmy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
12:21:51 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))
12:21:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
12:21:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-glqkiv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
12:21:51 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))
12:21:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
12:21:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1aehfp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
12:21:51 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))
12:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
12:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
12:21:51 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))
12:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
12:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
12:21:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
12:21:51 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
12:21:51 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
12:21:52 INFO - Downloading blessings-1.6.tar.gz
12:21:52 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
12:21:52 INFO - Installing collected packages: blessings
12:21:52 INFO - Running setup.py install for blessings
12:21:52 INFO - Successfully installed blessings
12:21:52 INFO - Cleaning up...
12:21:55 INFO - Return code: 0
12:21:55 INFO - Done creating virtualenv C:\slave\test\build/venv.
12:21:55 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
12:21:55 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
12:21:56 INFO - Reading from file tmpfile_stdout
12:21:56 INFO - Using _rmtree_windows ...
12:21:56 INFO - Using _rmtree_windows ...
12:21:56 INFO - Current package versions:
12:21:56 INFO - blessings == 1.6
12:21:56 INFO - blobuploader == 1.2.4
12:21:56 INFO - docopt == 0.6.1
12:21:56 INFO - functools32 == 3.2.3-2
12:21:56 INFO - jsonschema == 2.5.1
12:21:56 INFO - manifestparser == 1.1
12:21:56 INFO - mozInstall == 1.12
12:21:56 INFO - mozcrash == 0.17
12:21:56 INFO - mozdebug == 0.1
12:21:56 INFO - mozdevice == 0.48
12:21:56 INFO - mozfile == 1.2
12:21:56 INFO - mozhttpd == 0.7
12:21:56 INFO - mozinfo == 0.9
12:21:56 INFO - mozleak == 0.1
12:21:56 INFO - mozlog == 3.4
12:21:56 INFO - moznetwork == 0.27
12:21:56 INFO - mozprocess == 0.23
12:21:56 INFO - mozprofile == 0.28
12:21:56 INFO - mozrunner == 6.12
12:21:56 INFO - mozscreenshot == 0.1
12:21:56 INFO - mozsystemmonitor == 0.3
12:21:56 INFO - moztest == 0.7
12:21:56 INFO - mozversion == 1.4
12:21:56 INFO - psutil == 3.1.1
12:21:56 INFO - requests == 1.2.3
12:21:56 INFO - Installing None into virtualenv C:\slave\test\build/venv
12:21:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:56 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:56 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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
12:21:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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
12:21:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:56 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:56 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:56 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:56 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:56 INFO - 'DCLOCATION': 'SCL3',
12:21:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:56 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:56 INFO - 'HOMEDRIVE': 'C:',
12:21:56 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:56 INFO - 'KTS_VERSION': '1.19c',
12:21:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:56 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:56 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:56 INFO - 'MOZ_NO_REMOTE': '1',
12:21:56 INFO - 'NO_EM_RESTART': '1',
12:21:56 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:56 INFO - 'OS': 'Windows_NT',
12:21:56 INFO - 'OURDRIVE': 'C:',
12:21:56 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:56 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:56 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:56 INFO - 'PROCESSOR_LEVEL': '6',
12:21:56 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:56 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:56 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:56 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:56 INFO - 'PROMPT': '$P$G',
12:21:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:56 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:56 INFO - 'PWD': 'C:\\slave\\test',
12:21:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:56 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:56 INFO - 'SYSTEMDRIVE': 'C:',
12:21:56 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:56 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:56 INFO - 'TEST1': 'testie',
12:21:56 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:56 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:56 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:56 INFO - 'USERNAME': 'cltbld',
12:21:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:56 INFO - 'WINDIR': 'C:\\windows',
12:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1))
12:21:56 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 2))
12:21:56 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 3))
12:21:56 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 4))
12:21:56 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 5))
12:21:56 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 6))
12:21:56 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 7))
12:21:56 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 8))
12:21:56 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 9))
12:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
12:21:56 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 4))
12:21:56 INFO - Cleaning up...
12:21:56 INFO - Return code: 0
12:21:56 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
12:21:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
12:21:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
12:21:56 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B9AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-093', 'USERDOMAIN': 'T-W864-IX-093', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-093', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
12:21:56 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build
12:21:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
12:21:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:21:56 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:21:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:21:56 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:21:56 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:21:56 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:21:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:21:56 INFO - 'DCLOCATION': 'SCL3',
12:21:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:21:56 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:21:56 INFO - 'HOMEDRIVE': 'C:',
12:21:56 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:21:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:21:56 INFO - 'KTS_VERSION': '1.19c',
12:21:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:21:56 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:21:56 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:21:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:21:56 INFO - 'MOZ_NO_REMOTE': '1',
12:21:56 INFO - 'NO_EM_RESTART': '1',
12:21:56 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:21:56 INFO - 'OS': 'Windows_NT',
12:21:56 INFO - 'OURDRIVE': 'C:',
12:21:56 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:21:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:21:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:21:56 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:21:56 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:21:56 INFO - 'PROCESSOR_LEVEL': '6',
12:21:56 INFO - 'PROCESSOR_REVISION': '1e05',
12:21:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:21:56 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:21:56 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:21:56 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:21:56 INFO - 'PROMPT': '$P$G',
12:21:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:21:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:21:56 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:21:56 INFO - 'PWD': 'C:\\slave\\test',
12:21:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:21:56 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:21:56 INFO - 'SYSTEMDRIVE': 'C:',
12:21:56 INFO - 'SYSTEMROOT': 'C:\\windows',
12:21:56 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:56 INFO - 'TEST1': 'testie',
12:21:56 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:21:56 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:21:56 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:21:56 INFO - 'USERNAME': 'cltbld',
12:21:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:21:56 INFO - 'WINDIR': 'C:\\windows',
12:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/
12:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
12:21:56 INFO - Cleaning up...
12:21:56 INFO - Return code: 0
12:21:56 INFO - Running post-action listener: _resource_record_post_action
12:21:56 INFO - Running post-action listener: _start_resource_monitoring
12:21:56 INFO - Starting resource monitoring.
12:21:56 INFO - [mozharness: 2016-10-26 19:21:56.812000Z] Finished create-virtualenv step (success)
12:21:56 INFO - [mozharness: 2016-10-26 19:21:56.812000Z] Running install step.
12:21:56 INFO - Running pre-action listener: _resource_record_pre_action
12:21:56 INFO - Running main action method: install
12:21:56 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
12:21:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
12:21:57 INFO - Reading from file tmpfile_stdout
12:21:57 INFO - Using _rmtree_windows ...
12:21:57 INFO - Using _rmtree_windows ...
12:21:57 INFO - Detecting whether we're running mozinstall >=1.0...
12:21:57 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
12:21:57 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
12:21:57 INFO - Reading from file tmpfile_stdout
12:21:57 INFO - Output received:
12:21:57 INFO - Usage: mozinstall-script.py [options] installer
12:21:57 INFO - Options:
12:21:57 INFO - -h, --help show this help message and exit
12:21:57 INFO - -d DEST, --destination=DEST
12:21:57 INFO - Directory to install application into. [default:
12:21:57 INFO - "C:\slave\test"]
12:21:57 INFO - --app=APP Application being installed. [default: firefox]
12:21:57 INFO - Using _rmtree_windows ...
12:21:57 INFO - Using _rmtree_windows ...
12:21:57 INFO - mkdir: C:\slave\test\build\application
12:21:57 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-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application']
12:21:57 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application
ProcessManager NOT managing child processes
12:22:00 INFO - Reading from file tmpfile_stdout
12:22:00 INFO - Output received:
12:22:00 INFO - C:\slave\test\build\application\firefox\firefox.exe
12:22:00 INFO - Using _rmtree_windows ...
12:22:00 INFO - Using _rmtree_windows ...
12:22:00 INFO - Running post-action listener: _resource_record_post_action
12:22:00 INFO - [mozharness: 2016-10-26 19:22:00.104000Z] Finished install step (success)
12:22:00 INFO - [mozharness: 2016-10-26 19:22:00.104000Z] Running run-tests step.
12:22:00 INFO - Running pre-action listener: _resource_record_pre_action
12:22:00 INFO - Running main action method: run_tests
12:22:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
12:22:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
12:22:00 INFO - Python 2.7.3
12:22:00 INFO - Return code: 0
12:22:00 INFO - grabbing minidump binary from tooltool
12:22:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
12:22:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E90>, '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 0x0080A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
12:22:00 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
12:22:00 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
12:22:00 INFO - Calling ['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'] with output_timeout 600
ProcessManager UNABLE to use job objects to manage child processes
12:22:00 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
12:22:00 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpkdytbr
12:22:00 INFO - INFO - File integrity verified, renaming tmpkdytbr to win32-minidump_stackwalk.exe
12:22:00 INFO - Return code: 0
12:22:00 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
12:22:00 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
12:22:00 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
12:22:00 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
12:22:00 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
12:22:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-093', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build
12:22:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-093 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log
12:22:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:22:00 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Roaming',
12:22:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:22:00 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:22:00 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:22:00 INFO - 'COMPUTERNAME': 'T-W864-IX-093',
12:22:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
12:22:00 INFO - 'DCLOCATION': 'SCL3',
12:22:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
12:22:00 INFO - 'FP_NO_HOST_CHECK': 'NO',
12:22:00 INFO - 'HOMEDRIVE': 'C:',
12:22:00 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-093',
12:22:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
12:22:00 INFO - 'KTS_VERSION': '1.19c',
12:22:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-093\\AppData\\Local',
12:22:00 INFO - 'LOGONSERVER': '\\\\T-W864-IX-093',
12:22:00 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
12:22:00 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
12:22:00 INFO - 'MONDIR': 'C:\\Monitor_config\\',
12:22:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
12:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:22:00 INFO - 'MOZ_NO_REMOTE': '1',
12:22:00 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
12:22:00 INFO - 'NO_EM_RESTART': '1',
12:22:00 INFO - 'NUMBER_OF_PROCESSORS': '8',
12:22:00 INFO - 'OS': 'Windows_NT',
12:22:00 INFO - 'OURDRIVE': 'C:',
12:22:00 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
12:22:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:22:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
12:22:00 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
12:22:00 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
12:22:00 INFO - 'PROCESSOR_LEVEL': '6',
12:22:00 INFO - 'PROCESSOR_REVISION': '1e05',
12:22:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
12:22:00 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
12:22:00 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:22:00 INFO - 'PROGRAMW6432': 'C:\\Program Files',
12:22:00 INFO - 'PROMPT': '$P$G',
12:22:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
12:22:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
12:22:00 INFO - 'PUBLIC': 'C:\\Users\\Public',
12:22:00 INFO - 'PWD': 'C:\\slave\\test',
12:22:00 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
12:22:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
12:22:00 INFO - 'SLAVEDIR': 'C:\\slave\\',
12:22:00 INFO - 'SYSTEMDRIVE': 'C:',
12:22:00 INFO - 'SYSTEMROOT': 'C:\\windows',
12:22:00 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:22:00 INFO - 'TEST1': 'testie',
12:22:00 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
12:22:00 INFO - 'USERDOMAIN': 'T-W864-IX-093',
12:22:00 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-093',
12:22:00 INFO - 'USERNAME': 'cltbld',
12:22:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-093',
12:22:00 INFO - 'WINDIR': 'C:\\windows',
12:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
12:22:00 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-093', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600
ProcessManager NOT managing child processes
ProcessManager UNABLE to use job objects to manage child processes
12:22:01 INFO - mozversion application_buildid: 20161026095323
12:22:01 INFO - mozversion application_changeset: 8e23fb23036b1d49ab9b39c5d79fbf12d4336a8b
12:22:01 INFO - mozversion application_display_name: Nightly
12:22:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
12:22:01 INFO - mozversion application_name: Firefox
12:22:01 INFO - mozversion application_remotingname: firefox
12:22:01 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch
12:22:01 INFO - mozversion application_vendor: Mozilla
12:22:01 INFO - mozversion application_version: 52.0a1
12:22:01 INFO - mozversion platform_buildid: 20161026095323
12:22:01 INFO - mozversion platform_changeset: 8e23fb23036b1d49ab9b39c5d79fbf12d4336a8b
12:22:01 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch
12:22:01 INFO - mozversion platform_version: 52.0a1
12:22:01 INFO - using testdate: 1477509721
12:22:01 INFO - actual date: 1477509721
12:22:01 INFO - starting webserver on 'localhost:49275'
12:22:01 INFO - SUITE-START | Running 2 tests
12:22:01 INFO - TEST-START | dromaeo_css
12:22:01 INFO - operating with platform_type : w8_
12:22:01 INFO - Initialising browser for dromaeo_css test...
12:22:01 INFO - TEST-INFO | started process 3204 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpxutcph\profile http://localhost:49275/getInfo.html)
12:22:10 INFO - PROCESS | 3204 | __metrics Screen width/height:1600/1200
12:22:10 INFO - PROCESS | 3204 | colorDepth:24
12:22:10 INFO - PROCESS | 3204 | Browser inner width/height: 1010/674
12:22:10 INFO - PROCESS | 3204 | __metrics
12:22:11 INFO - PROCESS | 3204 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
12:22:11 INFO - PROCESS | 3204 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
12:22:13 INFO - TEST-INFO | 3204: exit 0
12:22:13 INFO - Browser initialized.
12:22:13 INFO - Running cycle 1/1 for dromaeo_css test...
12:22:13 INFO - TEST-INFO | started process 3292 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpxutcph\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
12:22:13 INFO - PROCESS | 3292 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
12:22:24 INFO - PROCESS | 3292 | RSS: Main: 174489600
12:22:24 INFO - PROCESS | 3292 |
12:23:16 INFO - PROCESS | 3292 | 1477509796298 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]
12:25:26 INFO - PROCESS | 3292 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html)
12:25:29 INFO - PROCESS | 3292 | RSS: Main: 314884096
12:25:29 INFO - PROCESS | 3292 |
12:28:32 INFO - PROCESS | 3292 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html)
12:28:32 INFO - PROCESS | 3292 | RSS: Main: 232558592
12:28:32 INFO - PROCESS | 3292 |
12:31:35 INFO - PROCESS | 3292 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html)
12:31:35 INFO - PROCESS | 3292 | RSS: Main: 182145024
12:31:35 INFO - PROCESS | 3292 |
12:34:37 INFO - PROCESS | 3292 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html)
12:34:38 INFO - PROCESS | 3292 | RSS: Main: 178528256
12:34:38 INFO - PROCESS | 3292 |
12:37:41 INFO - PROCESS | 3292 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html)
12:37:42 INFO - PROCESS | 3292 | RSS: Main: 170319872
12:37:42 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html)
12:40:45 INFO - PROCESS | 3292 | RSS: Main: 241889280
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | __start_tp_report
12:40:45 INFO - PROCESS | 3292 | _x_x_mozilla_page_load
12:40:45 INFO - PROCESS | 3292 | _x_x_mozilla_page_load_details
12:40:45 INFO - PROCESS | 3292 | |i|pagename|runs|
12:40:45 INFO - PROCESS | 3292 | |0;dojo.html;2516.144510866305;2526.7978561715054;2540.7459254074583;2541.466292078663;2565.6408102865603;4186.079062606225;4208.116295577925;4224.408582798403;4228.513720922098;4276.9786151069275;4120.423140760296;4230.97884510577;4266.914661706764;4285.20723666122;4346.608805207531;3879.5538513070933;3886.067343837473;3894.240623078487;3902.180542086165;3931.567527571965;3941.6255455731803;3948.269570129521;3965.8810235692977;3994.0613955720382;4027.4764280643476;3978.1446988897383;4012.699047571429;4034.515858097018;4055.4119652650347;4062.3906414037833;4009.59664117558;4011.117554138114;4011.3180759270995;4011.498562679665;4053.27041132596;3696.353138200804;3707.5921648618632;3883.0486530800135;3956.9208615827524;3993.9600603994168;4187.727797693171;4227.936580951288;4243.321068629036;4297.39836422901;4313.460817397825;4445.755483448409;4454.198244316054;4457.442819647544;4459.108178364308;4514.616257618107;4336.284513055342;4442.511323754385;4491.4161159049445;4526.366308716782;4529.569690879362;4090.7750073745933;4133.132042271097;4138.565450627701;4151.045259590311;4153.501579810442;4465.575770301816;4538.069695712437;4555.954440455553;4556.931646025312;4563.178627846953;4304.7632380218765;4369.75966321849;4397.164538737629;4413.161499315184;4445.844395446144;4404.801783919731;4414.580614841585;4418.889527761831;4432.490263619725;4445.444319460067;4375.693701440869;4381.9342709859375;4384.978075109604;4396.098799746044;4448.466184057934;4279.251131052053;4323.265044942367;4347.500037495665;4403.053343531092;4433.6009759121835;3034.666186719459;3062.525308577174;3070.5854709614364;3086.9691303086684;3104.9689503105133;2840.616516770251;2856.657201135877;2859.7140285971655;2863.3700585871075;2866.039876641307;4104.56902025289;4151.086760912594;4161.0845613964875;4164.167166566699;4204.243236217449;4300.698951073395;4331.891702707395;4347.913041739211;4483.14820184164;4515.841945531891;4077.0622756765515;4156;4162.583741625813;4166.0834616384345;4221.5567365426805;3756.2487502499607;3756.286305601927;3766.133789228493;3769.981150094232;3815.7901315427916;4269.551697071763;4512.481064677539;4521.796519156712;4522.072975040043;4583.770811459413;4318.265894797829;4371.060222052274;4371.388005679271;4371.956280437155;4375.212461756787;4385.736855788663;4401.647868170475;4418.6023257906945;4423.60187583119;4456.710313829591;4393.934090988701;4418.337249412614;4442.888927776831;4468.865934021985;4471.396361491157;4392.626626736763;4452.510223875436;4465.0400163964905;4470.754108524063;4529.614982726505;4279.315309550457;4326.956730432781;4369.3664418659755;4415.5363686812425;4429.911401772011;4341.696081274406;4364.410804541473;4373.628241599373;4374.19077470669;4376.212281789309;4283.164782867311;4315.029118448324;4322.827086916488;4323.329883867879;4328.783560821883;4319.676024298253;4342.261815491311;4379.5401482843845;4398.010447649253;4399;4091.509018917749;4264.488261408651;4303.311470164758;4343.739375637472;4348.173846969065
12:40:45 INFO - PROCESS | 3292 | |1;ext.html;541.5721579951838;550.3643291997741;560.249265983582;563.3521450332117;576.5733357315585;24405.38986525338;35566.82216588916;36794.44808327874;36862.07844803881;40282.19435611293;36559.451608225834;36648.900532983986;36864.26271474575;37016.629833701656;37089.443658345146;6797.388235058844;7743.380529557636;7858.1356050834365;7893.921060789376;7902.170272121402;6887.035814985881;9140.680076197334;9461.101195386427;9464.763380915463;9469.337146399721;9463.195628371597;9540.284478664093;9549.904500955006;9550.474723890184;9552.474613896233;6856.108705868255;7036.542624729427;9197.908020919773;9269.397489163182;9279.907200927972;8954.104589541059;9341.813163736755;9348.252139828865;9489.620415183384;9603.90396096044;34082;34358;34588;34689;34730.479042814375;2843.786715996288;2891.5951766752673;2915.897943571986;2924.546695262238;3085.382923415326;26680.19959401221;26726.73273267262;26804.19587412381;26805.195844124708;27224.95812814027;3482.7387945904156;3502.544669193014;3515.2090779574646;3515.982420087909;3583.390823560001;196254;196362;196556;197241;197440.99999999857;41872.581274187476;46399.99999999932;46507.30239046417;46538.76730616325;46603.766981164874;29771.702282977327;30558.38883222323;30622;32681;32849.67150328514;12374.628761137;12501.312427816558;12540.68648283782;12558;12609.93695031519;7230.674619642024;7511.098668159856;9319.534023298807;9394.859077113848;9487.90512094884;16529.834701652828;16560.254788534545;16588.50234492967;16596.419125330554;16605.50183494497;6605.877000909857;6633.4693224541925;6676.86646267072;6680.498962577826;6691.799246022627;803.7990502374406;899.3659470073583;915.5919930582526;917.4770380882966;1004.4525733475274;24648.753512465006;25732.8713356432;26170.6074408884;26502.204933852016;26824.865875670497;934.8924873639482;938.4088024544493;960.1502670136979;962.41292811385;1033.4574348466965;13698.794518082237;14175.291235438186;14289.214093224764;14341;14367.13797172152;285272;287610;291232;291474;291670;45833.541664582925;45875;46361;46456;46487.30269045967;959.2757468111531;998.5905778630727;1176.8293597428326;1215.1676101870248;1215.9542793197666;25806.870965645052;26794.866025670526;26877;27291;27349;38181.23637527179;38361;38407;38425.4236186463;38471.80764096162;216337;218638;218853;219064;316887;34546.309073818884;35068.5643725223;35275;35663.82168089143;35753.284934301686;40079;40132;40252.597474024886;40424.79787601161;40497.595024049384;32976.505352419255;33366.83316583402;33530.49704254487;33899.66100338965;34003.48994765031;33247.66752332446;33482.16294592557;33641.15897102592;33743.32513349768;34348;32741;33427.33145337031;33452.330953381286;33462;33582.160445989044;27624.171274861787;29726.851365743034;29783;29821.85089074541;29861.03135408313;22991.310260692208;23335.41661458477;23419.297421077394;23492.647610285516;24582
12:40:45 INFO - PROCESS | 3292 | |2;jquery.html;268.3117802835727;304.8826201912264;309.73672378478295;312.15561905046843;312.31291159449205;11486.597969071085;12301;15617.84382156178;16581.088040157785;17850.464486065437;15437.536873893772;15953;16190.75713864293;16352.75470867938;16563.83436165638;4373.256546387106;4784.306275590055;4843.951560484403;5083.3391659084455;5084.440711521748;4825.541573550525;4913.631477639174;4925.38432695913;4940.654154209206;4945.579625731817;4694.765261736917;4881.585065269456;4891.095147397743;4892.119418504668;4896.192128298844;4808.831690890819;4852.2479015752615;4882.145624515695;4889.266610008492;4893.241547560134;4267.615914567704;4268.59448352406;4269.466316710411;4273.829046838154;4275.978620106911;18165;18797.436076917715;18950.336738214235;18989.905050474797;19001.90499047496;1786;1899.6200759847948;1908.065048126422;1958.6180694764528;2363.7636236376397;11747.530098796038;12235.265884046898;12716.491340346374;12821.807672884914;12889.742205155844;1636.0244605608366;1675.8491735743842;1692.2976964559693;1734.8351906568855;1765.9823401765946;52937.47062529364;53274.46725532734;53358.46641533612;53762;54110;7813.570253636105;7869.213078692085;8024.358051355877;8070.314023307968;8198.426110172231;10493.842592361121;10517.9474102629;10521.473926303654;10534.73663158412;10550.208734344802;6126.785562505291;6182.907256391158;6247.75008999644;6263.8702841034265;6270.122182894398;5928.644281343133;5955.255593050869;6019.909701354483;6028.4272994065495;6034.788782392595;5326.387465441524;5436.130219164915;5439.606573107899;5441.238226648273;5527.834164975057;1494.641286091352;1502.1137528858026;1502.6543894904014;1516.6056825225521;1523.2612183091192;753.886916962449;757;758.6737702787744;771.9964046739217;791.2404092071675;14541.054831435922;14988.625284367978;15267.847321526642;15844.52466425986;15890.205489725698;783.8589053970226;784.1452816430004;784.1922819495928;826.962786674601;844.6663567890648;7787.221277872281;8940.195382415613;9042.18620324174;9067.277217328687;9166.954165229132;221214;271954;277257;277397;278095;58682.7065864668;63157;63431.365686343466;63811.680941595;66294.33705662978;848.762346542969;891.6210610490516;906.9274458043341;907.1019690506351;908.9681861134828;13766.93116534411;13850.792238116235;13950.720985580028;14054.086484378482;14282.642933926734;29213.41573168482;29371.265718357212;29693.5545966815;29812.85093574605;30650.386992260475;38967.2206555873;39271.607283926794;39696.404553931134;39961.2007759849;39971.2005759889;5905.143754155538;6060.333363330118;6134.539909506716;6217.689115544114;6251.71867265965;8969.461832290084;9825.312228143961;10014.39913605186;10049.095581397709;10455.84316235242;8284.000019983105;8297.377696672653;8489.702860399857;8640.956795215983;9144.085591440802;8772.254358379354;8861.468311901306;8938.68714594986;8980.955095224743;8981.506017169118;9221;9233.307501937246;9325.580348884452;9425.114977004763;9493.24054075686;5951.791687290924;6034.668093254738;6044.667543284985;6062.636241825505;6120.143179954721;5992.850178745566;6447.387498187664;9108.908910911072;9113.681021164493;9125.880746653878
12:40:45 INFO - PROCESS | 3292 | |3;mootools.html;1019.108280254777;1209.606877764726;1233.8334324866146;1288.8517820450647;1565.8121025476937;5210.9478905210935;5605.215269862222;6081.087836824473;6305.621662700241;6328.303886572485;6077.3314935357075;6263.404976527223;6269.373062693729;6286.622802631845;6291.905621415671;1790.982090179101;1829.1128802530761;1835.5411147213197;1837.6600328939123;1838.742576039349;1759.8240175982364;1775;1778.448680908916;1779.3772179737052;1779.5106345754891;1784.5717027913272;1793.3543924187281;1799.8650101242458;1801.0364455016568;1801.2884910460361;1733.9046352450548;1755.2540170427517;1755.6225411536452;1757.139001889078;1758.1560850791564;1718.8195239499923;1722.939697110595;1753.9035353055576;1756.7804024496938;1758.34062226665;6429.421352078335;6498.480121590262;6510.5117116216;6527.4125328720165;6527.510436717265;3529.9294014119832;3606.4229723244157;3695.907602309937;3732.1416074302792;3732.346839303138;2319.826013049028;2363.9172628958077;2369.6563998220336;2370.1585936992465;2370.751071137523;741.9925800742031;759.2710997442462;766.8504641594891;770.8535378278109;778.5834578500532;8235;8345.916540834574;8376.371772117054;8426.705065322745;8435.536045517494;3165.8733650654176;3189.4577921753357;3324.3185147044796;3327.783694059878;3331.93336133276;7320.194778574352;7326.890096648554;7354.595497247596;7388.371988381048;7390.5196162249285;3697.205100903319;3699.7040236780995;3710.703143748494;3712.201876596545;3716.3867961786004;2827.476916770363;2946.0867131189398;3390.779599326036;3395.966040339565;3398.8300584970652;2961.985190074036;3078.7998780079224;3086.79935804172;3098.148009297461;3107.5183346581316;973.8003709239589;992.4491906991544;997.2670087485837;1000.869886914711;1001.5242759689235;777.2150128370387;786.3276898252027;805.4241217529494;806.749907528668;822.1983566023199;4083.1833633273463;4153.771542565188;4196.118815048874;4242;4307.375430562551;761.5544906229918;812.8780682897612;826.6197549127469;832.629479881459;836.4479443567217;3029.8788048478254;3087.4442600332154;3127.3119913618966;3143.528470729409;3154.6372167201066;7046.964765176142;7304.890426643605;7338.853222935511;7499.362554182846;7517.887231691529;7452.105747310357;7463.552186868806;7467.551946883095;7476.70093196266;7479.065116860393;5877.882442351129;5939.168516407706;6029.974904266285;6030.698465076729;6034.969825150846;4202.3696445533415;4287.871363859089;4291.527931927423;4295.506016807982;4432.800523976364;6580.80257592273;6878.27778083314;6945.617991010543;6990.475714321548;6996.475264355296;6934.965325173342;7143.357097861218;7245.239249878687;7247.673854676657;7263.527870688388;5557.666160121623;5637.041702910597;5668.433156684298;5682.516986056066;5690.089585666274;4994.101061808909;5879.529637629065;6278.0896769967185;6280.0893870389455;6327.557071004985;5555.444455554412;5579.414161512983;5597.944020559742;5617.943820561905;5632.436756324335;5654.491095801398;5673.574481913791;5692.117721753135;5735.9139612905;5745.569082318759;5184.611154163377;5241.895162096813;5245.239440281061;5245.291885595396;5251.081060814418;3584.820758961989;3632.110133017428;3659.8170091494785;3680.7239457041364;3684.1710615111388;3713.665770080706;3744.4944932434864;3844.9231015380096;3869.438931354994;3917.9608203917596
12:40:45 INFO - PROCESS | 3292 | |4;prototype.html;224.4545753818223;230.77153617918265;238.30415187652054;244.97182823975248;245.91884678056243;4428.18078655449;4499.055198408334;4503.752293623849;4507.459104907408;4510.954890451095;4436.29019356903;4437.912711385707;4439.712483379816;4442.2004039272915;4458.888527786807;3229.1119942015957;3341.9781032475244;3358.378699940519;3439.466882633196;3482.703970162539;3424.914377140579;3455.3434847378917;3461.740369472287;3468.549088618476;3470.6182319944787;3440.294739578393;3443.1220038890046;3444.7760895541833;3451.8446669899913;3452.395830729625;3219.919502012445;3330.217398911254;3372.9494057589154;3451.9482207766905;3504.4743288506675;3007.0678089792013;3013.668496465387;3016.502277124272;3020.335526184258;3024.6370435547656;4385.122975404932;4400.1419723153995;4404.339349097629;4408.691391602589;4417;3594.9281014379567;3870.8838734838;3877.6316249956208;3898.941515877236;3900.4734360861203;4581.496035436099;4582.977085114553;4597.241455159895;4618.884527886796;4620.838270660511;3135.81185128893;3143.387039527293;3145.308032232905;3148;3159.936801263962;4827.227643577011;4841.346418233528;4868.172410690227;4869.537393947569;4870.6347023972985;3011.4278287125376;3177.9841100794347;3217.4208642444582;3221.2430078931434;3234.6603606620965;3254.9837250814066;3259.445894197992;3265.4938484534937;3270.754693397957;3275.1812046988252;3799.1831756172555;3812.4662547243406;3820.522434695663;3825.3305671507374;3830.180664184546;4647.209974304376;4656.161890859677;4656.650751193674;4661.417322834645;4661.43621008444;1067.108964015056;1079.4548752879746;1109.3011402816173;1110.1396417776289;1116.776644671069;659.3241927024837;666.2404858461358;691.4572060932144;691.9100516932766;698.9091418115714;4291.888380923805;4314.827406903752;4458.9331160032625;4461.754603496774;4474.932876006863;4796.928046079312;4799.496052914464;4810.927836082462;4813.205821039559;4814.9518504815205;4429.844955426609;4440.555944405598;4446.62203712688;4453.643708503312;4458.019235768126;2425.854448733082;2545.46545225501;2565.204786516186;2567.740388458182;2572.717001129874;4843.854684359475;4853.272009198648;4868.683535570177;4868.78090485929;4874.8050077997195;4900;4907.509249075135;4910.926336104962;4922.163232250526;4922.58158056562;4605.6085232755595;4902.014684052893;4921.818763496806;4926.113299605962;4931.4821943696115;4865.221564549655;4867.70793752376;4877.926831097466;4887.804487820589;4901.926471103007;4742;4791.401074865642;4801.18379875415;4802.351682522954;4812;4614.723116613014;4829.879253018703;4917.680350777188;4919.655624106422;4933.273354325957;3269.4605390111315;3319.2697606526526;3330.983345083259;3338.165458635341;3341.331733653328;4754.690945088558;4801.18379875429;4825.662203645711;4827.996381501637;4854.466008739107;4515.480719717275;4677.32178834074;4684.039771846695;4690.812367505261;4722.1028004679;4686.835960741358;4689.413823272091;4692.882677933079;4694.3427920090535;4715.481297057389;4574.519675434031;4627.514111018295;4632.5135860734135;4641.373414589122;4650.930236046394;4482;4716.434027916672;4732.225415469199;4737.336772851734;4763.30932014849;4650.7212415246495;4676.181668208118;4676.532346765296;4678.368420263221;4690.6247500199215
12:40:45 INFO - PROCESS | 3292 | |5;yui.html;563.9971800140999;570.2814453788226;574.127326463775;576.3832699012058;649.1236830279122;11340.43297835108;12085.758284834308;12104.273743575392;12105.515779368836;12108.939455302732;10952;12234.755304893897;12274.324912129829;12286.938565307184;12307.076969227299;496.8782648251184;513.1661050792462;756.3835474088614;776.6737970052592;779.4894344204555;750.3059669805435;765.26534526854;769.7536788227769;773.0259872560586;776.7514395393476;815.6737305077957;817.7138001699387;817.8200795824939;818.8157664525464;819.3035919468464;515.9974200128976;544.0777881490875;811.9675212991473;812.2933048248033;812.4597142899994;579.252763934524;592.0734051209886;592.2922108080845;595.3034949109552;599.0953659973428;11485.196036277464;11525.538978440853;11539.653810385618;11540.192186546945;11554.248973816675;10478.947605262001;11392.886071139266;11427.714307142389;11459.770804583944;11745.647630571011;10652.147828173727;10690.946545267223;10935.56257749689;10984.780304393948;10993.120550355952;3669.6330366963357;3697.9260414791825;3699.519062521882;3703.3148867459604;3816.866409675648;50184.49815501835;50791.492085079044;50976;51042.48957510452;51200.74399627978;8471.576421178916;8571.571421428904;8571.614277357534;8631.654733810577;8711.303095752324;14339.354729037219;17077.487675369757;17079.06065166403;17086.145692715316;17096.57258568546;5642.266505354278;5653.321601407857;5812.738426770806;5870.794522191788;5933.792317268962;3183.80897146172;3222.3319271160503;3226.709596136359;3241.9351612967607;3366.495025746158;2436.8537887726793;2528.595424732071;2550.4006558458746;2560.577504711739;2562.2569454858253;417.57407444406533;426.1434516621551;429.22524842658675;432.8549935771552;434.7760903134888;396.4489359789894;455.8472911574593;473.75128057769945;546.6880473664734;572.8052462162884;7096;7198.964005179941;7439.776806695808;7471.292886987789;7566.016417865642;447.7457041616626;464.30354468297554;464.81639752297656;497.2317769046759;556.41854262296;3297.8186199758766;3332.783369081002;3342.8662853486076;3447.3622379859808;3449.7757645752945;62303.6884815573;65553.67223163854;69831.65084174648;71879.28120718726;72161.63919180476;53992.73003634957;55283.44716552863;63875.04187437192;64862.35137648658;66210.66894665496;56252.43747562554;56410.43589564134;57707;57723.71138144282;59380.70309648424;6959.756408525677;7060.505764596429;7087.255838137127;7106.4314854810455;7230.313120253568;35268.64731352653;35296.647033529334;35672.97607751003;36031;36687.63312366842;48357.27464088112;49799.75100124476;50020.49979500304;50529;50856;9860.556274967787;9925;10061.597536098474;10070.194384449373;10103.141232994984;11271.267367621078;11294.60468883585;11658.242214256046;11821.23161994502;11934.641960741192;9580.95209523948;9873.506324683593;9886.4562449066;9895.55470003866;9984.950075249577;9834.508274586386;10465.058144766703;10467.110295624958;10486.895131048897;10492.213084018882;9491.952540237255;9740.80518389614;9988.850167247352;10112.140468060003;10141.188704903443;8440.53577053268;8808.075152109193;8889.822203556021;8899.599518021576;8950.14973577535;8207.466514676527;8950.433674107135;8960.507172105597;9092.909070909207;9160.908390916273
12:40:45 INFO - PROCESS | 3292 | __end_tp_report
12:40:45 INFO - PROCESS | 3292 | __start_cc_report
12:40:45 INFO - PROCESS | 3292 | _x_x_mozilla_cycle_collect,2145
12:40:45 INFO - PROCESS | 3292 | __end_cc_report
12:40:45 INFO - PROCESS | 3292 | __startTimestamp1477510845453__endTimestamp
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | ------- Summary: start -------
12:40:45 INFO - PROCESS | 3292 | Number of tests: 6
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | [#0] dojo.html Cycles:165 Average:4135.10 Median:4313.46 stddev:466.04 (10.8%) stddev-sans-first:449.83
12:40:45 INFO - PROCESS | 3292 | Values: 2516.1 2526.8 2540.7 2541.5 2565.6 4186.1 4208.1 4224.4 4228.5 4277.0 4120.4 4231.0 4266.9 4285.2 4346.6 3879.6 3886.1 3894.2 3902.2 3931.6 3941.6 3948.3 3965.9 3994.1 4027.5 3978.1 4012.7 4034.5 4055.4 4062.4 4009.6 4011.1 4011.3 4011.5 4053.3 3696.4 3707.6 3883.0 3956.9 3994.0 4187.7 4227.9 4243.3 4297.4 4313.5 4445.8 4454.2 4457.4 4459.1 4514.6 4336.3 4442.5 4491.4 4526.4 4529.6 4090.8 4133.1 4138.6 4151.0 4153.5 4465.6 4538.1 4556.0 4556.9 4563.2 4304.8 4369.8 4397.2 4413.2 4445.8 4404.8 4414.6 4418.9 4432.5 4445.4 4375.7 4381.9 4385.0 4396.1 4448.5 4279.3 4323.3 4347.5 4403.1 4433.6 3034.7 3062.5 3070.6 3087.0 3105.0 2840.6 2856.7 2859.7 2863.4 2866.0 4104.6 4151.1 4161.1 4164.2 4204.2 4300.7 4331.9 4347.9 4483.1 4515.8 4077.1 4156.0 4162.6 4166.1 4221.6 3756.2 3756.3 3766.1 3770.0 3815.8 4269.6 4512.5 4521.8 4522.1 4583.8 4318.3 4371.1 4371.4 4372.0 4375.2 4385.7 4401.6 4418.6 4423.6 4456.7 4393.9 4418.3 4442.9 4468.9 4471.4 4392.6 4452.5 4465.0 4470.8 4529.6 4279.3 4327.0 4369.4 4415.5 4429.9 4341.7 4364.4 4373.6 4374.2 4376.2 4283.2 4315.0 4322.8 4323.3 4328.8 4319.7 4342.3 4379.5 4398.0 4399.0 4091.5 4264.5 4303.3 4343.7 4348.2
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | [#1] ext.html Cycles:180 Average:39240.98 Median:34709.74 stddev:64001.95 (184.4%) stddev-sans-first:64115.53
12:40:45 INFO - PROCESS | 3292 | Values: 541.6 550.4 560.2 563.4 576.6 24405.4 35566.8 36794.4 36862.1 40282.2 36559.5 36648.9 36864.3 37016.6 37089.4 6797.4 7743.4 7858.1 7893.9 7902.2 6887.0 9140.7 9461.1 9464.8 9469.3 9463.2 9540.3 9549.9 9550.5 9552.5 6856.1 7036.5 9197.9 9269.4 9279.9 8954.1 9341.8 9348.3 9489.6 9603.9 34082.0 34358.0 34588.0 34689.0 34730.5 2843.8 2891.6 2915.9 2924.5 3085.4 26680.2 26726.7 26804.2 26805.2 27225.0 3482.7 3502.5 3515.2 3516.0 3583.4 196254.0 196362.0 196556.0 197241.0 197441.0 41872.6 46400.0 46507.3 46538.8 46603.8 29771.7 30558.4 30622.0 32681.0 32849.7 12374.6 12501.3 12540.7 12558.0 12609.9 7230.7 7511.1 9319.5 9394.9 9487.9 16529.8 16560.3 16588.5 16596.4 16605.5 6605.9 6633.5 6676.9 6680.5 6691.8 803.8 899.4 915.6 917.5 1004.5 24648.8 25732.9 26170.6 26502.2 26824.9 934.9 938.4 960.2 962.4 1033.5 13698.8 14175.3 14289.2 14341.0 14367.1 285272.0 287610.0 291232.0 291474.0 291670.0 45833.5 45875.0 46361.0 46456.0 46487.3 959.3 998.6 1176.8 1215.2 1216.0 25806.9 26794.9 26877.0 27291.0 27349.0 38181.2 38361.0 38407.0 38425.4 38471.8 216337.0 218638.0 218853.0 219064.0 316887.0 34546.3 35068.6 35275.0 35663.8 35753.3 40079.0 40132.0 40252.6 40424.8 40497.6 32976.5 33366.8 33530.5 33899.7 34003.5 33247.7 33482.2 33641.2 33743.3 34348.0 32741.0 33427.3 33452.3 33462.0 33582.2 27624.2 29726.9 29783.0 29821.9 29861.0 22991.3 23335.4 23419.3 23492.6 24582.0
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | [#2] jquery.html Cycles:180 Average:18776.01 Median:4894.72 stddev:44154.47 (902.1%) stddev-sans-first:44256.47
12:40:45 INFO - PROCESS | 3292 | Values: 268.3 304.9 309.7 312.2 312.3 11486.6 12301.0 15617.8 16581.1 17850.5 15437.5 15953.0 16190.8 16352.8 16563.8 4373.3 4784.3 4844.0 5083.3 5084.4 4825.5 4913.6 4925.4 4940.7 4945.6 4694.8 4881.6 4891.1 4892.1 4896.2 4808.8 4852.2 4882.1 4889.3 4893.2 4267.6 4268.6 4269.5 4273.8 4276.0 18165.0 18797.4 18950.3 18989.9 19001.9 1786.0 1899.6 1908.1 1958.6 2363.8 11747.5 12235.3 12716.5 12821.8 12889.7 1636.0 1675.8 1692.3 1734.8 1766.0 52937.5 53274.5 53358.5 53762.0 54110.0 7813.6 7869.2 8024.4 8070.3 8198.4 10493.8 10517.9 10521.5 10534.7 10550.2 6126.8 6182.9 6247.8 6263.9 6270.1 5928.6 5955.3 6019.9 6028.4 6034.8 5326.4 5436.1 5439.6 5441.2 5527.8 1494.6 1502.1 1502.7 1516.6 1523.3 753.9 757.0 758.7 772.0 791.2 14541.1 14988.6 15267.8 15844.5 15890.2 783.9 784.1 784.2 827.0 844.7 7787.2 8940.2 9042.2 9067.3 9167.0 221214.0 271954.0 277257.0 277397.0 278095.0 58682.7 63157.0 63431.4 63811.7 66294.3 848.8 891.6 906.9 907.1 909.0 13766.9 13850.8 13950.7 14054.1 14282.6 29213.4 29371.3 29693.6 29812.9 30650.4 38967.2 39271.6 39696.4 39961.2 39971.2 5905.1 6060.3 6134.5 6217.7 6251.7 8969.5 9825.3 10014.4 10049.1 10455.8 8284.0 8297.4 8489.7 8641.0 9144.1 8772.3 8861.5 8938.7 8981.0 8981.5 9221.0 9233.3 9325.6 9425.1 9493.2 5951.8 6034.7 6044.7 6062.6 6120.1 5992.9 6447.4 9108.9 9113.7 9125.9
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | [#3] mootools.html Cycles:180 Average:4143.88 Median:5243.57 stddev:2255.70 (43.0%) stddev-sans-first:2249.80
12:40:45 INFO - PROCESS | 3292 | Values: 1019.1 1209.6 1233.8 1288.9 1565.8 5210.9 5605.2 6081.1 6305.6 6328.3 6077.3 6263.4 6269.4 6286.6 6291.9 1791.0 1829.1 1835.5 1837.7 1838.7 1759.8 1775.0 1778.4 1779.4 1779.5 1784.6 1793.4 1799.9 1801.0 1801.3 1733.9 1755.3 1755.6 1757.1 1758.2 1718.8 1722.9 1753.9 1756.8 1758.3 6429.4 6498.5 6510.5 6527.4 6527.5 3529.9 3606.4 3695.9 3732.1 3732.3 2319.8 2363.9 2369.7 2370.2 2370.8 742.0 759.3 766.9 770.9 778.6 8235.0 8345.9 8376.4 8426.7 8435.5 3165.9 3189.5 3324.3 3327.8 3331.9 7320.2 7326.9 7354.6 7388.4 7390.5 3697.2 3699.7 3710.7 3712.2 3716.4 2827.5 2946.1 3390.8 3396.0 3398.8 2962.0 3078.8 3086.8 3098.1 3107.5 973.8 992.4 997.3 1000.9 1001.5 777.2 786.3 805.4 806.7 822.2 4083.2 4153.8 4196.1 4242.0 4307.4 761.6 812.9 826.6 832.6 836.4 3029.9 3087.4 3127.3 3143.5 3154.6 7047.0 7304.9 7338.9 7499.4 7517.9 7452.1 7463.6 7467.6 7476.7 7479.1 5877.9 5939.2 6030.0 6030.7 6035.0 4202.4 4287.9 4291.5 4295.5 4432.8 6580.8 6878.3 6945.6 6990.5 6996.5 6935.0 7143.4 7245.2 7247.7 7263.5 5557.7 5637.0 5668.4 5682.5 5690.1 4994.1 5879.5 6278.1 6280.1 6327.6 5555.4 5579.4 5597.9 5617.9 5632.4 5654.5 5673.6 5692.1 5735.9 5745.6 5184.6 5241.9 5245.2 5245.3 5251.1 3584.8 3632.1 3659.8 3680.7 3684.2 3713.7 3744.5 3844.9 3869.4 3918.0
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | [#4] prototype.html Cycles:180 Average:3893.47 Median:4478.47 stddev:1190.29 (26.6%) stddev-sans-first:1161.34
12:40:45 INFO - PROCESS | 3292 | Values: 224.5 230.8 238.3 245.0 245.9 4428.2 4499.1 4503.8 4507.5 4511.0 4436.3 4437.9 4439.7 4442.2 4458.9 3229.1 3342.0 3358.4 3439.5 3482.7 3424.9 3455.3 3461.7 3468.5 3470.6 3440.3 3443.1 3444.8 3451.8 3452.4 3219.9 3330.2 3372.9 3451.9 3504.5 3007.1 3013.7 3016.5 3020.3 3024.6 4385.1 4400.1 4404.3 4408.7 4417.0 3594.9 3870.9 3877.6 3898.9 3900.5 4581.5 4583.0 4597.2 4618.9 4620.8 3135.8 3143.4 3145.3 3148.0 3159.9 4827.2 4841.3 4868.2 4869.5 4870.6 3011.4 3178.0 3217.4 3221.2 3234.7 3255.0 3259.4 3265.5 3270.8 3275.2 3799.2 3812.5 3820.5 3825.3 3830.2 4647.2 4656.2 4656.7 4661.4 4661.4 1067.1 1079.5 1109.3 1110.1 1116.8 659.3 666.2 691.5 691.9 698.9 4291.9 4314.8 4458.9 4461.8 4474.9 4796.9 4799.5 4810.9 4813.2 4815.0 4429.8 4440.6 4446.6 4453.6 4458.0 2425.9 2545.5 2565.2 2567.7 2572.7 4843.9 4853.3 4868.7 4868.8 4874.8 4900.0 4907.5 4910.9 4922.2 4922.6 4605.6 4902.0 4921.8 4926.1 4931.5 4865.2 4867.7 4877.9 4887.8 4901.9 4742.0 4791.4 4801.2 4802.4 4812.0 4614.7 4829.9 4917.7 4919.7 4933.3 3269.5 3319.3 3331.0 3338.2 3341.3 4754.7 4801.2 4825.7 4828.0 4854.5 4515.5 4677.3 4684.0 4690.8 4722.1 4686.8 4689.4 4692.9 4694.3 4715.5 4574.5 4627.5 4632.5 4641.4 4650.9 4482.0 4716.4 4732.2 4737.3 4763.3 4650.7 4676.2 4676.5 4678.4 4690.6
12:40:45 INFO - PROCESS | 3292 |
12:40:45 INFO - PROCESS | 3292 | [#5] yui.html Cycles:180 Average:14277.27 Median:51121.62 stddev:18784.38 (36.7%) stddev-sans-first:18808.85
12:40:45 INFO - PROCESS | 3292 | Values: 564.0 570.3 574.1 576.4 649.1 11340.4 12085.8 12104.3 12105.5 12108.9 10952.0 12234.8 12274.3 12286.9 12307.1 496.9 513.2 756.4 776.7 779.5 750.3 765.3 769.8 773.0 776.8 815.7 817.7 817.8 818.8 819.3 516.0 544.1 812.0 812.3 812.5 579.3 592.1 592.3 595.3 599.1 11485.2 11525.5 11539.7 11540.2 11554.2 10478.9 11392.9 11427.7 11459.8 11745.6 10652.1 10690.9 10935.6 10984.8 10993.1 3669.6 3697.9 3699.5 3703.3 3816.9 50184.5 50791.5 50976.0 51042.5 51200.7 8471.6 8571.6 8571.6 8631.7 8711.3 14339.4 17077.5 17079.1 17086.1 17096.6 5642.3 5653.3 5812.7 5870.8 5933.8 3183.8 3222.3 3226.7 3241.9 3366.5 2436.9 2528.6 2550.4 2560.6 2562.3 417.6 426.1 429.2 432.9 434.8 396.4 455.8 473.8 546.7 572.8 7096.0 7199.0 7439.8 7471.3 7566.0 447.7 464.3 464.8 497.2 556.4 3297.8 3332.8 3342.9 3447.4 3449.8 62303.7 65553.7 69831.7 71879.3 72161.6 53992.7 55283.4 63875.0 64862.4 66210.7 56252.4 56410.4 57707.0 57723.7 59380.7 6959.8 7060.5 7087.3 7106.4 7230.3 35268.6 35296.6 35673.0 36031.0 36687.6 48357.3 49799.8 50020.5 50529.0 50856.0 9860.6 9925.0 10061.6 10070.2 10103.1 11271.3 11294.6 11658.2 11821.2 11934.6 9581.0 9873.5 9886.5 9895.6 9985.0 9834.5 10465.1 10467.1 10486.9 10492.2 9492.0 9740.8 9988.9 10112.1 10141.2 8440.5 8808.1 8889.8 8899.6 8950.1 8207.5 8950.4 8960.5 9092.9 9160.9
12:40:45 INFO - PROCESS | 3292 | -------- Summary: end --------
12:40:45 INFO - PROCESS | 3292 |
12:40:46 INFO - TEST-INFO | 3292: exit 0
12:40:46 INFO - TEST-OK | dromaeo_css | took 1125450ms
12:40:46 INFO - TEST-START | kraken
12:40:46 INFO - operating with platform_type : w8_
12:40:46 INFO - Initialising browser for kraken test...
12:40:46 INFO - TEST-INFO | started process 1032 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbt4pk4\profile http://localhost:49275/getInfo.html)
12:40:52 INFO - PROCESS | 1032 | __metrics Screen width/height:1600/1200
12:40:52 INFO - PROCESS | 1032 | colorDepth:24
12:40:52 INFO - PROCESS | 1032 | Browser inner width/height: 1010/674
12:40:52 INFO - PROCESS | 1032 | __metrics
12:40:53 INFO - PROCESS | 1032 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
12:40:53 INFO - PROCESS | 1032 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
12:40:53 INFO - PROCESS | 1032 | console.error:
12:40:53 INFO - PROCESS | 1032 | Message: Error: Connection closed before committing the transaction.
12:40:53 INFO - PROCESS | 1032 | Stack:
12:40:53 INFO - PROCESS | 1032 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23
12:40:53 INFO - PROCESS | 1032 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7
12:40:53 INFO - PROCESS | 1032 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
12:40:53 INFO - PROCESS | 1032 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7
12:40:53 INFO - PROCESS | 1032 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7
12:40:53 INFO - PROCESS | 1032 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15
12:40:53 INFO - PROCESS | 1032 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
12:40:53 INFO - PROCESS | 1032 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
12:40:53 INFO - PROCESS | 1032 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
12:40:53 INFO - PROCESS | 1032 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
12:40:53 INFO - PROCESS | 1032 | Barrier/this.client.addBlocker/promise13.3%
12:41:53 INFO - TinderboxPrint: I/O read bytes / time
227,595,264 / 3,484,470
12:41:53 INFO - TinderboxPrint: I/O write bytes / time
417,530,368 / 3,819,200
12:41:53 INFO - TinderboxPrint: CPU idle
8,292.5 (86.7%)
12:41:53 INFO - TinderboxPrint: CPU user
1,229.7 (12.9%)
12:41:53 INFO - install - Wall time: 3s; CPU: 9.0%; Read bytes: 0; Write bytes: 80612352; Read time: 0; Write time: 259430
12:41:53 INFO - run-tests - Wall time: 1193s; CPU: 13.0%; Read bytes: 227466752; Write bytes: 319129088; Read time: 3460200; Write time: 3541570
12:41:54 INFO - Running post-run listener: _upload_blobber_files
12:41:54 INFO - Blob upload gear active.
12:41:54 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
12:41:54 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
12:41:54 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Larch-Non-PGO', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
12:41:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Larch-Non-PGO -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
12:41:54 INFO - (blobuploader) - INFO - Open directory for files ...
12:41:54 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
12:41:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
12:41:54 INFO - (blobuploader) - INFO - Uploading, attempt #1.
12:41:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
12:41:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
12:41:55 INFO - (blobuploader) - INFO - Done attempting.
12:41:55 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
12:41:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
12:41:55 INFO - (blobuploader) - INFO - Uploading, attempt #1.
12:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
12:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
12:41:56 INFO - (blobuploader) - INFO - Done attempting.
12:41:56 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
12:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
12:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1.
12:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
12:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
12:41:58 INFO - (blobuploader) - INFO - Done attempting.
12:41:58 INFO - (blobuploader) - INFO - Iteration through files over.
12:41:58 INFO - Return code: 0
12:41:58 INFO - rmtree: C:\slave\test\build\uploaded_files.json
12:41:58 INFO - Using _rmtree_windows ...
12:41:58 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
12:41:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/66a27efa744874e39d7e0c7d25041f4657a0c4141b819d2c0752ccf075ab2c6d94b2fade60cbe028a68e82ae6580c78960dde25f03fd8633014852c70bab9a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1369747677eea85e143a22bfa4758fda3884af40b1a45c24d9c54579b4e1a3986c843108c32e9daa0dd64a6f7b4c6f6d2ec0d5a98f8cdf94e7308c4245945358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cea795f272c67b01198ef4477b0d39aaf0d8842eb6b57a12e569d586a43ea5be79567a9ebc9c86f94fa32f24151f0ed87f05748f48bf8b1d249cd20fb3eef870"}
12:41:58 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
12:41:58 INFO - Writing to file C:\slave\test\properties\blobber_files
12:41:58 INFO - Contents:
12:41:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/66a27efa744874e39d7e0c7d25041f4657a0c4141b819d2c0752ccf075ab2c6d94b2fade60cbe028a68e82ae6580c78960dde25f03fd8633014852c70bab9a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1369747677eea85e143a22bfa4758fda3884af40b1a45c24d9c54579b4e1a3986c843108c32e9daa0dd64a6f7b4c6f6d2ec0d5a98f8cdf94e7308c4245945358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cea795f272c67b01198ef4477b0d39aaf0d8842eb6b57a12e569d586a43ea5be79567a9ebc9c86f94fa32f24151f0ed87f05748f48bf8b1d249cd20fb3eef870"}
12:41:58 INFO - Running post-run listener: copy_logs_to_upload_dir
12:41:58 INFO - Copying logs to upload dir...
12:41:58 INFO - mkdir: C:\slave\test\build\upload\logs
12:41:58 INFO - Copying logs to upload dir...
12:41:58 INFO - Using _rmtree_windows ...
12:41:58 INFO - Using _rmtree_windows ...
12:41:58 INFO - Using _rmtree_windows ...
12:41:58 INFO - Using _rmtree_windows ...
12:41:58 INFO - Using _rmtree_windows ...
12:41:58 INFO - Using _rmtree_windows ...
12:41:58 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1454.414000
========= master_lag: 0.64 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 15 secs) (at 2016-10-26 12:41:58.459916) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 12:41:58.465595) =========
'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.T-W864-IX-093\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-093
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-093
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Local
LOGONSERVER=\\T-W864-IX-093
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-093
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-093
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-093
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/66a27efa744874e39d7e0c7d25041f4657a0c4141b819d2c0752ccf075ab2c6d94b2fade60cbe028a68e82ae6580c78960dde25f03fd8633014852c70bab9a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1369747677eea85e143a22bfa4758fda3884af40b1a45c24d9c54579b4e1a3986c843108c32e9daa0dd64a6f7b4c6f6d2ec0d5a98f8cdf94e7308c4245945358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cea795f272c67b01198ef4477b0d39aaf0d8842eb6b57a12e569d586a43ea5be79567a9ebc9c86f94fa32f24151f0ed87f05748f48bf8b1d249cd20fb3eef870"}
build_url:https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/OJdE6vwJScSSSi4i0OR6EQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/66a27efa744874e39d7e0c7d25041f4657a0c4141b819d2c0752ccf075ab2c6d94b2fade60cbe028a68e82ae6580c78960dde25f03fd8633014852c70bab9a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1369747677eea85e143a22bfa4758fda3884af40b1a45c24d9c54579b4e1a3986c843108c32e9daa0dd64a6f7b4c6f6d2ec0d5a98f8cdf94e7308c4245945358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cea795f272c67b01198ef4477b0d39aaf0d8842eb6b57a12e569d586a43ea5be79567a9ebc9c86f94fa32f24151f0ed87f05748f48bf8b1d249cd20fb3eef870"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 12:41:58.585200) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 12:41:58.585528) =========
'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.T-W864-IX-093\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-093
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-093
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-093\AppData\Local
LOGONSERVER=\\T-W864-IX-093
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-093
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-093
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-093
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.02 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 12:41:58.703656) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-26 12:41:58.703938) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-26 12:41:59.246273) =========
========= Total master_lag: 0.81 =========