builder: mozilla-beta_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-224
starttime: 1485264381.53
results: success (0)
buildid: 20170124031844
builduid: 63e14f3674a54fb1942699bb1e70483f
revision: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:21.530234) =========
master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:21.531264) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:21.532045) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:21.713087) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:26:21.713801) =========
'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-224\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-224
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-224
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-224\AppData\Local
LOGONSERVER=\\T-W864-IX-224
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-224
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-224
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-224
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--05:26:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|: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% 8.38 MB/s
05:26:23 (8.38 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=1.902000
========= master_lag: 0.04 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:26:23.658971) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-01-24 05:26:23.659385) =========
'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-224\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-224
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-224
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-224\AppData\Local
LOGONSERVER=\\T-W864-IX-224
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-224
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-224
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-224
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=3.920000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-01-24 05:26:27.601303) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:26:27.602276) =========
'bash' '-c' u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-224\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-224
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-224
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-224\AppData\Local
LOGONSERVER=\\T-W864-IX-224
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-224
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-224
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-224
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2017-01-24 05:26:27,719 truncating revision to first 12 chars
2017-01-24 05:26:27,719 Setting DEBUG logging.
2017-01-24 05:26:27,719 attempt 1/10
2017-01-24 05:26:27,719 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5a883b3f3178?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-01-24 05:26:28,785 unpacking tar archive at: mozilla-beta-5a883b3f3178/testing/mozharness/
2017-01-24 05:26:28,887 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.757000
========= master_lag: 0.09 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:26:29.447061) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:29.447447) =========
script_repo_revision: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:29.447974) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:29.448300) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:26:29.471317) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 38 secs) (at 2017-01-24 05:26:29.471850) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Mozilla-Beta' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Mozilla-Beta'
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', 'Mozilla-Beta', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-224\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-224
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-224
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-224\AppData\Local
LOGONSERVER=\\T-W864-IX-224
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-224
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-224
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-224
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
05:26:29 INFO - MultiFileLogger online at 20170124 05:26:29 in C:\slave\test
05:26:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta
05:26:29 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
05:26:29 INFO - {'append_to_log': False,
05:26:29 INFO - 'base_work_dir': 'C:\\slave\\test',
05:26:29 INFO - 'blob_upload_branch': 'Mozilla-Beta',
05:26:29 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
05:26:29 INFO - 'branch': 'Mozilla-Beta',
05:26:29 INFO - 'buildbot_json_path': 'buildprops.json',
05:26:29 INFO - 'config_files': ('talos/windows_config.py',),
05:26:29 INFO - 'default_actions': ('clobber',
05:26:29 INFO - 'read-buildbot-config',
05:26:29 INFO - 'download-and-extract',
05:26:29 INFO - 'populate-webroot',
05:26:29 INFO - 'create-virtualenv',
05:26:29 INFO - 'install',
05:26:29 INFO - 'run-tests'),
05:26:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
05:26:29 INFO - 'download_minidump_stackwalk': True,
05:26:29 INFO - 'download_symbols': 'ondemand',
05:26:29 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
05:26:29 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
05:26:29 INFO - 'hg': 'c:/mozilla-build/hg/hg',
05:26:29 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
05:26:29 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
05:26:29 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
05:26:29 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
05:26:29 INFO - 'C:/mozilla-build/tooltool.py'),
05:26:29 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
05:26:29 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
05:26:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
05:26:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
05:26:29 INFO - 'installer_path': 'installer.exe',
05:26:29 INFO - 'log_level': 'info',
05:26:29 INFO - 'log_name': 'talos',
05:26:29 INFO - 'log_to_console': True,
05:26:29 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
05:26:29 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
05:26:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
05:26:29 INFO - 'opt_config_files': (),
05:26:29 INFO - 'pip_index': False,
05:26:29 INFO - 'sps_profile': False,
05:26:29 INFO - 'sps_profile_interval': 0,
05:26:29 INFO - 'suite': 'dromaeojs',
05:26:29 INFO - 'system_bits': '32',
05:26:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
05:26:29 INFO - 'title': 'T-W864-IX-224',
05:26:29 INFO - 'use_talos_json': True,
05:26:29 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
05:26:29 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
05:26:29 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
05:26:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
05:26:29 INFO - 'work_dir': 'build'}
05:26:29 INFO - [mozharness: 2017-01-24 13:26:29.751000Z] Running clobber step.
05:26:29 INFO - Running pre-action listener: _resource_record_pre_action
05:26:29 INFO - Running main action method: clobber
05:26:29 INFO - rmtree: C:\slave\test\build
05:26:29 INFO - Using _rmtree_windows ...
05:26:29 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
05:28:13 INFO - Running post-action listener: _resource_record_post_action
05:28:13 INFO - [mozharness: 2017-01-24 13:28:13.463000Z] Finished clobber step (success)
05:28:13 INFO - [mozharness: 2017-01-24 13:28:13.463000Z] Running read-buildbot-config step.
05:28:13 INFO - Running pre-action listener: _resource_record_pre_action
05:28:13 INFO - Running main action method: read_buildbot_config
05:28:13 INFO - Using buildbot properties:
05:28:13 INFO - {
05:28:13 INFO - "project": "",
05:28:13 INFO - "product": "firefox",
05:28:13 INFO - "script_repo_revision": "production",
05:28:13 INFO - "builddir": "mozilla-beta_win8_64_test-dromaeojs",
05:28:13 INFO - "repository": "",
05:28:13 INFO - "buildername": "Windows 8 64-bit mozilla-beta pgo talos dromaeojs",
05:28:13 INFO - "buildid": "20170124031844",
05:28:13 INFO - "pgo_build": "True",
05:28:13 INFO - "basedir": "C:\\slave\\test",
05:28:13 INFO - "buildnumber": 50,
05:28:13 INFO - "slavename": "t-w864-ix-224",
05:28:13 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/",
05:28:13 INFO - "platform": "win8_64",
05:28:13 INFO - "scheduler": "tests-mozilla-beta-win64-pgo-talos",
05:28:13 INFO - "branch": "mozilla-beta",
05:28:13 INFO - "repo_path": "releases/mozilla-beta",
05:28:13 INFO - "revision": "5a883b3f3178302819d4cc821ca4d0c3465e5ca8",
05:28:13 INFO - "stage_platform": "win64-pgo",
05:28:13 INFO - "builduid": "63e14f3674a54fb1942699bb1e70483f",
05:28:13 INFO - "slavebuilddir": "test"
05:28:13 INFO - }
05:28:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip.
05:28:13 INFO - Running post-action listener: _resource_record_post_action
05:28:13 INFO - [mozharness: 2017-01-24 13:28:13.467000Z] Finished read-buildbot-config step (success)
05:28:13 INFO - [mozharness: 2017-01-24 13:28:13.467000Z] Running download-and-extract step.
05:28:13 INFO - Running pre-action listener: _resource_record_pre_action
05:28:13 INFO - Running main action method: download_and_extract
05:28:13 INFO - mkdir: C:\slave\test\build\tests
05:28:13 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')]}
05:28:13 INFO - trying https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.test_packages.json
05:28:13 INFO - Downloading https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0.en-US.win64.test_packages.json
05:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0.en-US.win64.test_packages.json'}, attempt #1
05:28:14 INFO - Downloaded 1186 bytes.
05:28:14 INFO - Reading from file C:\slave\test\build\firefox-52.0.en-US.win64.test_packages.json
05:28:14 INFO - Using the following test package requirements:
05:28:14 INFO - {u'common': [u'firefox-52.0.en-US.win64.common.tests.zip'],
05:28:14 INFO - u'cppunittest': [u'firefox-52.0.en-US.win64.common.tests.zip',
05:28:14 INFO - u'firefox-52.0.en-US.win64.cppunittest.tests.zip'],
05:28:14 INFO - u'gtest': [u'firefox-52.0.en-US.win64.common.tests.zip'],
05:28:14 INFO - u'jittest': [u'firefox-52.0.en-US.win64.common.tests.zip',
05:28:14 INFO - u'jsshell-win64.zip'],
05:28:14 INFO - u'mochitest': [u'firefox-52.0.en-US.win64.common.tests.zip',
05:28:14 INFO - u'firefox-52.0.en-US.win64.mochitest.tests.zip'],
05:28:14 INFO - u'mozbase': [u'firefox-52.0.en-US.win64.common.tests.zip'],
05:28:14 INFO - u'reftest': [u'firefox-52.0.en-US.win64.common.tests.zip',
05:28:14 INFO - u'firefox-52.0.en-US.win64.reftest.tests.zip'],
05:28:14 INFO - u'talos': [u'firefox-52.0.en-US.win64.common.tests.zip',
05:28:14 INFO - u'firefox-52.0.en-US.win64.talos.tests.zip'],
05:28:14 INFO - u'web-platform': [u'firefox-52.0.en-US.win64.common.tests.zip',
05:28:14 INFO - u'firefox-52.0.en-US.win64.web-platform.tests.zip'],
05:28:14 INFO - u'xpcshell': [u'firefox-52.0.en-US.win64.common.tests.zip',
05:28:14 INFO - u'firefox-52.0.en-US.win64.xpcshell.tests.zip']}
05:28:14 INFO - Downloading packages: [u'firefox-52.0.en-US.win64.common.tests.zip'] for test suite category: common
05:28:14 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.common.tests.zip
05:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.common.tests.zip'}, attempt #1
05:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.common.tests.zip into memory
05:28:15 INFO - Http code: 200
05:28:15 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront)
05:28:15 INFO - x-amz-cf-id: U6JytU6fbWAvzioePYGJgfOjNAW8y8GVJgpOXaR4vl_UIbWBgNcjEw==
05:28:15 INFO - x-amz-version-id: RPdqVCFY.mvuQP9VqU0K5tOoMUS3ghfN
05:28:15 INFO - Expected file size: 17314563
05:28:15 INFO - Obtained file size: 17314563
05:28:48 INFO - Downloading packages: [u'firefox-52.0.en-US.win64.common.tests.zip', u'firefox-52.0.en-US.win64.talos.tests.zip'] for test suite category: talos
05:28:48 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.common.tests.zip
05:28:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.common.tests.zip'}, attempt #1
05:28:48 INFO - Fetch https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.common.tests.zip into memory
05:28:48 INFO - Http code: 200
05:28:48 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront)
05:28:48 INFO - x-amz-cf-id: DzciuK5KNJNK7Ov0q3VDj_eAkDCZlD5r22PlVxFldMcLiBcqSMUnAw==
05:28:48 INFO - x-amz-version-id: RPdqVCFY.mvuQP9VqU0K5tOoMUS3ghfN
05:28:49 INFO - Expected file size: 17314563
05:28:49 INFO - Obtained file size: 17314563
05:28:57 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.talos.tests.zip
05:28:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.talos.tests.zip'}, attempt #1
05:28:57 INFO - Fetch https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.talos.tests.zip into memory
05:28:58 INFO - Http code: 200
05:28:58 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront)
05:28:58 INFO - x-amz-cf-id: XipuT-q7-11x_YaKR46ig1fhPPXkbme_GrMQzRSkKHgIrFaY6_DtXw==
05:28:58 INFO - x-amz-version-id: XDhKLmma3CcL3b.OHgMrr9gq1NpGgzIw
05:28:58 INFO - Expected file size: 14402992
05:28:58 INFO - Obtained file size: 14402992
05:29:14 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')]}
05:29:14 INFO - trying https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip
05:29:14 INFO - Downloading https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip to C:\slave\test\build\firefox-52.0.en-US.win64.zip
05:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0.en-US.win64.zip'}, attempt #1
05:29:16 INFO - Downloaded 59153100 bytes.
05:29:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip
05:29:16 INFO - mkdir: C:\slave\test\properties
05:29:16 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
05:29:16 INFO - Writing to file C:\slave\test\properties\build_url
05:29:16 INFO - Contents:
05:29:16 INFO - build_url:https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip
05:29:17 INFO - Running post-action listener: _resource_record_post_action
05:29:17 INFO - Running post-action listener: set_extra_try_arguments
05:29:17 INFO - [mozharness: 2017-01-24 13:29:17.148000Z] Finished download-and-extract step (success)
05:29:17 INFO - [mozharness: 2017-01-24 13:29:17.148000Z] Running populate-webroot step.
05:29:17 INFO - Running pre-action listener: _resource_record_pre_action
05:29:17 INFO - Running main action method: populate_webroot
05:29:17 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
05:29:17 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
05:29:17 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
05:29:17 INFO - u'--tppagecycles',
05:29:17 INFO - u'7'],
05:29:17 INFO - u'tests': [u'tsvgm']}},
05:29:17 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'tresize', u'tcanvasmark']},
05:29:17 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
05:29:17 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'dromaeo_css', u'kraken']},
05:29:17 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
05:29:17 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
05:29:17 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
05:29:17 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'damp', u'tps']},
05:29:17 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'tests': [u'damp', u'tps']},
05:29:17 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'dromaeo_dom']},
05:29:17 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
05:29:17 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'basic_compositor_video']},
05:29:17 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
05:29:17 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'a11yr',
05:29:17 INFO - u'ts_paint',
05:29:17 INFO - u'tpaint',
05:29:17 INFO - u'sessionrestore',
05:29:17 INFO - u'sessionrestore_no_auto_restore',
05:29:17 INFO - u'tabpaint']},
05:29:17 INFO - u'other-e10s': {u'tests': [u'a11yr',
05:29:17 INFO - u'ts_paint',
05:29:17 INFO - u'tpaint',
05:29:17 INFO - u'sessionrestore',
05:29:17 INFO - u'sessionrestore_no_auto_restore',
05:29:17 INFO - u'tabpaint']},
05:29:17 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
05:29:17 INFO - u'ts_paint',
05:29:17 INFO - u'tpaint',
05:29:17 INFO - u'sessionrestore',
05:29:17 INFO - u'sessionrestore_no_auto_restore',
05:29:17 INFO - u'tabpaint']},
05:29:17 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
05:29:17 INFO - u'ts_paint',
05:29:17 INFO - u'tpaint',
05:29:17 INFO - u'sessionrestore',
05:29:17 INFO - u'sessionrestore_no_auto_restore',
05:29:17 INFO - u'tabpaint']},
05:29:17 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'a11yr',
05:29:17 INFO - u'ts_paint',
05:29:17 INFO - u'tpaint',
05:29:17 INFO - u'sessionrestore',
05:29:17 INFO - u'sessionrestore_no_auto_restore',
05:29:17 INFO - u'tabpaint']},
05:29:17 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'a11yr',
05:29:17 INFO - u'ts_paint',
05:29:17 INFO - u'tpaint',
05:29:17 INFO - u'sessionrestore',
05:29:17 INFO - u'sessionrestore_no_auto_restore',
05:29:17 INFO - u'tabpaint']},
05:29:17 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'tsvgx',
05:29:17 INFO - u'tsvgr_opacity',
05:29:17 INFO - u'tart',
05:29:17 INFO - u'tscrollx',
05:29:17 INFO - u'cart']},
05:29:17 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
05:29:17 INFO - u'tsvgr_opacity',
05:29:17 INFO - u'tart',
05:29:17 INFO - u'tscrollx',
05:29:17 INFO - u'cart']},
05:29:17 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'talos_options': [u'--disable-e10s'],
05:29:17 INFO - u'tests': [u'tp5o']},
05:29:17 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'tests': [u'tp5o']},
05:29:17 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'talos_options': [u'--disable-e10s',
05:29:17 INFO - u'--xperf_path',
05:29:17 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
05:29:17 INFO - u'tests': [u'tp5n']},
05:29:17 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
05:29:17 INFO - u'talos_options': [u'--xperf_path',
05:29:17 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
05:29:17 INFO - u'tests': [u'tp5n']}},
05:29:17 INFO - u'talos.zip': {u'path': u'',
05:29:17 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
05:29:17 INFO - Running post-action listener: _resource_record_post_action
05:29:17 INFO - [mozharness: 2017-01-24 13:29:17.249000Z] Finished populate-webroot step (success)
05:29:17 INFO - [mozharness: 2017-01-24 13:29:17.249000Z] Running create-virtualenv step.
05:29:17 INFO - Running pre-action listener: _resource_record_pre_action
05:29:17 INFO - Running main action method: create_virtualenv
05:29:17 INFO - Creating virtualenv C:\slave\test\build/venv
05:29:17 INFO - mkdir: C:\slave\test\build\venv\Scripts
05:29:17 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
05:29:17 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'!
05:29:17 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
05:29:17 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
05:29:26 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
05:29:29 INFO - Installing distribute......................................................................................................................................................................................done.
05:29:31 INFO - Return code: 0
05:29:31 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
05:29:31 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
05:29:31 INFO - Reading from file tmpfile_stdout
05:29:31 INFO - Output received:
05:29:31 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
05:29:31 INFO - Using _rmtree_windows ...
05:29:31 INFO - Using _rmtree_windows ...
05:29:31 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
05:29:31 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')]}
05:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:29:31 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')]}
05:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:29:31 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:29:31 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
05:29:31 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
05:29:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:29:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:29:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:29:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:29:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:29:31 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:29:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:29:31 INFO - 'DCLOCATION': 'SCL3',
05:29:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:29:31 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:29:31 INFO - 'HOMEDRIVE': 'C:',
05:29:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:29:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:29:31 INFO - 'KTS_VERSION': '1.19c',
05:29:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:29:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:29:31 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:29:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:29:31 INFO - 'MOZ_NO_REMOTE': '1',
05:29:31 INFO - 'NO_EM_RESTART': '1',
05:29:31 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:29:31 INFO - 'OS': 'Windows_NT',
05:29:31 INFO - 'OURDRIVE': 'C:',
05:29:31 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',
05:29:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:29:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:29:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:29:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:29:31 INFO - 'PROCESSOR_LEVEL': '6',
05:29:31 INFO - 'PROCESSOR_REVISION': '1e05',
05:29:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:29:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:29:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:29:31 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:29:31 INFO - 'PROMPT': '$P$G',
05:29:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:29:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:29:31 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:29:31 INFO - 'PWD': 'C:\\slave\\test',
05:29:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:29:31 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:29:31 INFO - 'SYSTEMDRIVE': 'C:',
05:29:31 INFO - 'SYSTEMROOT': 'C:\\windows',
05:29:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:31 INFO - 'TEST1': 'testie',
05:29:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:31 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:29:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:29:31 INFO - 'USERNAME': 'cltbld',
05:29:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:29:31 INFO - 'WINDIR': 'C:\\windows',
05:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:29:32 INFO - Ignoring indexes: http://pypi.python.org/simple/
05:29:32 INFO - Downloading/unpacking pip>=1.5
05:29:37 INFO - Running setup.py egg_info for package pip
05:29:37 INFO - warning: no files found matching 'pip\cacert.pem'
05:29:37 INFO - warning: no files found matching '*.html' under directory 'docs'
05:29:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
05:29:37 INFO - no previously-included directories found matching 'docs\_build\_sources'
05:29:37 INFO - Installing collected packages: pip
05:29:37 INFO - Found existing installation: pip 0.8.2
05:29:37 INFO - Uninstalling pip:
05:29:37 INFO - Successfully uninstalled pip
05:29:37 INFO - Running setup.py install for pip
05:29:37 INFO - warning: no files found matching 'pip\cacert.pem'
05:29:37 INFO - warning: no files found matching '*.html' under directory 'docs'
05:29:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
05:29:37 INFO - no previously-included directories found matching 'docs\_build\_sources'
05:29:37 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
05:29:37 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
05:29:37 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
05:29:37 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
05:29:37 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
05:29:37 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
05:29:37 INFO - Successfully installed pip
05:29:37 INFO - Cleaning up...
05:29:37 INFO - Return code: 0
05:29:37 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
05:29: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')]}
05:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:29: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')]}
05:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:29:37 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:29:37 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
05:29:37 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
05:29:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:29:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:29:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:29:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:29:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:29:37 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:29:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:29:37 INFO - 'DCLOCATION': 'SCL3',
05:29:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:29:37 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:29:37 INFO - 'HOMEDRIVE': 'C:',
05:29:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:29:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:29:37 INFO - 'KTS_VERSION': '1.19c',
05:29:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:29:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:29:37 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:29:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:29:37 INFO - 'MOZ_NO_REMOTE': '1',
05:29:37 INFO - 'NO_EM_RESTART': '1',
05:29:37 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:29:37 INFO - 'OS': 'Windows_NT',
05:29:37 INFO - 'OURDRIVE': 'C:',
05:29: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',
05:29:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:29:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:29:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:29:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:29:37 INFO - 'PROCESSOR_LEVEL': '6',
05:29:37 INFO - 'PROCESSOR_REVISION': '1e05',
05:29:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:29:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:29:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:29:37 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:29:37 INFO - 'PROMPT': '$P$G',
05:29:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:29:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:29:37 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:29:37 INFO - 'PWD': 'C:\\slave\\test',
05:29:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:29:37 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:29:37 INFO - 'SYSTEMDRIVE': 'C:',
05:29:37 INFO - 'SYSTEMROOT': 'C:\\windows',
05:29:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:37 INFO - 'TEST1': 'testie',
05:29:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:37 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:29:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:29:37 INFO - 'USERNAME': 'cltbld',
05:29:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:29:37 INFO - 'WINDIR': 'C:\\windows',
05:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:29:39 INFO - Downloading/unpacking psutil>=3.1.1
05:29:39 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
05:29:39 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
05:29:40 INFO - Installing collected packages: psutil
05:29:40 INFO - Successfully installed psutil
05:29:40 INFO - Cleaning up...
05:29:41 INFO - Return code: 0
05:29:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
05:29:41 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')]}
05:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:29:41 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')]}
05:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:29:41 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:29:41 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
05:29:41 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
05:29:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:29:41 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:29:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:29:41 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:29:41 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:29:41 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:29:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:29:41 INFO - 'DCLOCATION': 'SCL3',
05:29:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:29:41 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:29:41 INFO - 'HOMEDRIVE': 'C:',
05:29:41 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:29:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:29:41 INFO - 'KTS_VERSION': '1.19c',
05:29:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:29:41 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:29:41 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:29:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:29:41 INFO - 'MOZ_NO_REMOTE': '1',
05:29:41 INFO - 'NO_EM_RESTART': '1',
05:29:41 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:29:41 INFO - 'OS': 'Windows_NT',
05:29:41 INFO - 'OURDRIVE': 'C:',
05:29:41 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',
05:29:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:29:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:29:41 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:29:41 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:29:41 INFO - 'PROCESSOR_LEVEL': '6',
05:29:41 INFO - 'PROCESSOR_REVISION': '1e05',
05:29:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:29:41 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:29:41 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:29:41 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:29:41 INFO - 'PROMPT': '$P$G',
05:29:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:29:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:29:41 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:29:41 INFO - 'PWD': 'C:\\slave\\test',
05:29:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:29:41 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:29:41 INFO - 'SYSTEMDRIVE': 'C:',
05:29:41 INFO - 'SYSTEMROOT': 'C:\\windows',
05:29:41 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:41 INFO - 'TEST1': 'testie',
05:29:41 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:41 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:29:41 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:29:41 INFO - 'USERNAME': 'cltbld',
05:29:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:29:41 INFO - 'WINDIR': 'C:\\windows',
05:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:29:41 INFO - Downloading/unpacking mozsystemmonitor==0.3
05:29:41 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
05:29:41 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
05:29:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz
05:29:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
05:29:42 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)
05:29:42 INFO - Installing collected packages: mozsystemmonitor
05:29:42 INFO - Running setup.py install for mozsystemmonitor
05:29:43 INFO - Successfully installed mozsystemmonitor
05:29:43 INFO - Cleaning up...
05:29:43 INFO - Return code: 0
05:29:43 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
05:29:43 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')]}
05:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:29:43 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')]}
05:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:29:43 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:29:43 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
05:29:43 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
05:29:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:29:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:29:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:29:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:29:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:29:43 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:29:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:29:43 INFO - 'DCLOCATION': 'SCL3',
05:29:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:29:43 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:29:43 INFO - 'HOMEDRIVE': 'C:',
05:29:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:29:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:29:43 INFO - 'KTS_VERSION': '1.19c',
05:29:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:29:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:29:43 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:29:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:29:43 INFO - 'MOZ_NO_REMOTE': '1',
05:29:43 INFO - 'NO_EM_RESTART': '1',
05:29:43 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:29:43 INFO - 'OS': 'Windows_NT',
05:29:43 INFO - 'OURDRIVE': 'C:',
05:29:43 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',
05:29:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:29:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:29:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:29:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:29:43 INFO - 'PROCESSOR_LEVEL': '6',
05:29:43 INFO - 'PROCESSOR_REVISION': '1e05',
05:29:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:29:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:29:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:29:43 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:29:43 INFO - 'PROMPT': '$P$G',
05:29:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:29:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:29:43 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:29:43 INFO - 'PWD': 'C:\\slave\\test',
05:29:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:29:43 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:29:43 INFO - 'SYSTEMDRIVE': 'C:',
05:29:43 INFO - 'SYSTEMROOT': 'C:\\windows',
05:29:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:43 INFO - 'TEST1': 'testie',
05:29:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:43 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:29:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:29:43 INFO - 'USERNAME': 'cltbld',
05:29:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:29:43 INFO - 'WINDIR': 'C:\\windows',
05:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:29:43 INFO - Downloading/unpacking jsonschema==2.5.1
05:29:43 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
05:29:43 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
05:29:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
05:29:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
05:29:44 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
05:29:44 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
05:29:45 INFO - Downloading functools32-3.2.3-2.tar.gz
05:29:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
05:29:45 INFO - warning: no files found matching '*.txt'
05:29:45 INFO - no previously-included directories found matching 'build'
05:29:45 INFO - no previously-included directories found matching 'dist'
05:29:45 INFO - no previously-included directories found matching '.git*'
05:29:45 INFO - Installing collected packages: jsonschema, functools32
05:29:45 INFO - Running setup.py install for functools32
05:29:45 INFO - warning: no files found matching '*.txt'
05:29:45 INFO - no previously-included directories found matching 'build'
05:29:45 INFO - no previously-included directories found matching 'dist'
05:29:45 INFO - no previously-included directories found matching '.git*'
05:29:45 INFO - Successfully installed jsonschema functools32
05:29:45 INFO - Cleaning up...
05:29:45 INFO - Return code: 0
05:29:45 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
05:29:45 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')]}
05:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:29:45 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')]}
05:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:29:45 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:29:45 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
05:29:45 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
05:29:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:29:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:29:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:29:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:29:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:29:45 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:29:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:29:45 INFO - 'DCLOCATION': 'SCL3',
05:29:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:29:45 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:29:45 INFO - 'HOMEDRIVE': 'C:',
05:29:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:29:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:29:45 INFO - 'KTS_VERSION': '1.19c',
05:29:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:29:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:29:45 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:29:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:29:45 INFO - 'MOZ_NO_REMOTE': '1',
05:29:45 INFO - 'NO_EM_RESTART': '1',
05:29:45 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:29:45 INFO - 'OS': 'Windows_NT',
05:29:45 INFO - 'OURDRIVE': 'C:',
05:29:45 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',
05:29:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:29:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:29:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:29:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:29:45 INFO - 'PROCESSOR_LEVEL': '6',
05:29:45 INFO - 'PROCESSOR_REVISION': '1e05',
05:29:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:29:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:29:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:29:45 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:29:45 INFO - 'PROMPT': '$P$G',
05:29:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:29:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:29:45 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:29:45 INFO - 'PWD': 'C:\\slave\\test',
05:29:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:29:45 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:29:45 INFO - 'SYSTEMDRIVE': 'C:',
05:29:45 INFO - 'SYSTEMROOT': 'C:\\windows',
05:29:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:45 INFO - 'TEST1': 'testie',
05:29:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:45 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:29:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:29:45 INFO - 'USERNAME': 'cltbld',
05:29:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:29:45 INFO - 'WINDIR': 'C:\\windows',
05:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
05:29:46 INFO - Cleaning up...
05:29:46 INFO - Return code: 0
05:29:46 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
05:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:29:46 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:29:46 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
05:29:46 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
05:29:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:29:46 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:29:46 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:29:46 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:29:46 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:29:46 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:29:46 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:29:46 INFO - 'DCLOCATION': 'SCL3',
05:29:46 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:29:46 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:29:46 INFO - 'HOMEDRIVE': 'C:',
05:29:46 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:29:46 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:29:46 INFO - 'KTS_VERSION': '1.19c',
05:29:46 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:29:46 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:29:46 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:29:46 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:29:46 INFO - 'MOZ_NO_REMOTE': '1',
05:29:46 INFO - 'NO_EM_RESTART': '1',
05:29:46 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:29:46 INFO - 'OS': 'Windows_NT',
05:29:46 INFO - 'OURDRIVE': 'C:',
05:29:46 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',
05:29:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:29:46 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:29:46 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:29:46 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:29:46 INFO - 'PROCESSOR_LEVEL': '6',
05:29:46 INFO - 'PROCESSOR_REVISION': '1e05',
05:29:46 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:29:46 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:29:46 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:29:46 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:29:46 INFO - 'PROMPT': '$P$G',
05:29:46 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:29:46 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:29:46 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:29:46 INFO - 'PWD': 'C:\\slave\\test',
05:29:46 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:29:46 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:29:46 INFO - 'SYSTEMDRIVE': 'C:',
05:29:46 INFO - 'SYSTEMROOT': 'C:\\windows',
05:29:46 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:46 INFO - 'TEST1': 'testie',
05:29:46 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:46 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:29:46 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:29:46 INFO - 'USERNAME': 'cltbld',
05:29:46 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:29:46 INFO - 'WINDIR': 'C:\\windows',
05:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:29:46 INFO - Downloading/unpacking blobuploader==1.2.4
05:29:46 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
05:29:46 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
05:29:47 INFO - Downloading blobuploader-1.2.4.tar.gz
05:29:47 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
05:29:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
05:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:29:47 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
05:29:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
05:29:48 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
05:29:48 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
05:29:48 INFO - Downloading docopt-0.6.1.tar.gz
05:29:48 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
05:29:48 INFO - Installing collected packages: blobuploader, requests, docopt
05:29:48 INFO - Running setup.py install for blobuploader
05:29:48 INFO - Running setup.py install for requests
05:29:49 INFO - Running setup.py install for docopt
05:29:49 INFO - Successfully installed blobuploader requests docopt
05:29:49 INFO - Cleaning up...
05:29:50 INFO - Return code: 0
05:29:50 INFO - Installing None into virtualenv C:\slave\test\build/venv
05:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:29:50 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, '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-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:29:50 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
05:29:50 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
05:29:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:29:50 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:29:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:29:50 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:29:50 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:29:50 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:29:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:29:50 INFO - 'DCLOCATION': 'SCL3',
05:29:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:29:50 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:29:50 INFO - 'HOMEDRIVE': 'C:',
05:29:50 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:29:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:29:50 INFO - 'KTS_VERSION': '1.19c',
05:29:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:29:50 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:29:50 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:29:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:29:50 INFO - 'MOZ_NO_REMOTE': '1',
05:29:50 INFO - 'NO_EM_RESTART': '1',
05:29:50 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:29:50 INFO - 'OS': 'Windows_NT',
05:29:50 INFO - 'OURDRIVE': 'C:',
05:29:50 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',
05:29:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:29:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:29:50 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:29:50 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:29:50 INFO - 'PROCESSOR_LEVEL': '6',
05:29:50 INFO - 'PROCESSOR_REVISION': '1e05',
05:29:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:29:50 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:29:50 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:29:50 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:29:50 INFO - 'PROMPT': '$P$G',
05:29:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:29:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:29:50 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:29:50 INFO - 'PWD': 'C:\\slave\\test',
05:29:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:29:50 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:29:50 INFO - 'SYSTEMDRIVE': 'C:',
05:29:50 INFO - 'SYSTEMROOT': 'C:\\windows',
05:29:50 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:50 INFO - 'TEST1': 'testie',
05:29:50 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:29:50 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:29:50 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:29:50 INFO - 'USERNAME': 'cltbld',
05:29:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:29:50 INFO - 'WINDIR': 'C:\\windows',
05:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:29:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
05:29:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sjcfru-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
05:29:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
05:29:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hyaelt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-evptti-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jga23n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tyxcaz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eaysz0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iqg6ks-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qpjufj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2v18nd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zzn_po-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
05:29:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tzfgtk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
05:29:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
05:29:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-urqupa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
05:29:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
05:29:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xkjhmj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
05:29:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
05:29:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oza_nd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
05:29:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
05:29:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uwkdu7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
05:29:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
05:29:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3f8wsz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
05:29:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
05:29:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ppslpd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
05:29:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
05:29:52 INFO - Running setup.py install for manifestparser
05:29:52 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
05:29:52 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
05:29:53 INFO - Running setup.py install for mozcrash
05:29:53 INFO - Running setup.py install for mozdebug
05:29:54 INFO - Running setup.py install for mozdevice
05:29:54 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
05:29:54 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
05:29:54 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
05:29:54 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
05:29:54 INFO - Running setup.py install for mozfile
05:29:55 INFO - Running setup.py install for mozhttpd
05:29:55 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
05:29:55 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
05:29:55 INFO - Running setup.py install for mozinfo
05:29:56 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Running setup.py install for mozInstall
05:29:56 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
05:29:56 INFO - Running setup.py install for mozleak
05:29:56 INFO - Running setup.py install for mozlog
05:29:57 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
05:29:57 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
05:29:57 INFO - Running setup.py install for moznetwork
05:29:58 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
05:29:58 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
05:29:58 INFO - Running setup.py install for mozprocess
05:29:58 INFO - Running setup.py install for mozprofile
05:29:58 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
05:29:58 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
05:29:58 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
05:29:58 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
05:29:58 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
05:29:58 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
05:29:59 INFO - Running setup.py install for mozrunner
05:29:59 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
05:29:59 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
05:30:00 INFO - Running setup.py install for mozscreenshot
05:30:00 INFO - Running setup.py install for moztest
05:30:01 INFO - Running setup.py install for mozversion
05:30:01 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
05:30:01 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
05:30:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
05:30:01 INFO - Cleaning up...
05:30:01 INFO - Return code: 0
05:30:01 INFO - Installing None into virtualenv C:\slave\test\build/venv
05:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:30:01 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, '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-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:30:01 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
05:30:01 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
05:30:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:30:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:30:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:30:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:30:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:30:01 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:30:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:30:01 INFO - 'DCLOCATION': 'SCL3',
05:30:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:30:01 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:30:01 INFO - 'HOMEDRIVE': 'C:',
05:30:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:30:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:30:01 INFO - 'KTS_VERSION': '1.19c',
05:30:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:30:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:30:01 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:30:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:30:01 INFO - 'MOZ_NO_REMOTE': '1',
05:30:01 INFO - 'NO_EM_RESTART': '1',
05:30:01 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:30:01 INFO - 'OS': 'Windows_NT',
05:30:01 INFO - 'OURDRIVE': 'C:',
05:30:01 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',
05:30:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:30:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:30:01 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:30:01 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:30:01 INFO - 'PROCESSOR_LEVEL': '6',
05:30:01 INFO - 'PROCESSOR_REVISION': '1e05',
05:30:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:30:01 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:30:01 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:30:01 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:30:01 INFO - 'PROMPT': '$P$G',
05:30:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:30:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:30:01 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:30:01 INFO - 'PWD': 'C:\\slave\\test',
05:30:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:30:01 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:30:01 INFO - 'SYSTEMDRIVE': 'C:',
05:30:01 INFO - 'SYSTEMROOT': 'C:\\windows',
05:30:01 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:01 INFO - 'TEST1': 'testie',
05:30:01 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:01 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:30:01 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:30:01 INFO - 'USERNAME': 'cltbld',
05:30:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:30:01 INFO - 'WINDIR': 'C:\\windows',
05:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:30:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
05:30:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2akbww-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sjmtln-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
05:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hh_4te-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bgsspa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gafvxc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dasixz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zujkdn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3ijjqe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z31y6p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
05:30:02 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))
05:30:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
05:30:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eyqmzu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
05:30:03 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))
05:30:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
05:30:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uosoqw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
05:30:03 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))
05:30:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
05:30:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hgb2j5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
05:30:03 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))
05:30:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
05:30:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-unzk4u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
05:30:03 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))
05:30:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
05:30:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rtuonw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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))
05:30:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
05:30:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-umxonl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
05:30:03 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))
05:30:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
05:30:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xr8nqq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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))
05:30:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
05:30:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wpwaeh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
05:30:04 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))
05:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
05:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
05:30:04 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))
05:30:04 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))
05:30:04 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))
05:30:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
05:30:04 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
05:30:04 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
05:30:05 INFO - Downloading blessings-1.6.tar.gz
05:30:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
05:30:05 INFO - Installing collected packages: blessings
05:30:05 INFO - Running setup.py install for blessings
05:30:05 INFO - Successfully installed blessings
05:30:05 INFO - Cleaning up...
05:30:08 INFO - Return code: 0
05:30:08 INFO - Done creating virtualenv C:\slave\test\build/venv.
05:30:08 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
05:30:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
05:30:09 INFO - Reading from file tmpfile_stdout
05:30:09 INFO - Using _rmtree_windows ...
05:30:09 INFO - Using _rmtree_windows ...
05:30:09 INFO - Current package versions:
05:30:09 INFO - blessings == 1.6
05:30:09 INFO - blobuploader == 1.2.4
05:30:09 INFO - docopt == 0.6.1
05:30:09 INFO - functools32 == 3.2.3-2
05:30:09 INFO - jsonschema == 2.5.1
05:30:09 INFO - manifestparser == 1.1
05:30:09 INFO - mozInstall == 1.12
05:30:09 INFO - mozcrash == 1.0
05:30:09 INFO - mozdebug == 0.1
05:30:09 INFO - mozdevice == 0.48
05:30:09 INFO - mozfile == 1.2
05:30:09 INFO - mozhttpd == 0.7
05:30:09 INFO - mozinfo == 0.9
05:30:09 INFO - mozleak == 0.1
05:30:09 INFO - mozlog == 3.4
05:30:09 INFO - moznetwork == 0.27
05:30:09 INFO - mozprocess == 0.23
05:30:09 INFO - mozprofile == 0.28
05:30:09 INFO - mozrunner == 6.13
05:30:09 INFO - mozscreenshot == 0.1
05:30:09 INFO - mozsystemmonitor == 0.3
05:30:09 INFO - moztest == 0.8
05:30:09 INFO - mozversion == 1.4
05:30:09 INFO - psutil == 3.1.1
05:30:09 INFO - requests == 1.2.3
05:30:09 INFO - Installing None into virtualenv C:\slave\test\build/venv
05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:30:09 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, '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-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:30:09 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
05:30:09 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
05:30:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:30:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:30:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:30:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:30:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:30:09 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:30:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:30:09 INFO - 'DCLOCATION': 'SCL3',
05:30:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:30:09 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:30:09 INFO - 'HOMEDRIVE': 'C:',
05:30:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:30:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:30:09 INFO - 'KTS_VERSION': '1.19c',
05:30:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:30:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:30:09 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:30:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:30:09 INFO - 'MOZ_NO_REMOTE': '1',
05:30:09 INFO - 'NO_EM_RESTART': '1',
05:30:09 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:30:09 INFO - 'OS': 'Windows_NT',
05:30:09 INFO - 'OURDRIVE': 'C:',
05:30:09 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',
05:30:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:30:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:30:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:30:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:30:09 INFO - 'PROCESSOR_LEVEL': '6',
05:30:09 INFO - 'PROCESSOR_REVISION': '1e05',
05:30:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:30:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:30:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:30:09 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:30:09 INFO - 'PROMPT': '$P$G',
05:30:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:30:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:30:09 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:30:09 INFO - 'PWD': 'C:\\slave\\test',
05:30:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:30:09 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:30:09 INFO - 'SYSTEMDRIVE': 'C:',
05:30:09 INFO - 'SYSTEMROOT': 'C:\\windows',
05:30:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:09 INFO - 'TEST1': 'testie',
05:30:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:09 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:30:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:30:09 INFO - 'USERNAME': 'cltbld',
05:30:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:30:09 INFO - 'WINDIR': 'C:\\windows',
05:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 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))
05:30:09 INFO - Cleaning up...
05:30:09 INFO - Return code: 0
05:30:09 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:30:09 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 0x02358640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D1E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246F2F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-224', 'USERDOMAIN': 'T-W864-IX-224', '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-224', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-224', '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-224\\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
05:30:09 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
05:30:09 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
05:30:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:30:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:30:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:30:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:30:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:30:09 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:30:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:30:09 INFO - 'DCLOCATION': 'SCL3',
05:30:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:30:09 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:30:09 INFO - 'HOMEDRIVE': 'C:',
05:30:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:30:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:30:09 INFO - 'KTS_VERSION': '1.19c',
05:30:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:30:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:30:09 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:30:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:30:09 INFO - 'MOZ_NO_REMOTE': '1',
05:30:09 INFO - 'NO_EM_RESTART': '1',
05:30:09 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:30:09 INFO - 'OS': 'Windows_NT',
05:30:09 INFO - 'OURDRIVE': 'C:',
05:30:09 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',
05:30:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:30:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:30:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:30:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:30:09 INFO - 'PROCESSOR_LEVEL': '6',
05:30:09 INFO - 'PROCESSOR_REVISION': '1e05',
05:30:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:30:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:30:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:30:09 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:30:09 INFO - 'PROMPT': '$P$G',
05:30:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:30:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:30:09 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:30:09 INFO - 'PWD': 'C:\\slave\\test',
05:30:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:30:09 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:30:09 INFO - 'SYSTEMDRIVE': 'C:',
05:30:09 INFO - 'SYSTEMROOT': 'C:\\windows',
05:30:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:09 INFO - 'TEST1': 'testie',
05:30:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:09 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:30:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:30:09 INFO - 'USERNAME': 'cltbld',
05:30:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:30:09 INFO - 'WINDIR': 'C:\\windows',
05:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
05:30:09 INFO - Cleaning up...
05:30:09 INFO - Return code: 0
05:30:09 INFO - Running post-action listener: _resource_record_post_action
05:30:09 INFO - Running post-action listener: _start_resource_monitoring
05:30:09 INFO - Starting resource monitoring.
05:30:09 INFO - [mozharness: 2017-01-24 13:30:09.862000Z] Finished create-virtualenv step (success)
05:30:09 INFO - [mozharness: 2017-01-24 13:30:09.863000Z] Running install step.
05:30:09 INFO - Running pre-action listener: _resource_record_pre_action
05:30:09 INFO - Running main action method: install
05:30:09 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
05:30:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
05:30:10 INFO - Reading from file tmpfile_stdout
05:30:10 INFO - Using _rmtree_windows ...
05:30:10 INFO - Using _rmtree_windows ...
05:30:10 INFO - Detecting whether we're running mozinstall >=1.0...
05:30:10 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
05:30:10 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
05:30:10 INFO - Reading from file tmpfile_stdout
05:30:10 INFO - Output received:
05:30:10 INFO - Usage: mozinstall-script.py [options] installer
05:30:10 INFO - Options:
05:30:10 INFO - -h, --help show this help message and exit
05:30:10 INFO - -d DEST, --destination=DEST
05:30:10 INFO - Directory to install application into. [default:
05:30:10 INFO - "C:\slave\test"]
05:30:10 INFO - --app=APP Application being installed. [default: firefox]
05:30:10 INFO - Using _rmtree_windows ...
05:30:10 INFO - Using _rmtree_windows ...
05:30:10 INFO - mkdir: C:\slave\test\build\application
05:30:10 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.0.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application']
05:30:10 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.0.en-US.win64.zip --destination C:\slave\test\build\application
ProcessManager NOT managing child processes
05:30:12 INFO - Reading from file tmpfile_stdout
05:30:12 INFO - Output received:
05:30:12 INFO - C:\slave\test\build\application\firefox\firefox.exe
05:30:12 INFO - Using _rmtree_windows ...
05:30:12 INFO - Using _rmtree_windows ...
05:30:12 INFO - Running post-action listener: _resource_record_post_action
05:30:12 INFO - [mozharness: 2017-01-24 13:30:12.500000Z] Finished install step (success)
05:30:12 INFO - [mozharness: 2017-01-24 13:30:12.500000Z] Running run-tests step.
05:30:12 INFO - Running pre-action listener: _resource_record_pre_action
05:30:12 INFO - Running main action method: run_tests
05:30:12 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
05:30:12 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
05:30:12 INFO - Python 2.7.3
05:30:12 INFO - Return code: 0
05:30:12 INFO - grabbing minidump binary from tooltool
05:30:12 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')]}
05:30:12 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 0x023ACE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028E4520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
05:30:12 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
05:30:12 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
05:30:12 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
05:30:12 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
05:30:14 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpn5r0w6
05:30:14 INFO - INFO - File integrity verified, renaming tmpn5r0w6 to win32-minidump_stackwalk.exe
05:30:14 INFO - Return code: 0
05:30:14 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
05:30:14 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
05:30:14 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
05:30:14 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
05:30:14 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
05:30:14 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-224', '--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
05:30:14 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-224 --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
05:30:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
05:30:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Roaming',
05:30:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
05:30:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
05:30:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
05:30:14 INFO - 'COMPUTERNAME': 'T-W864-IX-224',
05:30:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
05:30:14 INFO - 'DCLOCATION': 'SCL3',
05:30:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
05:30:14 INFO - 'FP_NO_HOST_CHECK': 'NO',
05:30:14 INFO - 'HOMEDRIVE': 'C:',
05:30:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-224',
05:30:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
05:30:14 INFO - 'KTS_VERSION': '1.19c',
05:30:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-224\\AppData\\Local',
05:30:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-224',
05:30:14 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
05:30:14 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
05:30:14 INFO - 'MONDIR': 'C:\\Monitor_config\\',
05:30:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
05:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:30:14 INFO - 'MOZ_NO_REMOTE': '1',
05:30:14 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
05:30:14 INFO - 'NO_EM_RESTART': '1',
05:30:14 INFO - 'NUMBER_OF_PROCESSORS': '8',
05:30:14 INFO - 'OS': 'Windows_NT',
05:30:14 INFO - 'OURDRIVE': 'C:',
05:30:14 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',
05:30:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
05:30:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
05:30:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
05:30:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
05:30:14 INFO - 'PROCESSOR_LEVEL': '6',
05:30:14 INFO - 'PROCESSOR_REVISION': '1e05',
05:30:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
05:30:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
05:30:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
05:30:14 INFO - 'PROGRAMW6432': 'C:\\Program Files',
05:30:14 INFO - 'PROMPT': '$P$G',
05:30:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
05:30:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
05:30:14 INFO - 'PUBLIC': 'C:\\Users\\Public',
05:30:14 INFO - 'PWD': 'C:\\slave\\test',
05:30:14 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
05:30:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
05:30:14 INFO - 'SLAVEDIR': 'C:\\slave\\',
05:30:14 INFO - 'SYSTEMDRIVE': 'C:',
05:30:14 INFO - 'SYSTEMROOT': 'C:\\windows',
05:30:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:14 INFO - 'TEST1': 'testie',
05:30:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
05:30:14 INFO - 'USERDOMAIN': 'T-W864-IX-224',
05:30:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-224',
05:30:14 INFO - 'USERNAME': 'cltbld',
05:30:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-224',
05:30:14 INFO - 'WINDIR': 'C:\\windows',
05:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
05:30:14 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-224', '--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
05:30:15 INFO - mozversion application_buildid: 20170124031844
05:30:15 INFO - mozversion application_changeset: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8
05:30:15 INFO - mozversion application_display_name: Firefox
05:30:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
05:30:15 INFO - mozversion application_name: Firefox
05:30:15 INFO - mozversion application_remotingname: firefox
05:30:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta
05:30:15 INFO - mozversion application_vendor: Mozilla
05:30:15 INFO - mozversion application_version: 52.0
05:30:15 INFO - mozversion platform_buildid: 20170124031844
05:30:15 INFO - mozversion platform_changeset: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8
05:30:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta
05:30:15 INFO - mozversion platform_version: 52.0
05:30:15 INFO - using testdate: 1485264615
05:30:15 INFO - actual date: 1485264615
05:30:15 INFO - starting webserver on 'localhost:49273'
05:30:15 INFO - SUITE-START | Running 2 tests
05:30:15 INFO - TEST-START | dromaeo_css
05:30:15 INFO - operating with platform_type : w8_
05:30:15 INFO - Initialising browser for dromaeo_css test...
05:30:15 INFO - TEST-INFO | started process 2844 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpxgod_n\profile http://localhost:49273/getInfo.html)
05:30:24 INFO - PROCESS | 2844 | __metrics Screen width/height:1600/1200
05:30:24 INFO - PROCESS | 2844 | colorDepth:24
05:30:24 INFO - PROCESS | 2844 | Browser inner width/height: 1010/674
05:30:24 INFO - PROCESS | 2844 | __metrics
05:30:25 INFO - PROCESS | 2844 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
05:30:25 INFO - PROCESS | 2844 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
05:30:26 INFO - TEST-INFO | 2844: exit 0
05:30:26 INFO - Browser initialized.
05:30:26 INFO - Running cycle 1/1 for dromaeo_css test...
05:30:26 INFO - TEST-INFO | started process 3992 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpxgod_n\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
05:30:27 INFO - PROCESS | 3992 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
05:30:38 INFO - PROCESS | 3992 | RSS: Main: 142782464
05:30:38 INFO - PROCESS | 3992 |
05:33:39 INFO - PROCESS | 3992 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html)
05:33:41 INFO - PROCESS | 3992 | RSS: Main: 175910912
05:33:41 INFO - PROCESS | 3992 |
05:36:44 INFO - PROCESS | 3992 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html)
05:36:44 INFO - PROCESS | 3992 | RSS: Main: 216768512
05:36:44 INFO - PROCESS | 3992 |
05:39:46 INFO - PROCESS | 3992 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html)
05:39:47 INFO - PROCESS | 3992 | RSS: Main: 166912000
05:39:47 INFO - PROCESS | 3992 |
05:42:49 INFO - PROCESS | 3992 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html)
05:42:50 INFO - PROCESS | 3992 | RSS: Main: 172699648
05:42:50 INFO - PROCESS | 3992 |
05:45:53 INFO - PROCESS | 3992 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html)
05:45:53 INFO - PROCESS | 3992 | RSS: Main: 158023680
05:45:53 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html)
05:48:56 INFO - PROCESS | 3992 | RSS: Main: 209350656
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | __start_tp_report
05:48:56 INFO - PROCESS | 3992 | _x_x_mozilla_page_load
05:48:56 INFO - PROCESS | 3992 | _x_x_mozilla_page_load_details
05:48:56 INFO - PROCESS | 3992 | |i|pagename|runs|
05:48:56 INFO - PROCESS | 3992 | |0;dojo.html;2821.097248880358;2845.9288517787054;2847.8433686147255;2859.24230079029;2865.78506612004;4937.333459982901;4957.429895562012;4972.0055988802205;4985.925211121836;5026.849194524166;5027.245913113025;5049.84850454487;5067.315912351841;5106.259592359106;5114;4509.7970591323465;4540.250858608326;4551.704139230956;4590.655700822435;4593.632509399256;4431.29099344105;4455.376247325377;4609.193391156534;4631.120087183441;4634.3280224367445;4531.796069176895;4532.592066713995;4581.083783243348;4582.335561343603;4623.976880115595;4506.594406503414;4550.954490455119;4601.263797792337;4606.838760643362;4611.654125940568;4518.43519560055;4521.186186486431;4562.749048802315;4572.154151481953;4573.176828170928;4773.11697335994;4879.804807807719;4904.896398310351;4928.137575924199;4945.579625731817;5360.088784906575;5379.946200537984;5381.515663590296;5398.379186393537;5403.648762830403;5373.1402975524115;5435.1847222916485;5449.182622606601;5450.91823622646;5470.2888624478965;4874.8537543873745;4902.191138462185;4922.606191504671;4966.553010229097;5000.924986125211;5518.806841760519;5520.282363292747;5520.806771762969;5524.696141712245;5531.557475401958;5240.528352448298;5250.579953603703;5263.315768950012;5279.920801187908;5294.814681486207;5371.62398632092;5380.515753582118;5427.348718153847;5427.782888684487;5452.945470545244;5343.19852022192;5346.91979620306;5403.459654034565;5403.702796346239;5434.701091440009;5284.735763211901;5338.599605029638;5362.812301569426;5363.624546281723;5366.329208848894;3613.801240931774;3635.309291234657;3652.4521321801412;3657.5610926688437;3660.04838741929;3287.063186991696;3301.4387554115856;3302.6367099619024;3314.7679662423398;3319.817410042471;4886.315915771795;4913.017396520639;5114.897702045938;5123.129068058439;5156.355455568054;5296;5312.256284120149;5323.3079699639575;5350.197470379397;5395.811146609928;4930.654854160174;4953.479884612136;4961.131801934647;4964.379452568429;4996.200607902718;4458.754768487699;4460.30865215892;4464.107178564235;4465.598096171295;4493.5281795411665;5484.957858007046;5507.091329930517;5560.888782224414;5629;5629.831105066936;5447.4824891635235;5468.398476167539;5481.013417584713;5492.148716948879;5495.0658388073325;5602;5618.353889302783;5625.381208067191;5627.465390787868;5634.577406694596;5250.89498210026;5352.571794256528;5365.543928765943;5377.946220537745;5383.7846486140115;5369.436209198134;5414.3232095988005;5442.619016668795;5444.945550544602;5449.3188351456065;5297.443768404416;5300.31095957523;5305.628605997543;5305.65513241638;5305.734713264244;5228.9738551307;5258.947410525846;5288.444713305047;5291.470852914832;5311.229871668664;5128.7179205144075;5173.32746742921;5177.715225662625;5189.221616757516;5235.581153507786;5289.57683385336;5293.232481290268;5297.867553311198;5302.469753024667;5306.54894333986;5140.537351638371;5141.640085194001;5170.9658068385725;5239.607029472729;5273.34083239595
05:48:56 INFO - PROCESS | 3992 | |1;ext.html;540.5378451289263;546.7102435709073;559.1138046196778;562.0529407947611;566.6769941133555;28255.858720706394;30596.847015764946;30628.846855765718;30649;37014;35710.46434303487;39059.21881562374;39101.608983910155;39114.21771564574;39129.41305880407;8091.19088091192;8176.38677099217;8238.134995825441;8242.052164001158;8243.587820608946;7330.8900366494545;7545.094588649343;8196.795080122985;8262.958685206566;8301.211384918422;7628.0464941882265;7632.198619144993;7712.498687585289;9757.463339516324;9994.400335979864;10003.699889003341;10003.949980250125;10074.9496252519;10077.949610251939;10103.646372377005;9744.561494732754;9803.264755143393;9811.852822207602;9812;9815.509224538815;36567.4514882277;36861;36946.8152659235;36962.630373696185;36978.815105924295;2826.985865070682;2879.2370021944203;3079.291762894547;3337.0823023668686;3560.6795388414907;28261.858690706416;28441.28896777597;28473.028673388533;28810.279743006384;28938.565921511195;3641.253543023674;3963.46493223414;3999.1801680655394;4030.496187976503;4097.672186225095;230517;287509.9999999979;289029;292286;292881;49923.50076499261;50382.49617503778;50443;50463.24305135426;50559.74720126376;28879;29686.55470167949;29697.703022969927;31015.844920775253;52415.47584524106;14293.78559321611;14500.129992200502;14516.129032258099;14549.41802327895;14602.780958285633;10128.594856205817;10161.796764064677;10192.286539942133;10195;10234.744131396626;11617.941910290394;16326.102064386572;16397.344106235854;16408.425705100264;16500.42248521296;5143.382794064736;6244.313125556185;6280.309165991737;6362.1093046973465;6397.360263973565;774.2605811450052;846.7671390367698;878.8505953987838;972.4311277902507;977.7213494154132;26490;27080;27519.31201719973;27708.584371234447;27738.306542336602;902.472053848506;916.4363916191628;946.7680418297562;994.0606127209862;1017.5726194998118;11747;14000.229987350589;14423.78364324536;14515.491957781427;14529.564113076625;315951;401373;410063;411198;450827;38394.80802595969;39177.80411097926;41476;42865.57134428678;43292.56707432948;1083.967480975572;1116.5701205036119;1131.196850236325;1133.6825688807148;1135.3415019288957;25150.24549263525;25244.873775631004;25628.35929101713;25954;26147.607785883607;37566;37579;38058;38287.42568861525;38313.80843095878;219289;240961;241860;242212;243165;22324.21865234774;22335.66496502521;22577;22622.208222712125;22633.321000369357;34623.307533849686;34827;35530.46704299489;35801;36135.45796813103;30638.387232255674;30951.38181164152;31382;34904;35939.64060359363;34549.481757774156;34842.47736283907;35097.122571935906;35486;35523.64476355203;33241.501377478875;33964;34278.31443371168;34663.13342166466;34799.4780078294;30574.388512229187;31351.372972540878;32156.356872861943;32205.677943220267;32273.838630806695;23921.401964951016;24320.148794792804;24590.631140532547;24738;24768.50462990766
05:48:56 INFO - PROCESS | 3992 | |2;jquery.html;325.64829983617693;329.586369106771;346.0535435583679;347.3764592556361;363.9144800971771;13001.414936327865;13838.308084595768;15943.840561594381;16284.26720797564;17022.404215852446;16009.439669611565;16281.755773663375;16403.83596164041;16550.586235344093;16692.83307166928;4773.546513081269;5113.616478764089;5341.492558206984;5349.5720342372715;5355.598330125236;5812.883742325151;6023.945809483344;6030.306514750794;6033.42682445167;6036.667983260919;4825.565699087081;5046.82336118236;5990;5990.251218597676;5990.8801823963495;5254.605904557155;5274.2879711238875;5283.920741188886;5297.841064768082;5298.993191293642;4966.1309270877455;5070.2394640803805;5101.464346243665;5116.488351164854;5180.533751962342;10421.374717516974;10429.269951103426;17621.471355859343;19851.80148198514;20161.294354697515;1771.769669942912;1835.651226267005;1837.4028440756674;1946.6204090202416;2617.084020592796;8001.599720048968;8448.197421245033;8484.957575212084;8508.978922529273;8763.912360876373;1762.189392879277;1773.0957211822063;1779.1993602878756;1790.5255107396551;1805.1154934082335;66453;70371.94442083425;70827;71094.64452677703;72170.27829721688;8834.823303534022;8974.820503589892;9221.985581586021;9414.340996130342;9554;11861;11868.10989175798;11875.643730688093;11880.881191188151;11892.227005244631;6664.500162487736;6778.491613129035;6789.694463749143;6860.485463590251;6865.450763938973;6668.399844013965;6681;6736.326367363323;6755.763548275787;6799.1161149051295;3662.0661731258892;3718.4980027696456;3722.2555488902326;3748.4189950557707;3767.8492860285282;1561.125769569045;1581.4623028170477;1582.7704982777432;1585.262852773466;1586.1831156954179;755.7241606813584;757.6211894052974;764.6406189091118;771.1093686791764;772.632999325316;15968;16080.839191608167;16411.17944102814;16458.506244812674;16490.58773530671;761.37186820873;807.4912804932854;820.1716266570807;820.3314298846421;914.6341463414687;8949.284057275403;8981.787458693123;9158.86261706075;9378.437293762396;9493.952530237304;378993;383753;386100;386174;387688;77521.6123919388;77693;78655.60672196717;78769;79194;871.4901782457333;883.2536506651998;901.5402144906014;902.3322741171617;903.9864402033975;14410.279486025447;14437.7834332483;14549.272536372928;14614.269286535418;14994.700105998038;34068.318633627685;35069.298614027066;35557.28885422225;35733;35924;48905.755471222416;49798.50201498083;49993.25010124778;52049;53030;7004.894926576208;7411.925880741123;7445.516041457288;7516.24837516244;7670.693172273047;11057.944710276397;11515;11556.42217889119;11671.183017188716;11781.823272651089;9558.636193330836;9626.66306679263;9798.167155791838;9863.260255481011;9996.700098997042;9720.465374404475;9870.654527091518;9997.800043999225;10157.89842101599;10234.385936843813;9455.574499147693;9676.467794271382;9940.652077177265;10010.949945250228;10014.949925250326;6033.245844269466;6459.6447195402825;6521.347865213441;6542.640154791532;7544.811379715551;6720.529562930548;9336.53317334117;9729.562169702238;9778.951105244429;9819.803603928025
05:48:56 INFO - PROCESS | 3992 | |3;mootools.html;1038.7818558102797;1040.380973320874;1044.4046893270838;1162.732571508553;1269.8730126987302;6376.872462550752;6842.82892927677;7046.718131274755;7053.435725141989;7055.85888282234;6986.685599148038;7006.57960522369;7055.400290975261;7062.929370706292;7064.222935477093;1926.826585607295;1941.5922656242205;1950.6098780243938;1950.7854136045023;1951.4535929939639;1902.9809701903012;1924.422673198042;1931.9806801932011;1936.3416438410939;1939.0401751133209;1919.5585015446457;1942.8834269943777;1950.6391317606217;1950.7464029676194;1951.2390167834485;1875.3061367294051;1908.8186622270862;1910.0258867977361;1912.9617407651838;1915.8467322614158;1871.1392759330724;1881.2098918454283;1903.8381737552324;1910.923563057476;1912.9330473433502;6784.694688739019;6792.28680988494;6803;6826.146731658543;6870.072540207058;4289.356596510548;4456.732596044215;4456.844010459618;4458.308962110878;4462.3975763271865;2786.1084452975056;2919.3139612191117;2970.2277407874108;2972.970270297291;2974.8363839988792;906.7989995316543;928.6842473559022;932.8572498689119;935.6210734652477;947.1901524196782;9190.575460803586;9215.124563166488;9258.72223833286;9260.166585007315;9279.396839205498;3705.9258814824093;3777.7166712496673;3840.6927445804267;3902.746321489094;3902.980485097613;7711.922880771121;7718.729844455417;7771.689132434639;7779.299863012356;7793.376529877596;4317.503487099024;4372.584604462571;4375.671824613167;4378.408914796525;4387.363832244307;3561.465780133001;3573.8920934510384;4132.132252227006;4133.524644665842;4133.689973251958;2934.7212014858555;3201.9039428817173;3209.3420848725955;3234.466313058319;3257.885973990899;921.5944984206927;948.4167237149104;950.3300173377752;955.9952200238954;958.4488918871538;688.2841844481683;696.4776417686735;705.9258777828356;712.4976891291627;728.9562626242442;4115.97942010288;4162.542120366757;4201.075763332123;4241.300185469425;4426.402435671143;352.7354484136897;354.5160855432316;363;365.6014943711367;366.6443549756732;2668.7331266873157;2718.130198336553;2810.803243772916;2839.744423001898;2845.38824152804;8218.547979861165;8549.829003419896;8594.613242404106;8617.526036067951;8621.31029517637;8384.748457546284;8385.832283354299;8514;8536.189062039097;8566.143385661384;6360.650164241011;6485.351464853571;6490.156279683705;6498.707558159894;6505.934940650627;4111.588841115865;4126.051008268055;4143.109231515239;4146.958530414778;4206.242876282298;7834.725784597512;7921.049474063149;8059.556724379981;8083.151269116894;8111.472754270953;8060.435769496079;8189.836203276021;8210.753677389688;8222.095569487232;8222.38332125081;6061.515078793774;6117.480014198843;6121.908171377522;6122.846928826815;6124.203853499017;6712.463002959849;6721.596704197764;6793.388595026471;6794.8641027180165;6812.284710105368;6239.407256310643;6294.748210071546;6299.023651334051;6333.588316759396;6360.872782544416;6099.024156134997;6148.600340977822;6181.3200547938795;6236.438720515175;6251.906221406592;5270.841874743764;5272.314599102092;5307.177387504943;5327.147656374961;5334.75993580282;3663.487111804403;3678.7608805427562;3694.2980833642596;3728.9067773305883;3747.0819649186124;3666.688331491853;3673.1000904778502;3682.2819550187455;3708.1285897813455;3772.75477093988
05:48:56 INFO - PROCESS | 3992 | |4;prototype.html;262.96055591661246;265.8139302488259;269.7841726618705;270.3107076953767;272.2757465142718;4897.36334276544;4992.428899116958;5012.674176178555;5026.497350264972;5041.294218809365;4936.753162341886;4945.579625731817;4952.554270115689;4955.182394904837;4964.046392396527;3565.6790888820065;3594.370985077614;3678.8528458861615;3736.1220113273357;3748.2878253131953;3703.1112532992024;3726.273376691546;3740.233252183296;3748.3627783276906;3755.155090104718;3702.4261239507787;3720.9813950930206;3725.701943844486;3725.8882233533036;3740.8690695825653;3639.9080275917117;3698.4822124902535;3735.8505659773577;3740.3157889478707;3741.6071312512204;3233.611966564027;3243.1567792373917;3245.464498357768;3256.234784825564;3266.869325226988;4772.162717353844;4793.873439741658;4805.327254184417;4805.783739731721;4817.229243321051;4296.183725092223;4299.75307160923;4305.160493703729;4324.783760811947;4356.520782713899;5069.403138011515;5122.743862806882;5127.230915362688;5145.408278047998;5161.322570164712;3568.6431356864364;3579.49887015818;3595.658412450813;3616.7468277220605;3617.281791149183;5314.787408503656;5374.092197269991;5423.213634023084;5460.426655201187;5521.613487055908;3565.714742820568;3649.996251030988;3666.4683620874825;3686.9815650921573;3692.1138926657945;3703.666669999713;3758.248350329945;3762.5861155272896;3767.604401537854;3767.811609419518;4317.373980772771;4340.197063543254;4341.370501277297;4354.586314300136;4358.564143585616;4978.925316120261;5164.845054648366;5170.844874653766;5179.741012949337;5277.179373116269;1208.9879101208876;1210.8436443196726;1214.611324376191;1217.287886586357;1220.3776074202221;798.5406984077664;810.2424233341844;818.3248819723751;822.1737154160031;822.5845947796324;4829.396325459317;4832.299316599074;4894.828680996148;4984.277279794482;5101.311322971352;5374.865628359323;5383.327084114486;5384.3000409947235;5412.755066334765;5428.348598168245;4791.832285869978;4989.600831933437;4993.203805868725;4996.701517302082;5006.69959802413;2739.6164536964443;2743.231895069384;2746.503155780105;2750.6561679790025;2762.240383894445;5310.575153987749;5353.58130095525;5369.946300536944;5372.334576281365;5453.23654688344;5085.2372144177925;5205.375354957429;5256.9737151314;5293.497117773805;5530.834074977757;5590.357108932443;5592.860178495407;5607.523360514402;5609.8597535061135;5619.606627536034;5431.2667789847865;5448.673079615236;5500.744694675164;5504.80733174337;5561.833145005657;5040.84877453677;5318.388385335581;5320.605727422598;5358.705271210121;5382.3541175059245;5547.52990457521;5556.555475562026;5563.025126080183;5566.888662226814;5590.385057643737;3710.925781484409;3716.1638631307737;3746.1009357753396;3748.8313025913353;3763.2661630981697;5388.811391601275;5396.379416367168;5448.618596698193;5463.808766693147;5489.231507589021;5285.365756109138;5286.180642000496;5303.893922121459;5304.230886521355;5320.946790532045;5150.042983666183;5343.519083282523;5350.839474815762;5411.864703382447;5421.349438067457;5151.407588127413;5174.870628234325;5183.792648294026;5189.636725429184;5203.947960520346;5047.318611987334;5126.923096153635;5179.1195496766395;5242.239875218148;5272.894542109213;5194.194899790538;5206.2190671398075;5208.9479105209975;5210.244514545446;5214.150839719097
05:48:56 INFO - PROCESS | 3992 | |5;yui.html;598.0730956223822;607.7234858139547;626.7430353555044;626.9968650156745;691.5297597633607;12835.229886206835;13247;13322.866771332283;13348.599542013755;13353.265570393636;13435.059545831795;13591.660208494792;13596.93201533991;13627.114237574575;13636.38636261368;541.3341589844493;549.0748089469257;624.5378419969236;631.9778807741718;647.4011539326104;640.948724102073;647.3558808985066;653.0758976048885;654.361997052872;654.3914159831355;686.5091459606381;687.5805758487344;688.2429327739496;688.562762645721;689.5793565924782;678.9422899053586;681.1689738519024;681.6966449929783;681.7000519771285;682.126877596677;497.86806496278155;497.90290893275824;497.94522602513695;497.972611506367;498.32974649096906;12911.5480958166;13140.737185256337;13161.736765264737;13322.333883305795;13326.067175297732;11776.352300623463;11786.646400607995;12192.878071219351;12323.322217278046;12382.442790074469;9963.950180249125;10030.348027378197;10030.348027378197;10109.191264698806;10296.073353398155;2979.716926891942;3000.9549856752164;3002.2044158298067;3020.4865172920654;3035.7267845893975;49858.501414985745;54188;55008.724956375365;55190.44809551853;61675.38324616786;9717.56270967808;9731.610735570639;9857.950710246403;9877.60489580423;10019.998000200067;16105.838941610667;16616.750748738777;16669.749953750703;17046.488605341612;17058.573535661708;7031.683574239171;7054.365107140382;7259.637018149071;7282.344588987016;7287.198408175096;3890.2219556088894;3910.902227444337;3913.0804260998643;3956.723029387973;3973.602639736061;2786.4009238013923;2866.942661146765;2881.5245484495244;2893.059755579445;2898.5507246376847;516.6951498615759;532.9253904453379;537.5538303208327;538.9164679474687;539.8299535646337;494.38942905511664;601.9526024717048;603.8707122704584;606.4087514673158;650.9283978762332;7869.724559640385;8019.43863929531;8148.877766833502;8237.341012718967;8439.367047471464;520.7110053920111;568.7867049856304;618.9597676151036;621.3817251834454;631.845197926511;3663.780173189617;3732.1042949692423;3740.7194460415576;3843.673287770515;3922.5881282465502;71386.64306678434;72796.63601681958;73574.6321268401;74117;74274.25725742674;59564;62049;63288.36711632825;63559.682201588694;64464;57015.429845701015;57737;57911.13133303004;58540.7072964641;59638.403615964155;7169.964150179216;7258.927410725825;7343.228960959236;7479.364254038468;7516.774496765106;36738.26523469569;38919.6108038916;40173.397399038455;40705;40792.3881141789;44358.778206108764;47538.28692569683;48842.75578622084;49197.262041068694;49510;9795.167410770164;9889.357191782512;10265.486725663537;10681.51933162994;10811.675649730521;12814.29521376296;13037;13122.14706044104;13391.129576577492;13760.449582017007;11169.609063683058;11419;11444.256123351955;11513.539458421905;12291.385430728249;11395.829062564235;11843.526258949545;12172.513099476277;12290.692732681397;12447.315397653216;11692.766144676889;11868.525258989544;11912.40437978115;11943.701407464883;12170.330631815335;9514.476703781358;9754.26842986793;9804.36271642341;9941.353812002197;9972.850407244043;9844.409335439897;9935.503224838585;10055.547500362647;10145;10227.130693891102
05:48:56 INFO - PROCESS | 3992 | __end_tp_report
05:48:56 INFO - PROCESS | 3992 | __start_cc_report
05:48:56 INFO - PROCESS | 3992 | _x_x_mozilla_cycle_collect,1973
05:48:56 INFO - PROCESS | 3992 | __end_cc_report
05:48:56 INFO - PROCESS | 3992 | __startTimestamp1485265736379__endTimestamp
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | ------- Summary: start -------
05:48:56 INFO - PROCESS | 3992 | Number of tests: 6
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | [#0] dojo.html Cycles:165 Average:4960.83 Median:5228.97 stddev:639.32 (12.2%) stddev-sans-first:618.86
05:48:56 INFO - PROCESS | 3992 | Values: 2821.1 2845.9 2847.8 2859.2 2865.8 4937.3 4957.4 4972.0 4985.9 5026.8 5027.2 5049.8 5067.3 5106.3 5114.0 4509.8 4540.3 4551.7 4590.7 4593.6 4431.3 4455.4 4609.2 4631.1 4634.3 4531.8 4532.6 4581.1 4582.3 4624.0 4506.6 4551.0 4601.3 4606.8 4611.7 4518.4 4521.2 4562.7 4572.2 4573.2 4773.1 4879.8 4904.9 4928.1 4945.6 5360.1 5379.9 5381.5 5398.4 5403.6 5373.1 5435.2 5449.2 5450.9 5470.3 4874.9 4902.2 4922.6 4966.6 5000.9 5518.8 5520.3 5520.8 5524.7 5531.6 5240.5 5250.6 5263.3 5279.9 5294.8 5371.6 5380.5 5427.3 5427.8 5452.9 5343.2 5346.9 5403.5 5403.7 5434.7 5284.7 5338.6 5362.8 5363.6 5366.3 3613.8 3635.3 3652.5 3657.6 3660.0 3287.1 3301.4 3302.6 3314.8 3319.8 4886.3 4913.0 5114.9 5123.1 5156.4 5296.0 5312.3 5323.3 5350.2 5395.8 4930.7 4953.5 4961.1 4964.4 4996.2 4458.8 4460.3 4464.1 4465.6 4493.5 5485.0 5507.1 5560.9 5629.0 5629.8 5447.5 5468.4 5481.0 5492.1 5495.1 5602.0 5618.4 5625.4 5627.5 5634.6 5250.9 5352.6 5365.5 5377.9 5383.8 5369.4 5414.3 5442.6 5444.9 5449.3 5297.4 5300.3 5305.6 5305.7 5305.7 5229.0 5258.9 5288.4 5291.5 5311.2 5128.7 5173.3 5177.7 5189.2 5235.6 5289.6 5293.2 5297.9 5302.5 5306.5 5140.5 5141.6 5171.0 5239.6 5273.3
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | [#1] ext.html Cycles:180 Average:44362.35 Median:34586.39 stddev:82737.66 (239.2%) stddev-sans-first:82904.34
05:48:56 INFO - PROCESS | 3992 | Values: 540.5 546.7 559.1 562.1 566.7 28255.9 30596.8 30628.8 30649.0 37014.0 35710.5 39059.2 39101.6 39114.2 39129.4 8091.2 8176.4 8238.1 8242.1 8243.6 7330.9 7545.1 8196.8 8263.0 8301.2 7628.0 7632.2 7712.5 9757.5 9994.4 10003.7 10003.9 10074.9 10077.9 10103.6 9744.6 9803.3 9811.9 9812.0 9815.5 36567.5 36861.0 36946.8 36962.6 36978.8 2827.0 2879.2 3079.3 3337.1 3560.7 28261.9 28441.3 28473.0 28810.3 28938.6 3641.3 3963.5 3999.2 4030.5 4097.7 230517.0 287510.0 289029.0 292286.0 292881.0 49923.5 50382.5 50443.0 50463.2 50559.7 28879.0 29686.6 29697.7 31015.8 52415.5 14293.8 14500.1 14516.1 14549.4 14602.8 10128.6 10161.8 10192.3 10195.0 10234.7 11617.9 16326.1 16397.3 16408.4 16500.4 5143.4 6244.3 6280.3 6362.1 6397.4 774.3 846.8 878.9 972.4 977.7 26490.0 27080.0 27519.3 27708.6 27738.3 902.5 916.4 946.8 994.1 1017.6 11747.0 14000.2 14423.8 14515.5 14529.6 315951.0 401373.0 410063.0 411198.0 450827.0 38394.8 39177.8 41476.0 42865.6 43292.6 1084.0 1116.6 1131.2 1133.7 1135.3 25150.2 25244.9 25628.4 25954.0 26147.6 37566.0 37579.0 38058.0 38287.4 38313.8 219289.0 240961.0 241860.0 242212.0 243165.0 22324.2 22335.7 22577.0 22622.2 22633.3 34623.3 34827.0 35530.5 35801.0 36135.5 30638.4 30951.4 31382.0 34904.0 35939.6 34549.5 34842.5 35097.1 35486.0 35523.6 33241.5 33964.0 34278.3 34663.1 34799.5 30574.4 31351.4 32156.4 32205.7 32273.8 23921.4 24320.1 24590.6 24738.0 24768.5
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | [#2] jquery.html Cycles:180 Average:23687.89 Median:5298.42 stddev:63658.54 (1201.5%) stddev-sans-first:63812.95
05:48:56 INFO - PROCESS | 3992 | Values: 325.6 329.6 346.1 347.4 363.9 13001.4 13838.3 15943.8 16284.3 17022.4 16009.4 16281.8 16403.8 16550.6 16692.8 4773.5 5113.6 5341.5 5349.6 5355.6 5812.9 6023.9 6030.3 6033.4 6036.7 4825.6 5046.8 5990.0 5990.3 5990.9 5254.6 5274.3 5283.9 5297.8 5299.0 4966.1 5070.2 5101.5 5116.5 5180.5 10421.4 10429.3 17621.5 19851.8 20161.3 1771.8 1835.7 1837.4 1946.6 2617.1 8001.6 8448.2 8485.0 8509.0 8763.9 1762.2 1773.1 1779.2 1790.5 1805.1 66453.0 70371.9 70827.0 71094.6 72170.3 8834.8 8974.8 9222.0 9414.3 9554.0 11861.0 11868.1 11875.6 11880.9 11892.2 6664.5 6778.5 6789.7 6860.5 6865.5 6668.4 6681.0 6736.3 6755.8 6799.1 3662.1 3718.5 3722.3 3748.4 3767.8 1561.1 1581.5 1582.8 1585.3 1586.2 755.7 757.6 764.6 771.1 772.6 15968.0 16080.8 16411.2 16458.5 16490.6 761.4 807.5 820.2 820.3 914.6 8949.3 8981.8 9158.9 9378.4 9494.0 378993.0 383753.0 386100.0 386174.0 387688.0 77521.6 77693.0 78655.6 78769.0 79194.0 871.5 883.3 901.5 902.3 904.0 14410.3 14437.8 14549.3 14614.3 14994.7 34068.3 35069.3 35557.3 35733.0 35924.0 48905.8 49798.5 49993.3 52049.0 53030.0 7004.9 7411.9 7445.5 7516.2 7670.7 11057.9 11515.0 11556.4 11671.2 11781.8 9558.6 9626.7 9798.2 9863.3 9996.7 9720.5 9870.7 9997.8 10157.9 10234.4 9455.6 9676.5 9940.7 10010.9 10014.9 6033.2 6459.6 6521.3 6542.6 7544.8 6720.5 9336.5 9729.6 9779.0 9819.8
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | [#3] mootools.html Cycles:180 Average:4524.46 Median:5271.58 stddev:2578.36 (48.9%) stddev-sans-first:2572.28
05:48:56 INFO - PROCESS | 3992 | Values: 1038.8 1040.4 1044.4 1162.7 1269.9 6376.9 6842.8 7046.7 7053.4 7055.9 6986.7 7006.6 7055.4 7062.9 7064.2 1926.8 1941.6 1950.6 1950.8 1951.5 1903.0 1924.4 1932.0 1936.3 1939.0 1919.6 1942.9 1950.6 1950.7 1951.2 1875.3 1908.8 1910.0 1913.0 1915.8 1871.1 1881.2 1903.8 1910.9 1912.9 6784.7 6792.3 6803.0 6826.1 6870.1 4289.4 4456.7 4456.8 4458.3 4462.4 2786.1 2919.3 2970.2 2973.0 2974.8 906.8 928.7 932.9 935.6 947.2 9190.6 9215.1 9258.7 9260.2 9279.4 3705.9 3777.7 3840.7 3902.7 3903.0 7711.9 7718.7 7771.7 7779.3 7793.4 4317.5 4372.6 4375.7 4378.4 4387.4 3561.5 3573.9 4132.1 4133.5 4133.7 2934.7 3201.9 3209.3 3234.5 3257.9 921.6 948.4 950.3 956.0 958.4 688.3 696.5 705.9 712.5 729.0 4116.0 4162.5 4201.1 4241.3 4426.4 352.7 354.5 363.0 365.6 366.6 2668.7 2718.1 2810.8 2839.7 2845.4 8218.5 8549.8 8594.6 8617.5 8621.3 8384.7 8385.8 8514.0 8536.2 8566.1 6360.7 6485.4 6490.2 6498.7 6505.9 4111.6 4126.1 4143.1 4147.0 4206.2 7834.7 7921.0 8059.6 8083.2 8111.5 8060.4 8189.8 8210.8 8222.1 8222.4 6061.5 6117.5 6121.9 6122.8 6124.2 6712.5 6721.6 6793.4 6794.9 6812.3 6239.4 6294.7 6299.0 6333.6 6360.9 6099.0 6148.6 6181.3 6236.4 6251.9 5270.8 5272.3 5307.2 5327.1 5334.8 3663.5 3678.8 3694.3 3728.9 3747.1 3666.7 3673.1 3682.3 3708.1 3772.8
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | [#4] prototype.html Cycles:180 Average:4346.39 Median:5001.70 stddev:1334.53 (26.7%) stddev-sans-first:1302.61
05:48:56 INFO - PROCESS | 3992 | Values: 263.0 265.8 269.8 270.3 272.3 4897.4 4992.4 5012.7 5026.5 5041.3 4936.8 4945.6 4952.6 4955.2 4964.0 3565.7 3594.4 3678.9 3736.1 3748.3 3703.1 3726.3 3740.2 3748.4 3755.2 3702.4 3721.0 3725.7 3725.9 3740.9 3639.9 3698.5 3735.9 3740.3 3741.6 3233.6 3243.2 3245.5 3256.2 3266.9 4772.2 4793.9 4805.3 4805.8 4817.2 4296.2 4299.8 4305.2 4324.8 4356.5 5069.4 5122.7 5127.2 5145.4 5161.3 3568.6 3579.5 3595.7 3616.7 3617.3 5314.8 5374.1 5423.2 5460.4 5521.6 3565.7 3650.0 3666.5 3687.0 3692.1 3703.7 3758.2 3762.6 3767.6 3767.8 4317.4 4340.2 4341.4 4354.6 4358.6 4978.9 5164.8 5170.8 5179.7 5277.2 1209.0 1210.8 1214.6 1217.3 1220.4 798.5 810.2 818.3 822.2 822.6 4829.4 4832.3 4894.8 4984.3 5101.3 5374.9 5383.3 5384.3 5412.8 5428.3 4791.8 4989.6 4993.2 4996.7 5006.7 2739.6 2743.2 2746.5 2750.7 2762.2 5310.6 5353.6 5369.9 5372.3 5453.2 5085.2 5205.4 5257.0 5293.5 5530.8 5590.4 5592.9 5607.5 5609.9 5619.6 5431.3 5448.7 5500.7 5504.8 5561.8 5040.8 5318.4 5320.6 5358.7 5382.4 5547.5 5556.6 5563.0 5566.9 5590.4 3710.9 3716.2 3746.1 3748.8 3763.3 5388.8 5396.4 5448.6 5463.8 5489.2 5285.4 5286.2 5303.9 5304.2 5320.9 5150.0 5343.5 5350.8 5411.9 5421.3 5151.4 5174.9 5183.8 5189.6 5203.9 5047.3 5126.9 5179.1 5242.2 5272.9 5194.2 5206.2 5208.9 5210.2 5214.2
05:48:56 INFO - PROCESS | 3992 |
05:48:56 INFO - PROCESS | 3992 | [#5] yui.html Cycles:180 Average:15161.28 Median:498.15 stddev:19481.35 (3910.7%) stddev-sans-first:19505.30
05:48:56 INFO - PROCESS | 3992 | Values: 598.1 607.7 626.7 627.0 691.5 12835.2 13247.0 13322.9 13348.6 13353.3 13435.1 13591.7 13596.9 13627.1 13636.4 541.3 549.1 624.5 632.0 647.4 640.9 647.4 653.1 654.4 654.4 686.5 687.6 688.2 688.6 689.6 678.9 681.2 681.7 681.7 682.1 497.9 497.9 497.9 498.0 498.3 12911.5 13140.7 13161.7 13322.3 13326.1 11776.4 11786.6 12192.9 12323.3 12382.4 9964.0 10030.3 10030.3 10109.2 10296.1 2979.7 3001.0 3002.2 3020.5 3035.7 49858.5 54188.0 55008.7 55190.4 61675.4 9717.6 9731.6 9858.0 9877.6 10020.0 16105.8 16616.8 16669.7 17046.5 17058.6 7031.7 7054.4 7259.6 7282.3 7287.2 3890.2 3910.9 3913.1 3956.7 3973.6 2786.4 2866.9 2881.5 2893.1 2898.6 516.7 532.9 537.6 538.9 539.8 494.4 602.0 603.9 606.4 650.9 7869.7 8019.4 8148.9 8237.3 8439.4 520.7 568.8 619.0 621.4 631.8 3663.8 3732.1 3740.7 3843.7 3922.6 71386.6 72796.6 73574.6 74117.0 74274.3 59564.0 62049.0 63288.4 63559.7 64464.0 57015.4 57737.0 57911.1 58540.7 59638.4 7170.0 7258.9 7343.2 7479.4 7516.8 36738.3 38919.6 40173.4 40705.0 40792.4 44358.8 47538.3 48842.8 49197.3 49510.0 9795.2 9889.4 10265.5 10681.5 10811.7 12814.3 13037.0 13122.1 13391.1 13760.4 11169.6 11419.0 11444.3 11513.5 12291.4 11395.8 11843.5 12172.5 12290.7 12447.3 11692.8 11868.5 11912.4 11943.7 12170.3 9514.5 9754.3 9804.4 9941.4 9972.9 9844.4 9935.5 10055.5 10145.0 10227.1
05:48:56 INFO - PROCESS | 3992 | -------- Summary: end --------
05:48:56 INFO - PROCESS | 3992 |
05:48:57 INFO - TEST-INFO | 3992: exit 0
05:48:57 INFO - TEST-OK | dromaeo_css | took 1122424ms
05:48:57 INFO - TEST-START | kraken
05:48:57 INFO - operating with platform_type : w8_
05:48:57 INFO - Initialising browser for kraken test...
05:48:57 INFO - TEST-INFO | started process 964 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpl32wtx\profile http://localhost:49273/getInfo.html)
05:49:03 INFO - PROCESS | 964 | __metrics Screen width/height:1600/1200
05:49:03 INFO - PROCESS | 964 | colorDepth:24
05:49:03 INFO - PROCESS | 964 | Browser inner width/height: 1010/674
05:49:03 INFO - PROCESS | 964 | __metrics
05:49:04 INFO - PROCESS | 964 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
05:49:04 INFO - PROCESS | 964 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
05:49:05 INFO - PROCESS | 964 | console.error:
05:49:05 INFO - PROCESS | 964 | Message: Error: Connection closed before committing the transaction.
05:49:05 INFO - PROCESS | 964 | Stack:
05:49:05 INFO - PROCESS | 964 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23
05:49:05 INFO - PROCESS | 964 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
05:49:05 INFO - PROCESS | 964 | this.PromiseWalker.scheduleWalkerLoop/<@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
05:49:05 INFO - PROCESS | 964 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9
05:49:05 INFO - PROCESS | 964 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
05:49:05 INFO - PROCESS | 964 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5
05:49:05 INFO - PROCESS | 964 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
05:49:05 INFO - PROCESS | 964 | Barrier/this.client.addBlocker/promise13.3%
05:50:02 INFO - TinderboxPrint: I/O read bytes / time
221,746,176 / 2,166,360
05:50:02 INFO - TinderboxPrint: I/O write bytes / time
365,786,112 / 3,620,830
05:50:02 INFO - TinderboxPrint: CPU idle
8,258.2 (86.7%)
05:50:02 INFO - TinderboxPrint: CPU user
1,222.6 (12.8%)
05:50:02 INFO - install - Wall time: 3s; CPU: 9.0%; Read bytes: 0; Write bytes: 32215552; Read time: 0; Write time: 138540
05:50:02 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 221746176; Write bytes: 305218048; Read time: 2166360; Write time: 3429710
05:50:02 INFO - Running post-run listener: _upload_blobber_files
05:50:02 INFO - Blob upload gear active.
05:50:02 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
05:50:02 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
05:50:02 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', 'Mozilla-Beta', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
05:50:02 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 Mozilla-Beta -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
05:50:03 INFO - (blobuploader) - INFO - Open directory for files ...
05:50:03 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
05:50:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
05:50:03 INFO - (blobuploader) - INFO - Uploading, attempt #1.
05:50:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
05:50:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
05:50:04 INFO - (blobuploader) - INFO - Done attempting.
05:50:04 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
05:50:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
05:50:04 INFO - (blobuploader) - INFO - Uploading, attempt #1.
05:50:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
05:50:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
05:50:05 INFO - (blobuploader) - INFO - Done attempting.
05:50:05 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
05:50:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
05:50:05 INFO - (blobuploader) - INFO - Uploading, attempt #1.
05:50:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
05:50:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
05:50:07 INFO - (blobuploader) - INFO - Done attempting.
05:50:07 INFO - (blobuploader) - INFO - Iteration through files over.
05:50:07 INFO - Return code: 0
05:50:07 INFO - rmtree: C:\slave\test\build\uploaded_files.json
05:50:07 INFO - Using _rmtree_windows ...
05:50:07 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
05:50:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cac475d9dcf8e03549e5351658a8dea99b88f13fdcd945d42dca0ea4c905237d1b60c3adcecff79b523663548660c0c665e37ee1be08189c4e90872f4974f5ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bd048aceff0cc635c89ce984a2d6405c0fe9a9597138859251199b6a813f0a69e216e0b11ed6c0465f8e5515d2e523d75dc64ed20eeff59a31b1133cac2dfb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94342ef96df21a270aa10cb2abb26d8fcfb554efdffac55e2257cfbbb1442cf6245163a856cb0e75b3e37d182a5491df66a41f482ea8a40dc924f1102f5b4852"}
05:50:07 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
05:50:07 INFO - Writing to file C:\slave\test\properties\blobber_files
05:50:07 INFO - Contents:
05:50:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cac475d9dcf8e03549e5351658a8dea99b88f13fdcd945d42dca0ea4c905237d1b60c3adcecff79b523663548660c0c665e37ee1be08189c4e90872f4974f5ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bd048aceff0cc635c89ce984a2d6405c0fe9a9597138859251199b6a813f0a69e216e0b11ed6c0465f8e5515d2e523d75dc64ed20eeff59a31b1133cac2dfb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94342ef96df21a270aa10cb2abb26d8fcfb554efdffac55e2257cfbbb1442cf6245163a856cb0e75b3e37d182a5491df66a41f482ea8a40dc924f1102f5b4852"}
05:50:07 INFO - Running post-run listener: copy_logs_to_upload_dir
05:50:07 INFO - Copying logs to upload dir...
05:50:07 INFO - mkdir: C:\slave\test\build\upload\logs
05:50:07 INFO - Copying logs to upload dir...
05:50:07 INFO - Using _rmtree_windows ...
05:50:07 INFO - Using _rmtree_windows ...
05:50:07 INFO - Using _rmtree_windows ...
05:50:07 INFO - Using _rmtree_windows ...
05:50:07 INFO - Using _rmtree_windows ...
05:50:07 INFO - Using _rmtree_windows ...
05:50:07 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1418.434000
========= master_lag: -0.18 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 38 secs) (at 2017-01-24 05:50:07.725884) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 05:50:07.726655) =========
'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-224\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-224
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-224
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-224\AppData\Local
LOGONSERVER=\\T-W864-IX-224
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-224
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-224
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-224
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cac475d9dcf8e03549e5351658a8dea99b88f13fdcd945d42dca0ea4c905237d1b60c3adcecff79b523663548660c0c665e37ee1be08189c4e90872f4974f5ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bd048aceff0cc635c89ce984a2d6405c0fe9a9597138859251199b6a813f0a69e216e0b11ed6c0465f8e5515d2e523d75dc64ed20eeff59a31b1133cac2dfb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94342ef96df21a270aa10cb2abb26d8fcfb554efdffac55e2257cfbbb1442cf6245163a856cb0e75b3e37d182a5491df66a41f482ea8a40dc924f1102f5b4852"}
build_url:https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.102000
build_url: 'https://queue.taskcluster.net/v1/task/VdRz1zD6TnSb_kYPTob2Tw/artifacts/public/build/firefox-52.0.en-US.win64.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cac475d9dcf8e03549e5351658a8dea99b88f13fdcd945d42dca0ea4c905237d1b60c3adcecff79b523663548660c0c665e37ee1be08189c4e90872f4974f5ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bd048aceff0cc635c89ce984a2d6405c0fe9a9597138859251199b6a813f0a69e216e0b11ed6c0465f8e5515d2e523d75dc64ed20eeff59a31b1133cac2dfb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94342ef96df21a270aa10cb2abb26d8fcfb554efdffac55e2257cfbbb1442cf6245163a856cb0e75b3e37d182a5491df66a41f482ea8a40dc924f1102f5b4852"}'
========= master_lag: 0.03 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 05:50:07.853691) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:50:07.854022) =========
'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-224\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-224
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-224
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-224\AppData\Local
LOGONSERVER=\\T-W864-IX-224
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-224
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-224
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-224
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 2017-01-24 05:50:07.976319) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-01-24 05:50:07.976648) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-01-24 05:50:08.679142) =========
========= Total master_lag: 0.02 =========