builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0054 starttime: 1457789405.32 results: success (0) buildid: 20160312044030 builduid: db5959ef006c47a2a1db3a933e596727 revision: 31481f9ebdda792e0ec01d8a007de8b193bc206f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.321905) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.322327) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.322619) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005711 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.429397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.429718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.666723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.667148) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005358 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.751295) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.751773) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.752150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.752437) ========= 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 /builds/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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-12 05:30:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-03-12 05:30:05 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142717 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.938330) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.938617) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019950 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:06.040875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-12 05:30:06.041201) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 31481f9ebdda792e0ec01d8a007de8b193bc206f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 31481f9ebdda792e0ec01d8a007de8b193bc206f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-12 05:30:06,123 truncating revision to first 12 chars 2016-03-12 05:30:06,124 Setting DEBUG logging. 2016-03-12 05:30:06,124 attempt 1/10 2016-03-12 05:30:06,124 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/31481f9ebdda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 05:30:07,463 unpacking tar archive at: mozilla-central-31481f9ebdda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590173 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-12 05:30:07.664917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.665245) ========= echo 31481f9ebdda792e0ec01d8a007de8b193bc206f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'31481f9ebdda792e0ec01d8a007de8b193bc206f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 31481f9ebdda792e0ec01d8a007de8b193bc206f program finished with exit code 0 elapsedTime=0.005169 script_repo_revision: '31481f9ebdda792e0ec01d8a007de8b193bc206f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.721117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.721407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.735869) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-03-12 05:30:07.736176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:30:07 INFO - MultiFileLogger online at 20160312 05:30:07 in /builds/slave/test 05:30:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:30:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:30:07 INFO - {'append_to_log': False, 05:30:07 INFO - 'base_work_dir': '/builds/slave/test', 05:30:07 INFO - 'blob_upload_branch': 'Firefox', 05:30:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:30:07 INFO - 'branch': 'Firefox', 05:30:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:07 INFO - 'config_files': ('talos/mac_config.py',), 05:30:07 INFO - 'default_actions': ('clobber', 05:30:07 INFO - 'read-buildbot-config', 05:30:07 INFO - 'download-and-extract', 05:30:07 INFO - 'populate-webroot', 05:30:07 INFO - 'create-virtualenv', 05:30:07 INFO - 'install', 05:30:07 INFO - 'run-tests'), 05:30:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:07 INFO - 'download_minidump_stackwalk': True, 05:30:07 INFO - 'download_symbols': 'ondemand', 05:30:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:07 INFO - 'installer_path': 'installer.exe', 05:30:07 INFO - 'log_level': 'info', 05:30:07 INFO - 'log_name': 'talos', 05:30:07 INFO - 'log_to_console': True, 05:30:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:30:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:30:07 INFO - 'opt_config_files': (), 05:30:07 INFO - 'pip_index': False, 05:30:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:07 INFO - 'cmd': ('bash', 05:30:07 INFO - '-c', 05:30:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:07 INFO - 'enabled': True, 05:30:07 INFO - 'halt_on_failure': False, 05:30:07 INFO - 'name': 'check_screen_resolution'},), 05:30:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:07 INFO - 'cmd': ('bash', 05:30:07 INFO - '-c', 05:30:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:07 INFO - 'enabled': True, 05:30:07 INFO - 'halt_on_failure': False, 05:30:07 INFO - 'name': 'check_screen_resolution'},), 05:30:07 INFO - 'run_cmd_checks_enabled': True, 05:30:07 INFO - 'sps_profile': False, 05:30:07 INFO - 'sps_profile_interval': 0, 05:30:07 INFO - 'suite': 'dromaeojs', 05:30:07 INFO - 'system_bits': '32', 05:30:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:07 INFO - 'title': 't-yosemite-r7-0054', 05:30:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:07 INFO - 'use_talos_json': True, 05:30:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:30:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:07 INFO - 'work_dir': 'build'} 05:30:07 INFO - ##### 05:30:07 INFO - ##### Running clobber step. 05:30:07 INFO - ##### 05:30:07 INFO - Running pre-action listener: _resource_record_pre_action 05:30:07 INFO - Running main action method: clobber 05:30:07 INFO - rmtree: /builds/slave/test/build 05:30:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:30:09 INFO - Running post-action listener: _resource_record_post_action 05:30:09 INFO - ##### 05:30:09 INFO - ##### Running read-buildbot-config step. 05:30:09 INFO - ##### 05:30:09 INFO - Running pre-action listener: _resource_record_pre_action 05:30:09 INFO - Running main action method: read_buildbot_config 05:30:09 INFO - Using buildbot properties: 05:30:09 INFO - { 05:30:09 INFO - "project": "", 05:30:09 INFO - "product": "firefox", 05:30:09 INFO - "script_repo_revision": "production", 05:30:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:30:09 INFO - "repository": "", 05:30:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:30:09 INFO - "buildid": "20160312044030", 05:30:09 INFO - "pgo_build": "False", 05:30:09 INFO - "basedir": "/builds/slave/test", 05:30:09 INFO - "buildnumber": 169, 05:30:09 INFO - "slavename": "t-yosemite-r7-0054", 05:30:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:30:09 INFO - "platform": "yosemite_r7", 05:30:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:30:09 INFO - "branch": "mozilla-central", 05:30:09 INFO - "repo_path": "mozilla-central", 05:30:09 INFO - "revision": "31481f9ebdda792e0ec01d8a007de8b193bc206f", 05:30:09 INFO - "stage_platform": "macosx64", 05:30:09 INFO - "builduid": "db5959ef006c47a2a1db3a933e596727", 05:30:09 INFO - "slavebuilddir": "test" 05:30:09 INFO - } 05:30:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:30:09 INFO - Running post-action listener: _resource_record_post_action 05:30:09 INFO - ##### 05:30:09 INFO - ##### Running download-and-extract step. 05:30:09 INFO - ##### 05:30:09 INFO - Running pre-action listener: _resource_record_pre_action 05:30:09 INFO - Running main action method: download_and_extract 05:30:09 INFO - mkdir: /builds/slave/test/build/tests 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:09 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:30:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:30:26 INFO - Downloaded 1199 bytes. 05:30:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:26 INFO - Using the following test package requirements: 05:30:26 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:30:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:30:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:30:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'jsshell-mac.zip'], 05:30:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:30:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:30:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:30:26 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:30:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:30:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:26 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:30:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:26 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:39 INFO - Downloaded 17864979 bytes. 05:30:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:42 INFO - Return code: 0 05:30:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:42 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:53 INFO - Downloaded 17864979 bytes. 05:30:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:57 INFO - Return code: 0 05:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:57 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:30:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:30:58 INFO - Downloaded 10845263 bytes. 05:30:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:30:58 INFO - Return code: 0 05:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:58 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:30:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:30:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:31:06 INFO - Downloaded 111023981 bytes. 05:31:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:06 INFO - mkdir: /builds/slave/test/properties 05:31:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:06 INFO - Contents: 05:31:06 INFO - build_url:https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:07 INFO - Running post-action listener: _resource_record_post_action 05:31:07 INFO - Running post-action listener: set_extra_try_arguments 05:31:07 INFO - ##### 05:31:07 INFO - ##### Running populate-webroot step. 05:31:07 INFO - ##### 05:31:07 INFO - Running pre-action listener: _resource_record_pre_action 05:31:07 INFO - Running main action method: populate_webroot 05:31:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:07 INFO - '--tppagecycles', 05:31:07 INFO - '7'], 05:31:07 INFO - 'tests': ['tsvgm']}}, 05:31:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:31:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:31:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'tests': ['damp', 'tps']}, 05:31:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['damp', 'tps']}, 05:31:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:31:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:07 INFO - 'other': {'tests': ['a11yr', 05:31:07 INFO - 'ts_paint', 05:31:07 INFO - 'tpaint', 05:31:07 INFO - 'sessionrestore', 05:31:07 INFO - 'sessionrestore_no_auto_restore', 05:31:07 INFO - 'tabpaint']}, 05:31:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['a11yr', 05:31:07 INFO - 'ts_paint', 05:31:07 INFO - 'tpaint', 05:31:07 INFO - 'sessionrestore', 05:31:07 INFO - 'sessionrestore_no_auto_restore', 05:31:07 INFO - 'tabpaint']}, 05:31:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['a11yr', 05:31:07 INFO - 'ts_paint', 05:31:07 INFO - 'tpaint', 05:31:07 INFO - 'sessionrestore', 05:31:07 INFO - 'sessionrestore_no_auto_restore', 05:31:07 INFO - 'tabpaint']}, 05:31:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['a11yr', 05:31:07 INFO - 'ts_paint', 05:31:07 INFO - 'tpaint', 05:31:07 INFO - 'sessionrestore', 05:31:07 INFO - 'sessionrestore_no_auto_restore', 05:31:07 INFO - 'tabpaint']}, 05:31:07 INFO - 'other_l64': {'tests': ['a11yr', 05:31:07 INFO - 'ts_paint', 05:31:07 INFO - 'tpaint', 05:31:07 INFO - 'sessionrestore', 05:31:07 INFO - 'sessionrestore_no_auto_restore', 05:31:07 INFO - 'tabpaint']}, 05:31:07 INFO - 'other_nol64': {'tests': ['a11yr', 05:31:07 INFO - 'ts_paint', 05:31:07 INFO - 'tpaint', 05:31:07 INFO - 'sessionrestore', 05:31:07 INFO - 'sessionrestore_no_auto_restore', 05:31:07 INFO - 'tabpaint']}, 05:31:07 INFO - 'svgr': {'tests': ['tsvgx', 05:31:07 INFO - 'tsvgr_opacity', 05:31:07 INFO - 'tart', 05:31:07 INFO - 'tscrollx', 05:31:07 INFO - 'cart']}, 05:31:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['tsvgx', 05:31:07 INFO - 'tsvgr_opacity', 05:31:07 INFO - 'tart', 05:31:07 INFO - 'tscrollx', 05:31:07 INFO - 'cart']}, 05:31:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'tests': ['tp5o']}, 05:31:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'talos_options': ['--e10s'], 05:31:07 INFO - 'tests': ['tp5o']}, 05:31:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'talos_options': ['--xperf_path', 05:31:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:07 INFO - 'tests': ['tp5n']}, 05:31:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:07 INFO - 'talos_options': ['--e10s', 05:31:07 INFO - '--xperf_path', 05:31:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:07 INFO - 'tests': ['tp5n']}}, 05:31:07 INFO - 'talos.zip': {'path': '', 05:31:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:07 INFO - Running post-action listener: _resource_record_post_action 05:31:07 INFO - ##### 05:31:07 INFO - ##### Running create-virtualenv step. 05:31:07 INFO - ##### 05:31:07 INFO - Running pre-action listener: _resource_record_pre_action 05:31:07 INFO - Running main action method: create_virtualenv 05:31:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:31:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:07 INFO - Using real prefix '/tools/python27' 05:31:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:11 INFO - Installing pip.................done. 05:31:11 INFO - Return code: 0 05:31:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:31:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:11 INFO - 'HOME': '/Users/cltbld', 05:31:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:11 INFO - 'LOGNAME': 'cltbld', 05:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:11 INFO - 'MOZ_NO_REMOTE': '1', 05:31:11 INFO - 'NO_EM_RESTART': '1', 05:31:11 INFO - 'PAGER': '/bin/cat', 05:31:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:11 INFO - 'PWD': '/builds/slave/test', 05:31:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:11 INFO - 'SHELL': '/bin/bash', 05:31:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:11 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:11 INFO - 'USER': 'cltbld', 05:31:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:11 INFO - 'XPC_FLAGS': '0x0', 05:31:11 INFO - 'XPC_SERVICE_NAME': '0', 05:31:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:31:11 INFO - Cleaning up... 05:31:11 INFO - Return code: 0 05:31:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:31:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:11 INFO - 'HOME': '/Users/cltbld', 05:31:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:11 INFO - 'LOGNAME': 'cltbld', 05:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:11 INFO - 'MOZ_NO_REMOTE': '1', 05:31:11 INFO - 'NO_EM_RESTART': '1', 05:31:11 INFO - 'PAGER': '/bin/cat', 05:31:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:11 INFO - 'PWD': '/builds/slave/test', 05:31:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:11 INFO - 'SHELL': '/bin/bash', 05:31:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:11 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:11 INFO - 'USER': 'cltbld', 05:31:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:11 INFO - 'XPC_FLAGS': '0x0', 05:31:11 INFO - 'XPC_SERVICE_NAME': '0', 05:31:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:11 INFO - Downloading/unpacking psutil>=0.7.1 05:31:11 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:31:11 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:31:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:11 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:31:11 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:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:15 INFO - Installing collected packages: psutil 05:31:15 INFO - Running setup.py install for psutil 05:31:15 INFO - building 'psutil._psutil_osx' extension 05:31:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:31:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:31:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:31:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:31:15 INFO - building 'psutil._psutil_posix' extension 05:31:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:31:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:31:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:31:15 INFO - ^ 05:31:15 INFO - 1 warning generated. 05:31:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:16 INFO - Successfully installed psutil 05:31:16 INFO - Cleaning up... 05:31:16 INFO - Return code: 0 05:31:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:31:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:16 INFO - 'HOME': '/Users/cltbld', 05:31:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:16 INFO - 'LOGNAME': 'cltbld', 05:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:16 INFO - 'MOZ_NO_REMOTE': '1', 05:31:16 INFO - 'NO_EM_RESTART': '1', 05:31:16 INFO - 'PAGER': '/bin/cat', 05:31:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:16 INFO - 'PWD': '/builds/slave/test', 05:31:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:16 INFO - 'SHELL': '/bin/bash', 05:31:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:16 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:16 INFO - 'USER': 'cltbld', 05:31:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:16 INFO - 'XPC_FLAGS': '0x0', 05:31:16 INFO - 'XPC_SERVICE_NAME': '0', 05:31:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:31:16 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:31:16 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:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:16 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:31:16 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:31:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:31:18 INFO - Installing collected packages: mozsystemmonitor 05:31:18 INFO - Running setup.py install for mozsystemmonitor 05:31:18 INFO - Successfully installed mozsystemmonitor 05:31:18 INFO - Cleaning up... 05:31:19 INFO - Return code: 0 05:31:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:19 INFO - 'HOME': '/Users/cltbld', 05:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:19 INFO - 'LOGNAME': 'cltbld', 05:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:19 INFO - 'MOZ_NO_REMOTE': '1', 05:31:19 INFO - 'NO_EM_RESTART': '1', 05:31:19 INFO - 'PAGER': '/bin/cat', 05:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:19 INFO - 'PWD': '/builds/slave/test', 05:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:19 INFO - 'SHELL': '/bin/bash', 05:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:19 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:19 INFO - 'USER': 'cltbld', 05:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:19 INFO - 'XPC_FLAGS': '0x0', 05:31:19 INFO - 'XPC_SERVICE_NAME': '0', 05:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:19 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:31:19 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:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:19 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:31:19 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:31:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31:21 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:31:21 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:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:21 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:31:21 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:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:31:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:22 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:31:22 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:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:22 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:31:22 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:31:22 INFO - Downloading docopt-0.6.1.tar.gz 05:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:31:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:31:22 INFO - Running setup.py install for blobuploader 05:31:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:31:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:31:23 INFO - Running setup.py install for requests 05:31:23 INFO - Running setup.py install for docopt 05:31:23 INFO - Successfully installed blobuploader requests docopt 05:31:23 INFO - Cleaning up... 05:31:23 INFO - Return code: 0 05:31:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:23 INFO - 'HOME': '/Users/cltbld', 05:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:23 INFO - 'LOGNAME': 'cltbld', 05:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:23 INFO - 'MOZ_NO_REMOTE': '1', 05:31:23 INFO - 'NO_EM_RESTART': '1', 05:31:23 INFO - 'PAGER': '/bin/cat', 05:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:23 INFO - 'PWD': '/builds/slave/test', 05:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:23 INFO - 'SHELL': '/bin/bash', 05:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:23 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:23 INFO - 'USER': 'cltbld', 05:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:23 INFO - 'XPC_FLAGS': '0x0', 05:31:23 INFO - 'XPC_SERVICE_NAME': '0', 05:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-es5jrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-N1wTlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-I_v75z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-XxhKKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-V3lBO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-PrxWzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-aoLK_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-pUu086-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:24 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zjG0dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-IvqoP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-XwmvUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-q7NSHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-AhYNZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zDB9NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-UgDsfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-NHxWjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-_4oLbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:25 INFO - Running setup.py install for manifestparser 05:31:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:31:26 INFO - Running setup.py install for mozcrash 05:31:26 INFO - Running setup.py install for mozdebug 05:31:26 INFO - Running setup.py install for mozdevice 05:31:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:31:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:31:26 INFO - Running setup.py install for mozfile 05:31:26 INFO - Running setup.py install for mozhttpd 05:31:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:31:26 INFO - Running setup.py install for mozinfo 05:31:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:31:26 INFO - Running setup.py install for mozInstall 05:31:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Running setup.py install for mozleak 05:31:27 INFO - Running setup.py install for mozlog 05:31:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Running setup.py install for moznetwork 05:31:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Running setup.py install for mozprocess 05:31:27 INFO - Running setup.py install for mozprofile 05:31:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:31:27 INFO - Running setup.py install for mozrunner 05:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:31:28 INFO - Running setup.py install for mozscreenshot 05:31:28 INFO - Running setup.py install for moztest 05:31:28 INFO - Running setup.py install for mozversion 05:31:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:31:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:28 INFO - Cleaning up... 05:31:28 INFO - Return code: 0 05:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:28 INFO - 'HOME': '/Users/cltbld', 05:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:28 INFO - 'LOGNAME': 'cltbld', 05:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:28 INFO - 'MOZ_NO_REMOTE': '1', 05:31:28 INFO - 'NO_EM_RESTART': '1', 05:31:28 INFO - 'PAGER': '/bin/cat', 05:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:28 INFO - 'PWD': '/builds/slave/test', 05:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:28 INFO - 'SHELL': '/bin/bash', 05:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:28 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:28 INFO - 'USER': 'cltbld', 05:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:28 INFO - 'XPC_FLAGS': '0x0', 05:31:28 INFO - 'XPC_SERVICE_NAME': '0', 05:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:28 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-pWk5T9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:28 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-V7Kek0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:28 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-ZC1taI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-O868q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-1tirv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-XLBVEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-jkv8m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-z4GC8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-eVlIqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-eZsYBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Mfn9Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:29 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SnkiZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:30 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-N9_JUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:30 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Wcd_mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:30 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-nN5J9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:30 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-TvZmJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:30 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-pwBa6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:32 INFO - Downloading blessings-1.6.tar.gz 05:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:33 INFO - Installing collected packages: blessings 05:31:33 INFO - Running setup.py install for blessings 05:31:33 INFO - Successfully installed blessings 05:31:33 INFO - Cleaning up... 05:31:33 INFO - Return code: 0 05:31:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:33 INFO - Reading from file tmpfile_stdout 05:31:33 INFO - Current package versions: 05:31:33 INFO - blessings == 1.6 05:31:33 INFO - blobuploader == 1.2.4 05:31:33 INFO - docopt == 0.6.1 05:31:33 INFO - manifestparser == 1.1 05:31:33 INFO - mozInstall == 1.12 05:31:33 INFO - mozcrash == 0.17 05:31:33 INFO - mozdebug == 0.1 05:31:33 INFO - mozdevice == 0.48 05:31:33 INFO - mozfile == 1.2 05:31:33 INFO - mozhttpd == 0.7 05:31:33 INFO - mozinfo == 0.9 05:31:33 INFO - mozleak == 0.1 05:31:33 INFO - mozlog == 3.1 05:31:33 INFO - moznetwork == 0.27 05:31:33 INFO - mozprocess == 0.22 05:31:33 INFO - mozprofile == 0.28 05:31:33 INFO - mozrunner == 6.11 05:31:33 INFO - mozscreenshot == 0.1 05:31:33 INFO - mozsystemmonitor == 0.0 05:31:33 INFO - moztest == 0.7 05:31:33 INFO - mozversion == 1.4 05:31:33 INFO - psutil == 3.1.1 05:31:33 INFO - requests == 1.2.3 05:31:33 INFO - wsgiref == 0.1.2 05:31:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:33 INFO - 'HOME': '/Users/cltbld', 05:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:33 INFO - 'LOGNAME': 'cltbld', 05:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:33 INFO - 'MOZ_NO_REMOTE': '1', 05:31:33 INFO - 'NO_EM_RESTART': '1', 05:31:33 INFO - 'PAGER': '/bin/cat', 05:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:33 INFO - 'PWD': '/builds/slave/test', 05:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:33 INFO - 'SHELL': '/bin/bash', 05:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:33 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:33 INFO - 'USER': 'cltbld', 05:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:33 INFO - 'XPC_FLAGS': '0x0', 05:31:33 INFO - 'XPC_SERVICE_NAME': '0', 05:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:31:33 INFO - Cleaning up... 05:31:33 INFO - Return code: 0 05:31:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:33 INFO - 'HOME': '/Users/cltbld', 05:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:33 INFO - 'LOGNAME': 'cltbld', 05:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:33 INFO - 'MOZ_NO_REMOTE': '1', 05:31:33 INFO - 'NO_EM_RESTART': '1', 05:31:33 INFO - 'PAGER': '/bin/cat', 05:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:33 INFO - 'PWD': '/builds/slave/test', 05:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:33 INFO - 'SHELL': '/bin/bash', 05:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:33 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:33 INFO - 'USER': 'cltbld', 05:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:33 INFO - 'XPC_FLAGS': '0x0', 05:31:33 INFO - 'XPC_SERVICE_NAME': '0', 05:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:34 INFO - Downloading/unpacking jsonschema 05:31:34 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:31:34 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:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:34 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:31:34 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:31:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:36 INFO - Downloading/unpacking functools32 (from jsonschema) 05:31:36 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:31:36 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:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:36 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:31:36 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:31:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:36 INFO - warning: no files found matching '*.txt' 05:31:36 INFO - no previously-included directories found matching 'build' 05:31:36 INFO - no previously-included directories found matching 'dist' 05:31:36 INFO - no previously-included directories found matching '.git*' 05:31:36 INFO - Installing collected packages: jsonschema, functools32 05:31:37 INFO - Running setup.py install for functools32 05:31:37 INFO - warning: no files found matching '*.txt' 05:31:37 INFO - no previously-included directories found matching 'build' 05:31:37 INFO - no previously-included directories found matching 'dist' 05:31:37 INFO - no previously-included directories found matching '.git*' 05:31:37 INFO - Successfully installed jsonschema functools32 05:31:37 INFO - Cleaning up... 05:31:37 INFO - Return code: 0 05:31:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10349da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9509d745a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:37 INFO - 'HOME': '/Users/cltbld', 05:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:37 INFO - 'LOGNAME': 'cltbld', 05:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:37 INFO - 'MOZ_NO_REMOTE': '1', 05:31:37 INFO - 'NO_EM_RESTART': '1', 05:31:37 INFO - 'PAGER': '/bin/cat', 05:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:37 INFO - 'PWD': '/builds/slave/test', 05:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:37 INFO - 'SHELL': '/bin/bash', 05:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:31:37 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:37 INFO - 'USER': 'cltbld', 05:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:37 INFO - 'XPC_FLAGS': '0x0', 05:31:37 INFO - 'XPC_SERVICE_NAME': '0', 05:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:37 INFO - Downloading/unpacking flake8 05:31:37 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:31:37 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:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:37 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:31:37 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:31:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:31:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:31: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:31: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:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31: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:31: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:31:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:31:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:31:40 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:31:40 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:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 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:31:40 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:31:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:31:40 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:31:40 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:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 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:31:40 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:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:31:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:41 INFO - no previously-included directories found matching 'docs/_build' 05:31:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:31:41 INFO - Running setup.py install for pep8 05:31:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:41 INFO - no previously-included directories found matching 'docs/_build' 05:31:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:31:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:31:41 INFO - Cleaning up... 05:31:41 INFO - Return code: 0 05:31:41 INFO - Running post-action listener: _resource_record_post_action 05:31:41 INFO - Running post-action listener: _start_resource_monitoring 05:31:41 INFO - Starting resource monitoring. 05:31:41 INFO - ##### 05:31:41 INFO - ##### Running install step. 05:31:41 INFO - ##### 05:31:41 INFO - Running pre-action listener: _resource_record_pre_action 05:31:41 INFO - Running main action method: install 05:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:41 INFO - Reading from file tmpfile_stdout 05:31:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:31:41 INFO - Reading from file tmpfile_stdout 05:31:41 INFO - Output received: 05:31:41 INFO - Usage: mozinstall [options] installer 05:31:41 INFO - Options: 05:31:41 INFO - -h, --help show this help message and exit 05:31:41 INFO - -d DEST, --destination=DEST 05:31:41 INFO - Directory to install application into. [default: 05:31:41 INFO - "/builds/slave/test"] 05:31:41 INFO - --app=APP Application being installed. [default: firefox] 05:31:41 INFO - mkdir: /builds/slave/test/build/application 05:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:32:15 INFO - Reading from file tmpfile_stdout 05:32:15 INFO - Output received: 05:32:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:32:15 INFO - Running post-action listener: _resource_record_post_action 05:32:15 INFO - ##### 05:32:15 INFO - ##### Running run-tests step. 05:32:15 INFO - ##### 05:32:15 INFO - Running pre-action listener: _resource_record_pre_action 05:32:15 INFO - Running main action method: run_tests 05:32:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:32:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:32:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:32:15 INFO - 2016-03-12 05:32:15.886 screenresolution[1973:16703] starting screenresolution argv=screenresolution get 05:32:15 INFO - 2016-03-12 05:32:15.889 screenresolution[1973:16703] Display 0: 1600x1200x32@60 05:32:15 INFO - 2016-03-12 05:32:15.895 screenresolution[1974:16705] starting screenresolution argv=screenresolution list 05:32:15 INFO - Available Modes on Display 0 05:32:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:32:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:32:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:32:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:32:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:32:16 INFO - Intel Iris: 05:32:16 INFO - Chipset Model: Intel Iris 05:32:16 INFO - Type: GPU 05:32:16 INFO - Bus: Built-In 05:32:16 INFO - VRAM (Dynamic, Max): 1536 MB 05:32:16 INFO - Vendor: Intel (0x8086) 05:32:16 INFO - Device ID: 0x0a2e 05:32:16 INFO - Revision ID: 0x0009 05:32:16 INFO - Displays: 05:32:16 INFO - Display: 05:32:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:32:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:32:16 INFO - Display Serial Number: 1600x1200 60 05:32:16 INFO - Main Display: Yes 05:32:16 INFO - Mirror: Off 05:32:16 INFO - Online: Yes 05:32:16 INFO - Rotation: Supported 05:32:16 INFO - Return code: 0 05:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:16 INFO - Python 2.7.3 05:32:16 INFO - Return code: 0 05:32:16 INFO - grabbing minidump binary from tooltool 05:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103341d30>, '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 0x103165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:32:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:32:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:16 INFO - Return code: 0 05:32:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:32:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:32:17 INFO - Return code: 0 05:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WC2SRpnTpL/Render', 05:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:17 INFO - 'HOME': '/Users/cltbld', 05:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:17 INFO - 'LOGNAME': 'cltbld', 05:32:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:17 INFO - 'MOZ_NO_REMOTE': '1', 05:32:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:17 INFO - 'NO_EM_RESTART': '1', 05:32:17 INFO - 'PAGER': '/bin/cat', 05:32:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:17 INFO - 'PWD': '/builds/slave/test', 05:32:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:17 INFO - 'SHELL': '/bin/bash', 05:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners', 05:32:17 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 05:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:17 INFO - 'USER': 'cltbld', 05:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:17 INFO - 'XPC_FLAGS': '0x0', 05:32:17 INFO - 'XPC_SERVICE_NAME': '0', 05:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:32:17 INFO - mozversion application_buildid: 20160312044030 05:32:17 INFO - mozversion application_changeset: 31481f9ebdda792e0ec01d8a007de8b193bc206f 05:32:17 INFO - mozversion application_display_name: Nightly 05:32:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:17 INFO - mozversion application_name: Firefox 05:32:17 INFO - mozversion application_remotingname: firefox 05:32:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:32:17 INFO - mozversion application_vendor: Mozilla 05:32:17 INFO - mozversion application_version: 48.0a1 05:32:17 INFO - mozversion platform_buildid: 20160312044030 05:32:17 INFO - mozversion platform_changeset: 31481f9ebdda792e0ec01d8a007de8b193bc206f 05:32:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:32:17 INFO - mozversion platform_version: 48.0a1 05:32:17 INFO - using testdate: 1457789537 05:32:17 INFO - actual date: 1457789537 05:32:17 INFO - starting webserver on 'localhost:49583' 05:32:17 INFO - SUITE-START | Running 2 tests 05:32:17 INFO - TEST-START | dromaeo_css 05:32:17 INFO - operating with platform_type : mac_ 05:32:17 INFO - Initialising browser for dromaeo_css test... 05:32:17 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpe_DScR/profile http://localhost:49583/getInfo.html) 05:32:19 INFO - PROCESS | 1992 | __metrics Screen width/height:1600/1200 05:32:19 INFO - PROCESS | 1992 | colorDepth:24 05:32:19 INFO - PROCESS | 1992 | Browser inner width/height: 1024/689 05:32:19 INFO - PROCESS | 1992 | __metrics 05:32:20 INFO - PROCESS | 1992 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:32:20 ERROR - PROCESS | 1992 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:32:20 INFO - TEST-INFO | 1992: exit 0 05:32:20 INFO - Browser initialized. 05:32:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:20 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpe_DScR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:32 INFO - PROCESS | 1995 | RSS: Main: 243388416 05:32:32 INFO - PROCESS | 1995 | 05:33:23 INFO - PROCESS | 1995 | 1457789603665 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:35:33 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49583/tests/dromaeo/cssquery-ext.html) 05:35:35 INFO - PROCESS | 1995 | RSS: Main: 402792448 05:35:35 INFO - PROCESS | 1995 | 05:38:37 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-ext.html (next: http://localhost:49583/tests/dromaeo/cssquery-jquery.html) 05:38:38 INFO - PROCESS | 1995 | RSS: Main: 379023360 05:38:38 INFO - PROCESS | 1995 | 05:41:40 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49583/tests/dromaeo/cssquery-mootools.html) 05:41:41 INFO - PROCESS | 1995 | RSS: Main: 375558144 05:41:41 INFO - PROCESS | 1995 | 05:44:43 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49583/tests/dromaeo/cssquery-prototype.html) 05:44:43 INFO - PROCESS | 1995 | RSS: Main: 336691200 05:44:43 INFO - PROCESS | 1995 | 05:47:46 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49583/tests/dromaeo/cssquery-yui.html) 05:47:47 INFO - PROCESS | 1995 | RSS: Main: 338194432 05:47:47 INFO - PROCESS | 1995 | 05:50:49 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-yui.html (next: http://localhost:49583/tests/dromaeo/cssquery-dojo.html) 05:50:50 INFO - PROCESS | 1995 | RSS: Main: 404557824 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | __start_tp_report 05:50:50 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 05:50:50 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 05:50:50 INFO - PROCESS | 1995 | |i|pagename|runs| 05:50:50 INFO - PROCESS | 1995 | |0;dojo.html;3122.484790009648;3311.817850018249;3419.9487007694875;3448.0862571418593;3492.930141397172;4604.677672562918;5439.5920305977115;5523.972380138103;5536.667799932007;5555;5433.26650902129;5483.177523371496;5521.972390138044;5533.474319939599;5550;4977.07924034053;4986.152354099793;4994.051130285252;5067.239914012909;5073.670211436245;5007.2489126630935;5063.063333283336;5063.316452278932;5075.9746201268945;5090;4980.153373926423;5017.473165317644;5030.899382012376;5048.596112311006;5068.138416469191;5055.898882022358;5112.36095488064;5120.820771273025;5138.203578445347;5190.948090519103;4906.901861962777;4950.7029578225065;5051.116054690415;5055.747212639353;5066.569341605968;5407.080796264644;5454.781808727646;5467.17992301158;5467.535259502947;5567;6025.397460253984;6043.758249670052;6058.878822423571;6062.181605483247;6076.817695469099;6010.669413182273;6012.248468941382;6163.414475624809;6169.907451388232;6172.4136207060255;5638.548916086745;5643.661380317194;5658.207850900877;5680.4319568043275;5699.401562835926;6203.937960620427;6257.56197066201;6270.843228919313;6285.779997700059;6287.528435367274;5750.02249617566;5901.970490147608;5945.078512830518;5997.820065398045;6065.999110146777;6083.939160608337;6085.6348619083;6086.391360863879;6094.238220222473;6104.4200800923845;5514.420985796514;5819.476247137778;5926.762929482858;5980.671063091485;5981.581289309794;5913.935491611465;6023.6385816851125;6113.202667687823;6125.907024958145;6138.202033735586;4772.546608072227;4774.427068751772;4784.760761961888;4805.8558243252755;4820;4225.9788701056295;4305.31115021595;4318.050028993616;4331.480222373272;4374.62815660666;5424.05079111154;5440;5482.80810171642;5490.588205884575;5492.450754924475;6069;6078.3921607838865;6082.270127584629;6091.482224011009;6091.5735898487565;5461.0716178249795;5497.120460726344;5498;5506.779728810883;5508.531774799187;5214.113600687816;5234.633575649668;5267.104592219332;5283.815066472655;5290.047791397586;6246.937530624727;6275.058741188767;6314.0844577536;6323.27282362525;6330.335314791972;6133;6136.877262454636;6169.259688837368;6170.259568851767;6190.783322583688;6118.010103775157;6219.253689557101;6312.84217894538;6315.621062736251;6344.555881088464;6003.7898673546215;6007.459328660441;6009.579329446897;6034.63792172471;6053.939460605337;6112.877742445037;6120.3267640558615;6136.539759518143;6159.384061593805;6166.660833654192;5765.106408506688;5880.206172166702;5908.409159084057;5927.288725352985;6043.3050199227655;5927.822165334875;5938.317093534126;5938.376470470538;5949.434803693643;5953.374895636069;5615.157726341082;5802.622829516068;5807.970960145172;5814.534837212928;5815.709214539341;5778.653280803165;5819.592628515963;5832.708364581838;5892.440218179266;5895.174675545341;5690.2887139107615;5717.514011309086;5731.656100633975;5739.684317362585;5742.109972954198 05:50:50 INFO - PROCESS | 1995 | |1;ext.html;538.3889285660774;558.059669456965;576.9240366716073;621.2296752027485;633.762339122829;29149.562756558644;36811.447828282595;37247.813760931225;37418.43872341917;37437.81281093591;33238.670453181905;39730.801345993226;40335.79832100843;40356.19287614246;40582.59417405825;7566.810829729259;9573.090556397132;9573.329866909318;9579.80840383192;9590.280728945358;9390.671326503574;9577.760555986086;9588;9590.664326748565;9707.077827606401;8749.693760718375;9436.103570160823;9647.855282170773;9746.171575416063;9748.463834489101;9637.61449542021;9686;9712.3201375903;9742.366746161477;9764.656482444234;9499.715008549685;9653.469059201741;9654;9656.662016829378;9661.806763864754;39246.803765980985;39617.80191099055;39697;39706;39718.20563588741;3171.841407929617;3183.9681603183903;3350.5141754445467;3535.876244331436;3788.3749181385037;28102;28130.015449459377;28194.85902570474;28715.994940177203;28776.71223287782;2643.616675582049;2671.9332016699736;2746.4644394343113;2772.7781777457753;2834.603155558203;489065;490871.5456422695;492421;492841;493725;63215.73568528604;63236;63369.683151583944;63595.36404635895;63603.6819815898;68681;69737.3026269741;69776.65111674409;69787.65106174437;70011.29988700048;16199.271032803552;16247.918760406123;16443.506694798936;16465.753013704805;16475.423360182336;12607.684807879876;12694.365281735876;12710.936445317715;12713.745725085631;12726.618201453972;19963.900180499004;20630;20666;20678.276260331117;20807.58384832295;8845.203931646183;9029;9052.004279529247;9058.184763371328;9160.587773550205;829.8049958259804;932.4591736792644;947.0907928388687;958.4441024205944;1174.2074099982478;28565.714342856307;29031.41937161245;29268.41463170725;29437.852810736236;29820.701792982225;972.2125078686287;1022.8056669232822;1065.9147268218524;1106.1427393769732;1144.7767685301453;14595.343209555596;14779.40662827936;14793.92603036978;14915.925420372829;15268.465603703817;451540;456759;460717;462103;462916;57502.424975750546;57881.13178302329;58027.41972580305;58081;58127.70936145292;1336.6057013180941;1466.7359875222562;1468.8090548228663;1478.3347493627696;1490.7763835424555;27577.724222757515;27790;28207.57688634631;28289;28332.191900660728;44120.779396102815;44514.77742611396;44549;44573.77713111414;44642.3303650452;301702;313300;314518;314675;316134;28186;32509.02472925816;32697.019089427355;33451.16372090717;33470.665293346756;40960;46327.30509042434;47653.523464764905;48368.5163148364;48499.51500485091;33562;35311.64688353083;37000.444993324585;37890.0527486804;37972.62027379691;29495.11514654564;29998.55002175013;34982.30035399328;36546;36634.45048324331;36805.44791828071;36997;37116.628833711315;37818.62181378261;38335;24548.754512454645;31067.84466077655;31245.531317029807;32503;32887.34225315528;24191.637125443485;24226.63660045136;24370.390740231636;24390.75609243956;24718 05:50:50 INFO - PROCESS | 1995 | |2;jquery.html;359.7481762766064;362.74607774557813;366.3552148219134;369.6599128801502;374.9568799588048;19626.901865490672;20385.388438346854;20886.37340879772;21089.894550527246;21585.812780297078;20204.29284975026;20616.07227674758;20968.26611068613;20980;21168.788312116874;5857.79497717581;5979.850503737398;6064.3026052003925;6067.7572897084065;6083.117947897552;5856.297244330665;5895.498882594985;5947.583669143161;5955.910661340084;6048.576599638027;5972.79095231667;5978.163057172;5998.310194327664;6006.8498287542725;6009.819705408823;5723.456271654186;5842.415758424166;5889.352171261158;5892.675902825343;5913.940860591403;5093.617978651616;5121.948780512184;5129.794808207667;5131.076406246874;5151.45909679482;24865.7567121645;25271.62092568613;25573.74426255751;25705;25747.485050299078;2222.4777177363308;2226.7995880370845;2293.6674182243646;2423.8182136339847;2766.73715996982;14197.716045679132;14482.927585362111;14572.562823115324;14977.625559360995;15160.545183644508;1721.5179749670112;1731.4372828830556;1756.5608597850537;1782.3583509936414;1789.346888385743;94915.52542237313;97986;98046.50976745143;98085.0191498083;98546;10322.380657160595;10791.352518848895;11093;11144.052755515871;11291.661250162508;13592.796108058386;13626.659333516543;13734.931325343508;13736.45054197841;13742.725145497034;8440.957795210985;8476.321894248445;8509.702160424355;8534.103919088531;8609.268212201907;8685;8692.348073894484;8699.739007829776;8789.121087891288;8822.117788221127;4428.3136113901755;4439.178751930903;4445.844395446144;4456.64346852251;4513.413256276663;1796.5508622844288;1838.9701767010517;1839.8804077734903;1843.3548258109554;1884.9434516964513;911.7036962987056;956.3257903178381;1014.5992333028413;1039.3348257115451;1056.99471502642;19972.700409493867;20352.89823550873;20554;20593.485162870747;21203.575928481652;858.7380848841163;952.3666761603456;955.3121752338305;987.2595553334999;992.9453880036523;8418.452800567944;9668.598053282234;10798.190135739851;10963.256009110957;11081.556737730562;638529;645126;651049;656997;658496;98813.50593247132;102094.95810083757;111536.44231778789;111887;112742.74514509663;988.8615593816871;992.4243938515643;1010.1968934696934;1014.0214692821463;1014.974625634365;18265.812722173017;18539.536511587317;18579.81420185835;18667.626647467245;18704.906475467535;37546.87359379223;51719.741401292755;52300;52737;53766.92466150577;70539.64730176317;71872.9219061725;72830;73922.52154956764;74001;7625.961870190614;7665.080190377191;7672.6547305372505;7737.729179478692;7967.442279040411;10212.285140040125;12132.636020919033;12238.87761122413;12472.251664900135;12537.686557835763;9938.552765125442;10081.14310283634;10170.135538479017;10226.23303252274;10246.436445995541;10339.379637221791;10407.427591482541;10585.417802020962;10588.735281618021;10750.946245269037;8978.326625502983;10087.243456740627;10382.221333399873;10492.422916739348;10520.263581549218;7501.099868015873;7714.5756983366455;7718.189590092959;7798.025246844145;7994.680212791423;9330.253579713471;10220.528830329482;10261.794764104825;10290.588376464857;10443.738906527398 05:50:50 INFO - PROCESS | 1995 | |3;mootools.html;1439.79842822005;1571.2929181868158;1601.6636506333673;1901.3155264104928;2036.5112373030477;7941.0867750208745;8552.48685078895;8724.781880452976;8726.86909696355;8732.825343493134;8339.708110216143;8627.396082274243;8659.047504774486;8663.003754568226;8666.090060543647;2178.36827320077;2423.273018094573;2470.234227389506;2500.599904015358;2504.912328068518;2494.114589320792;2503.123906632682;2506.8997240110375;2509.5859183234834;2511.3847107458605;2421.8425802322795;2470.555300046;2489.601663733803;2491.402063504764;2492.887820048093;1845.3356791555098;2432.6837511123617;2485.751424857518;2486.0677246032737;2486.8880900359436;2457.8771061447037;2461.7661322174363;2498.025769949721;2498.387894965745;2502.0742325339743;8591.957040214822;8680.739577812612;8685.001224859096;8686.782830429227;8723.12768723129;5377.865553361197;5494.450554944514;5498.257735205736;5524.116141417354;5546.223528705985;3565.2156525564333;3583.4087375583;3677.613850545681;3711.3319602471543;3733.8879833605033;1037.3101887244973;1055.3034996902009;1057.746140926172;1060.607575197182;1068.5779117248644;11847.052235821113;11872.584459543961;11873.762524749456;11884.940575297069;11903.285802851857;4877.487863774252;4901.877453063702;4915.58217551505;4951.653384263067;4953.331300274489;10065.34575252621;10088.344257623232;10100.848487272697;10196.541155648014;10197.031282028196;5452.890942181134;5456.372517160498;5457.863553411117;5458.372287187024;5464.0711079116645;4359.542248063971;4437.245668236407;4437.400950871655;4444.2222611042935;4536.251518499476;3870.148567315186;3937.2322397132284;3980.6616437602547;3996.0609256824623;4006.2988976928923;1326.8739469750358;1330.0955350361653;1331.9933400332936;1334.0594880609146;1338.5649663859285;1320.4850108457708;1324.4304948872077;1353.5127354152498;1387.7848933415135;1388.5487216654628;7973.521588704581;8058.274755272054;8185.918140818635;8201.466904651179;8201.8359632807;502.9069622119919;513.2199057432681;514.5343464164937;516.0581937963157;516.9870753231199;6180.072989051589;6225.906611400833;6259.624422534663;6271.247450305992;6275.901717199472;10294;10696.358218506915;10792.676219713421;10805.783884322269;10820.621278255223;10427.009434103747;10430.956904309509;10610.151187904949;10667.83998240027;10670.83993740079;6506.837329066717;8261.967254093359;8268.875966860502;8338.666453341799;8363.03825060126;6342.587731797418;7701.961490192513;7833.060032796101;7835;8033.638486268015;9337.393069450463;9364.110409511086;9377.671781487616;9433.386829856037;9433.764155895882;9375.578098985425;9657;9701.417914925127;9798.65704700332;9843.360181588174;6751.696173672295;6798.898016529657;7361.484696071224;7463.962680186564;7470.215627359049;8091.474054186459;8172.468789528662;8185.4270201085355;8201.09787923316;8210.261076503144;7176.641167941478;7264;7280.9271907280245;7386.630668466662;7397.260273972775;7148.606826624586;7153;7221.205667376479;7308.817279568053;7310.013148224922;7396.704131834666;7605.125410577854;7664.578448185403;7672.462927595015;7688.961555192188;6933.82665433348;6952.478564107611;6987.441004719509;6992.895106573304;6999.1950925644205;6436.774712885027;6768;6971.337722916315;6987.825304367431;7068.257832927468 05:50:50 INFO - PROCESS | 1995 | |4;prototype.html;266.7919023161934;331.312526507497;332.9700326970573;337.5645417411539;337.71463113668943;6400.1359816424765;6648.434883034942;6649.035889795977;6672.232693240278;6684.29814869439;6511.479081673467;6551.4431273341825;6566.146400967879;6567.408933196023;6611.504137189718;4620.907581848361;4716.669833111683;4731.929021064687;4886.755662216884;4900.289458028584;4817.735024573647;4835.806567737286;4843.806247750086;4865.6107511399005;4890.706557606537;4762.761861906891;4770.928436073462;4784.78468468918;4794.1610218211845;4795;4568.132054909556;4647.814087436498;4774.928376074362;4778.80884764609;4778.976105119469;4110.568390319003;4124.896877578085;4136.255474014676;4137.40007698885;4143.3370660694145;6162.691865406757;6168.136460895478;6198.132261483396;6241.375862413768;6322.589031712924;5725.570582206351;5728.570357223183;5736.024875771129;5736.569757268222;5739.110437882093;5759.913601295984;6965.79102626922;6980.057692211588;6990.790276291719;6991.916252980796;4372.781360931941;4530.637548996073;4556;4680.765961701935;4681.50844161365;6648.534602577822;6739.1239138912115;7223.747168849118;7302.634868256566;7327.267273272683;4615.9076818463445;4619.099275641218;4620.422447194101;4624.260118381043;4635.3742244797195;4669.813207471663;4696.8590942271785;4700.412448443944;4702.788374523155;4739.123262196505;5555.055640541118;5570.916436253459;5576.665400075927;5577.6932268724795;5581.860453488614;6747.291534388916;6993.89509157363;6995.26549712283;7006.474514411338;7015.9298407016295;1606.6224437257235;1614.5398561409943;1631.9718577296228;1634.7466142747894;1637.6806522727954;865.35098675993;1028.6194108179873;1048.1038711901367;1050.3435352904435;1055.4933631856752;6284.842878928063;6460.612363258219;6474.320196379406;6591.736330546724;6624.834379140464;7331.303526165006;7341.192468828424;7345.70617175307;7373.631318434057;7410.5183163094225;6538.215414150332;6548.508861835381;6548.574342667712;6555.016747487915;6558.475321974231;3848.5766565677754;3895.824687889052;3898.785566793797;3901.5318161820765;3904.902377440587;6251.499880009588;7270.563766174047;7606.771796846104;7621.847563048708;7683;5508.228847961289;6131.478824299896;6182.443580077725;7552.811179720551;7562.168161502231;6139.293981192041;6205.472534834499;7595;7627.389808815282;7634.923650763532;7322.1579518356075;7339.522931009467;7350.77947661571;7374.225706300761;7383.187849336676;6929.09449901261;7190.280971902768;7218;7226.349628533457;7229.530080544748;7523;7586.734464293723;7587.58268295249;7597.810054748676;7599.050118735158;4654.813807447664;4657.301404789308;4662.254039353687;4675.555822196886;4675.719456832601;7254.419646428168;7262.237465066092;7268.636568171676;7270.382017528569;7274.127104747464;6838.93161068383;7081.964590177222;7120.608366539683;7120.715171393086;7123.323284287984;7027.297270273137;7045.11936007999;7061.929380706332;7080.787576372717;7091.290870912868;5610.438956104357;6906.585604863724;6941.826454338682;6944.097267355211;6953.895691564529;6763.830904227434;7075.433965282868;7100.502964792415;7107.111611048619;7120.145582530129;6615.735370585123;6788.9660551696925;6802.387785099365;6908.032875397348;6942.757003504853 05:50:50 INFO - PROCESS | 1995 | |5;yui.html;654.5876098058222;685.4276678973057;710.1371833222637;718.4037249083261;775.9834616652186;14252.786208206886;14318.785218221721;14528.564143075724;14533.200673962929;14538.927305363472;13295.135816171942;13431.529896453627;13433.798493022588;13435.26106064166;13476.393562289695;760.1941941541955;920.0569416348229;936.840737074699;947.6777895515523;949.0746522140892;769.0118198115423;919.5907821019649;949.1125797379437;950.7765675066354;952.5189779161514;1000.7197984564334;1000.9099181073702;1005.3214080495673;1007.2043085962081;1008.2387797213094;790.2413682864457;790.8102055506695;1000.8198524265629;1002.8245057115012;1003.9759445365722;594.7234535940809;602.5691630484181;726.3426598927979;739.7484855149221;740.0120838680368;14214.005019648628;14283.21442320672;14298.714025719531;14302.356393962296;14312.42750289987;10308.896911030868;12052.276863388137;12139.453724582416;12233.388330583524;12535.56125535611;9721.56252968611;9747.220222382193;9772.169365603932;9873.259505537042;10039.89960100397;3294.044727029159;3322.1694576355912;3326.417876871538;3354.1446931032674;3403.3363494118657;82330.53008409757;82349;82413;82418.76371854427;82534;9147.954260228656;9150.908490915006;9245.676401325922;9342.439453632804;9749.707508774749;20890.268840590812;20918.372448826558;20968.370948871558;20972.475688107614;21002.579948400948;7272.63636818157;7302.415806735448;7311.268873112646;7403.592802395812;7449.515781474187;3910.8631197907935;3980.3432433648704;3989.6209860063245;4000.4999375078114;4019.0354314964197;3400.8639654413546;3426.9143271417915;3448.655134486531;3451.2579795344122;3452.016175390002;593.6171169595586;625.1966223402906;633.8256979330721;642.3095172689377;646.802725168828;528.6273177409917;555.7443575955025;568.863472766533;587.7267070812093;609.868878191191;7596.354309883612;7797.844043119106;7877.7636670899965;8112.391570632109;8202;500.47950131863183;509.6508891409396;563.7660370946094;570.1675553691657;576.6770608459276;3639.8544058237903;3640.8179591020344;3684.1894783147663;3810.580836108026;3869.542840296432;87874.56062719645;89484.5525772367;89958;90143;90220;77071;78961;79102.41795164064;79254.01864953422;80427.19572804314;69413.65293173502;69483.30516694768;69562;70478;70536.64731676309;7354.411647068328;7373.262673732584;7435.442341824277;7579.810504737426;7795.259450352208;46479;50524.49475505345;50564.988700225054;50801.74599126981;51105.2113176037;62895;68463.3153668457;69828.30171698218;70320.29679703138;71600.64199678968;8229.95885020595;9898.455584942898;9900.35647682927;9938.006199380005;10376.481175941022;8704.56477176126;10637.734056648645;10809.837852432063;10845.511951962339;10906.61826836057;10063.868386391545;10147.594096236067;10148.188144948239;10173.949130254301;10367.844482332923;10004.699859004242;10415.68752937413;10554.208434367607;10927.617533386294;11048.392338421463;10671.413072281099;10735.194860385658;11055.22613417053;11062.502187401748;11070.446477675923;9105;9148.862767058366;9424.905750942402;9467.810643786948;9537.998510156334;8331.67330677291;8473.83052338962;9292.907070929205;9296.767580810534;9392.389494682824 05:50:50 INFO - PROCESS | 1995 | __end_tp_report 05:50:50 INFO - PROCESS | 1995 | __start_cc_report 05:50:50 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,1519 05:50:50 INFO - PROCESS | 1995 | __end_cc_report 05:50:50 INFO - PROCESS | 1995 | __startTimestamp1457790650155__endTimestamp 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | ------- Summary: start ------- 05:50:50 INFO - PROCESS | 1995 | Number of tests: 6 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | [#0] dojo.html Cycles:165 Average:5587.62 Median:5750.02 stddev:633.04 (11.0%) stddev-sans-first:604.72 05:50:50 INFO - PROCESS | 1995 | Values: 3122.5 3311.8 3419.9 3448.1 3492.9 4604.7 5439.6 5524.0 5536.7 5555.0 5433.3 5483.2 5522.0 5533.5 5550.0 4977.1 4986.2 4994.1 5067.2 5073.7 5007.2 5063.1 5063.3 5076.0 5090.0 4980.2 5017.5 5030.9 5048.6 5068.1 5055.9 5112.4 5120.8 5138.2 5190.9 4906.9 4950.7 5051.1 5055.7 5066.6 5407.1 5454.8 5467.2 5467.5 5567.0 6025.4 6043.8 6058.9 6062.2 6076.8 6010.7 6012.2 6163.4 6169.9 6172.4 5638.5 5643.7 5658.2 5680.4 5699.4 6203.9 6257.6 6270.8 6285.8 6287.5 5750.0 5902.0 5945.1 5997.8 6066.0 6083.9 6085.6 6086.4 6094.2 6104.4 5514.4 5819.5 5926.8 5980.7 5981.6 5913.9 6023.6 6113.2 6125.9 6138.2 4772.5 4774.4 4784.8 4805.9 4820.0 4226.0 4305.3 4318.1 4331.5 4374.6 5424.1 5440.0 5482.8 5490.6 5492.5 6069.0 6078.4 6082.3 6091.5 6091.6 5461.1 5497.1 5498.0 5506.8 5508.5 5214.1 5234.6 5267.1 5283.8 5290.0 6246.9 6275.1 6314.1 6323.3 6330.3 6133.0 6136.9 6169.3 6170.3 6190.8 6118.0 6219.3 6312.8 6315.6 6344.6 6003.8 6007.5 6009.6 6034.6 6053.9 6112.9 6120.3 6136.5 6159.4 6166.7 5765.1 5880.2 5908.4 5927.3 6043.3 5927.8 5938.3 5938.4 5949.4 5953.4 5615.2 5802.6 5808.0 5814.5 5815.7 5778.7 5819.6 5832.7 5892.4 5895.2 5690.3 5717.5 5731.7 5739.7 5742.1 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | [#1] ext.html Cycles:180 Average:57488.24 Median:37628.22 stddev:113604.04 (301.9%) stddev-sans-first:113842.26 05:50:50 INFO - PROCESS | 1995 | Values: 538.4 558.1 576.9 621.2 633.8 29149.6 36811.4 37247.8 37418.4 37437.8 33238.7 39730.8 40335.8 40356.2 40582.6 7566.8 9573.1 9573.3 9579.8 9590.3 9390.7 9577.8 9588.0 9590.7 9707.1 8749.7 9436.1 9647.9 9746.2 9748.5 9637.6 9686.0 9712.3 9742.4 9764.7 9499.7 9653.5 9654.0 9656.7 9661.8 39246.8 39617.8 39697.0 39706.0 39718.2 3171.8 3184.0 3350.5 3535.9 3788.4 28102.0 28130.0 28194.9 28716.0 28776.7 2643.6 2671.9 2746.5 2772.8 2834.6 489065.0 490871.5 492421.0 492841.0 493725.0 63215.7 63236.0 63369.7 63595.4 63603.7 68681.0 69737.3 69776.7 69787.7 70011.3 16199.3 16247.9 16443.5 16465.8 16475.4 12607.7 12694.4 12710.9 12713.7 12726.6 19963.9 20630.0 20666.0 20678.3 20807.6 8845.2 9029.0 9052.0 9058.2 9160.6 829.8 932.5 947.1 958.4 1174.2 28565.7 29031.4 29268.4 29437.9 29820.7 972.2 1022.8 1065.9 1106.1 1144.8 14595.3 14779.4 14793.9 14915.9 15268.5 451540.0 456759.0 460717.0 462103.0 462916.0 57502.4 57881.1 58027.4 58081.0 58127.7 1336.6 1466.7 1468.8 1478.3 1490.8 27577.7 27790.0 28207.6 28289.0 28332.2 44120.8 44514.8 44549.0 44573.8 44642.3 301702.0 313300.0 314518.0 314675.0 316134.0 28186.0 32509.0 32697.0 33451.2 33470.7 40960.0 46327.3 47653.5 48368.5 48499.5 33562.0 35311.6 37000.4 37890.1 37972.6 29495.1 29998.6 34982.3 36546.0 36634.5 36805.4 36997.0 37116.6 37818.6 38335.0 24548.8 31067.8 31245.5 32503.0 32887.3 24191.6 24226.6 24370.4 24390.8 24718.0 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | [#2] jquery.html Cycles:180 Average:35025.43 Median:361.25 stddev:107177.55 (29668.8%) stddev-sans-first:107446.60 05:50:50 INFO - PROCESS | 1995 | Values: 359.7 362.7 366.4 369.7 375.0 19626.9 20385.4 20886.4 21089.9 21585.8 20204.3 20616.1 20968.3 20980.0 21168.8 5857.8 5979.9 6064.3 6067.8 6083.1 5856.3 5895.5 5947.6 5955.9 6048.6 5972.8 5978.2 5998.3 6006.8 6009.8 5723.5 5842.4 5889.4 5892.7 5913.9 5093.6 5121.9 5129.8 5131.1 5151.5 24865.8 25271.6 25573.7 25705.0 25747.5 2222.5 2226.8 2293.7 2423.8 2766.7 14197.7 14482.9 14572.6 14977.6 15160.5 1721.5 1731.4 1756.6 1782.4 1789.3 94915.5 97986.0 98046.5 98085.0 98546.0 10322.4 10791.4 11093.0 11144.1 11291.7 13592.8 13626.7 13734.9 13736.5 13742.7 8441.0 8476.3 8509.7 8534.1 8609.3 8685.0 8692.3 8699.7 8789.1 8822.1 4428.3 4439.2 4445.8 4456.6 4513.4 1796.6 1839.0 1839.9 1843.4 1884.9 911.7 956.3 1014.6 1039.3 1057.0 19972.7 20352.9 20554.0 20593.5 21203.6 858.7 952.4 955.3 987.3 992.9 8418.5 9668.6 10798.2 10963.3 11081.6 638529.0 645126.0 651049.0 656997.0 658496.0 98813.5 102095.0 111536.4 111887.0 112742.7 988.9 992.4 1010.2 1014.0 1015.0 18265.8 18539.5 18579.8 18667.6 18704.9 37546.9 51719.7 52300.0 52737.0 53766.9 70539.6 71872.9 72830.0 73922.5 74001.0 7626.0 7665.1 7672.7 7737.7 7967.4 10212.3 12132.6 12238.9 12472.3 12537.7 9938.6 10081.1 10170.1 10226.2 10246.4 10339.4 10407.4 10585.4 10588.7 10750.9 8978.3 10087.2 10382.2 10492.4 10520.3 7501.1 7714.6 7718.2 7798.0 7994.7 9330.3 10220.5 10261.8 10290.6 10443.7 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | [#3] mootools.html Cycles:180 Average:5982.94 Median:5415.38 stddev:3165.17 (58.4%) stddev-sans-first:3155.62 05:50:50 INFO - PROCESS | 1995 | Values: 1439.8 1571.3 1601.7 1901.3 2036.5 7941.1 8552.5 8724.8 8726.9 8732.8 8339.7 8627.4 8659.0 8663.0 8666.1 2178.4 2423.3 2470.2 2500.6 2504.9 2494.1 2503.1 2506.9 2509.6 2511.4 2421.8 2470.6 2489.6 2491.4 2492.9 1845.3 2432.7 2485.8 2486.1 2486.9 2457.9 2461.8 2498.0 2498.4 2502.1 8592.0 8680.7 8685.0 8686.8 8723.1 5377.9 5494.5 5498.3 5524.1 5546.2 3565.2 3583.4 3677.6 3711.3 3733.9 1037.3 1055.3 1057.7 1060.6 1068.6 11847.1 11872.6 11873.8 11884.9 11903.3 4877.5 4901.9 4915.6 4951.7 4953.3 10065.3 10088.3 10100.8 10196.5 10197.0 5452.9 5456.4 5457.9 5458.4 5464.1 4359.5 4437.2 4437.4 4444.2 4536.3 3870.1 3937.2 3980.7 3996.1 4006.3 1326.9 1330.1 1332.0 1334.1 1338.6 1320.5 1324.4 1353.5 1387.8 1388.5 7973.5 8058.3 8185.9 8201.5 8201.8 502.9 513.2 514.5 516.1 517.0 6180.1 6225.9 6259.6 6271.2 6275.9 10294.0 10696.4 10792.7 10805.8 10820.6 10427.0 10431.0 10610.2 10667.8 10670.8 6506.8 8262.0 8268.9 8338.7 8363.0 6342.6 7702.0 7833.1 7835.0 8033.6 9337.4 9364.1 9377.7 9433.4 9433.8 9375.6 9657.0 9701.4 9798.7 9843.4 6751.7 6798.9 7361.5 7464.0 7470.2 8091.5 8172.5 8185.4 8201.1 8210.3 7176.6 7264.0 7280.9 7386.6 7397.3 7148.6 7153.0 7221.2 7308.8 7310.0 7396.7 7605.1 7664.6 7672.5 7689.0 6933.8 6952.5 6987.4 6992.9 6999.2 6436.8 6768.0 6971.3 6987.8 7068.3 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | [#4] prototype.html Cycles:180 Average:5705.07 Median:6492.90 stddev:1811.20 (27.9%) stddev-sans-first:1769.69 05:50:50 INFO - PROCESS | 1995 | Values: 266.8 331.3 333.0 337.6 337.7 6400.1 6648.4 6649.0 6672.2 6684.3 6511.5 6551.4 6566.1 6567.4 6611.5 4620.9 4716.7 4731.9 4886.8 4900.3 4817.7 4835.8 4843.8 4865.6 4890.7 4762.8 4770.9 4784.8 4794.2 4795.0 4568.1 4647.8 4774.9 4778.8 4779.0 4110.6 4124.9 4136.3 4137.4 4143.3 6162.7 6168.1 6198.1 6241.4 6322.6 5725.6 5728.6 5736.0 5736.6 5739.1 5759.9 6965.8 6980.1 6990.8 6991.9 4372.8 4530.6 4556.0 4680.8 4681.5 6648.5 6739.1 7223.7 7302.6 7327.3 4615.9 4619.1 4620.4 4624.3 4635.4 4669.8 4696.9 4700.4 4702.8 4739.1 5555.1 5570.9 5576.7 5577.7 5581.9 6747.3 6993.9 6995.3 7006.5 7015.9 1606.6 1614.5 1632.0 1634.7 1637.7 865.4 1028.6 1048.1 1050.3 1055.5 6284.8 6460.6 6474.3 6591.7 6624.8 7331.3 7341.2 7345.7 7373.6 7410.5 6538.2 6548.5 6548.6 6555.0 6558.5 3848.6 3895.8 3898.8 3901.5 3904.9 6251.5 7270.6 7606.8 7621.8 7683.0 5508.2 6131.5 6182.4 7552.8 7562.2 6139.3 6205.5 7595.0 7627.4 7634.9 7322.2 7339.5 7350.8 7374.2 7383.2 6929.1 7190.3 7218.0 7226.3 7229.5 7523.0 7586.7 7587.6 7597.8 7599.1 4654.8 4657.3 4662.3 4675.6 4675.7 7254.4 7262.2 7268.6 7270.4 7274.1 6838.9 7082.0 7120.6 7120.7 7123.3 7027.3 7045.1 7061.9 7080.8 7091.3 5610.4 6906.6 6941.8 6944.1 6953.9 6763.8 7075.4 7100.5 7107.1 7120.1 6615.7 6789.0 6802.4 6908.0 6942.8 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - PROCESS | 1995 | [#5] yui.html Cycles:180 Average:17988.04 Median:606.22 stddev:25775.91 (4251.9%) stddev-sans-first:25815.36 05:50:50 INFO - PROCESS | 1995 | Values: 654.6 685.4 710.1 718.4 776.0 14252.8 14318.8 14528.6 14533.2 14538.9 13295.1 13431.5 13433.8 13435.3 13476.4 760.2 920.1 936.8 947.7 949.1 769.0 919.6 949.1 950.8 952.5 1000.7 1000.9 1005.3 1007.2 1008.2 790.2 790.8 1000.8 1002.8 1004.0 594.7 602.6 726.3 739.7 740.0 14214.0 14283.2 14298.7 14302.4 14312.4 10308.9 12052.3 12139.5 12233.4 12535.6 9721.6 9747.2 9772.2 9873.3 10039.9 3294.0 3322.2 3326.4 3354.1 3403.3 82330.5 82349.0 82413.0 82418.8 82534.0 9148.0 9150.9 9245.7 9342.4 9749.7 20890.3 20918.4 20968.4 20972.5 21002.6 7272.6 7302.4 7311.3 7403.6 7449.5 3910.9 3980.3 3989.6 4000.5 4019.0 3400.9 3426.9 3448.7 3451.3 3452.0 593.6 625.2 633.8 642.3 646.8 528.6 555.7 568.9 587.7 609.9 7596.4 7797.8 7877.8 8112.4 8202.0 500.5 509.7 563.8 570.2 576.7 3639.9 3640.8 3684.2 3810.6 3869.5 87874.6 89484.6 89958.0 90143.0 90220.0 77071.0 78961.0 79102.4 79254.0 80427.2 69413.7 69483.3 69562.0 70478.0 70536.6 7354.4 7373.3 7435.4 7579.8 7795.3 46479.0 50524.5 50565.0 50801.7 51105.2 62895.0 68463.3 69828.3 70320.3 71600.6 8230.0 9898.5 9900.4 9938.0 10376.5 8704.6 10637.7 10809.8 10845.5 10906.6 10063.9 10147.6 10148.2 10173.9 10367.8 10004.7 10415.7 10554.2 10927.6 11048.4 10671.4 10735.2 11055.2 11062.5 11070.4 9105.0 9148.9 9424.9 9467.8 9538.0 8331.7 8473.8 9292.9 9296.8 9392.4 05:50:50 INFO - PROCESS | 1995 | -------- Summary: end -------- 05:50:50 INFO - PROCESS | 1995 | 05:50:50 INFO - TEST-INFO | 1995: exit 0 05:50:50 INFO - TEST-OK | dromaeo_css | took 1113056ms 05:50:50 INFO - TEST-START | kraken 05:50:50 INFO - operating with platform_type : mac_ 05:50:50 INFO - Initialising browser for kraken test... 05:50:50 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpUyLoeY/profile http://localhost:49583/getInfo.html) 05:50:52 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 05:50:52 INFO - PROCESS | 1998 | colorDepth:24 05:50:52 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 05:50:52 INFO - PROCESS | 1998 | __metrics 05:50:52 INFO - PROCESS | 1998 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:50:52 ERROR - PROCESS | 1998 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:50:53 INFO - TEST-INFO | 1998: exit 0 05:50:53 INFO - Browser initialized. 05:50:53 INFO - Running cycle 1/1 for kraken test... 05:50:53 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpUyLoeY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:05 INFO - PROCESS | 2000 | RSS: Main: 243077120 05:51:05 INFO - PROCESS | 2000 | 05:51:08 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:08 INFO - PROCESS | 2000 | RSS: Main: 290009088 05:51:08 INFO - PROCESS | 2000 | 05:51:11 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-dft) 05:51:12 INFO - PROCESS | 2000 | RSS: Main: 299794432 05:51:12 INFO - PROCESS | 2000 | 05:51:15 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-fft) 05:51:15 INFO - PROCESS | 2000 | RSS: Main: 286281728 05:51:15 INFO - PROCESS | 2000 | 05:51:17 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-oscillator) 05:51:18 INFO - PROCESS | 2000 | RSS: Main: 288432128 05:51:18 INFO - PROCESS | 2000 | 05:51:20 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:21 INFO - PROCESS | 2000 | RSS: Main: 289361920 05:51:21 INFO - PROCESS | 2000 | 05:51:23 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49583/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:24 INFO - PROCESS | 2000 | RSS: Main: 289710080 05:51:24 INFO - PROCESS | 2000 | 05:51:27 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49583/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:27 INFO - PROCESS | 2000 | RSS: Main: 289427456 05:51:27 INFO - PROCESS | 2000 | 05:51:30 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49583/tests/kraken/driver.html?testName=json-parse-financial) 05:51:31 INFO - PROCESS | 2000 | RSS: Main: 290992128 05:51:31 INFO - PROCESS | 2000 | 05:51:32 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:33 INFO - PROCESS | 2000 | RSS: Main: 324792320 05:51:33 INFO - PROCESS | 2000 | 05:51:35 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:35 INFO - PROCESS | 2000 | RSS: Main: 324202496 05:51:35 INFO - PROCESS | 2000 | 05:51:37 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:38 INFO - PROCESS | 2000 | RSS: Main: 332300288 05:51:38 INFO - PROCESS | 2000 | 05:51:41 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:41 INFO - PROCESS | 2000 | RSS: Main: 333541376 05:51:41 INFO - PROCESS | 2000 | 05:51:44 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:44 INFO - PROCESS | 2000 | RSS: Main: 332070912 05:51:44 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49583/tests/kraken/driver.html?testName=ai-astar) 05:51:46 INFO - PROCESS | 2000 | RSS: Main: 392998912 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | __start_tp_report 05:51:46 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 05:51:46 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 05:51:46 INFO - PROCESS | 2000 | |i|pagename|runs| 05:51:46 INFO - PROCESS | 2000 | |0;ai-astar;113;108;110;112;112;110;117;110;113;111 05:51:46 INFO - PROCESS | 2000 | |1;audio-beat-detection;156;128;148;190;145;125;161;103;181;135 05:51:46 INFO - PROCESS | 2000 | |2;audio-dft;188;187;185;184;186;184;187;179;183;181 05:51:46 INFO - PROCESS | 2000 | |3;audio-fft;81;72;84;78;56;57;58;79;84;75 05:51:46 INFO - PROCESS | 2000 | |4;audio-oscillator;91;96;131;80;78;87;115;77;80;109 05:51:46 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;88;86;88;86;133;122;89;84;88;84 05:51:46 INFO - PROCESS | 2000 | |6;imaging-darkroom;92;93;117;93;93;94;93;98;96;93 05:51:46 INFO - PROCESS | 2000 | |7;imaging-desaturate;87;87;85;88;88;86;85;87;84;87 05:51:46 INFO - PROCESS | 2000 | |8;json-parse-financial;56;55;53;54;53;54;53;65;54;51 05:51:46 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;64;75;76;74;71;67;67;67;69;68 05:51:46 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;83;83;82;82;83;82;80;82;82;83 05:51:46 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;130;129;131;107;131;128;129;129;120;120 05:51:46 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;157;165;176;120;164;165;173;162;136;138 05:51:46 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;68;66;66;67;68;66;69;68;66;69 05:51:46 INFO - PROCESS | 2000 | __end_tp_report 05:51:46 INFO - PROCESS | 2000 | __start_cc_report 05:51:46 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,1223 05:51:46 INFO - PROCESS | 2000 | __end_cc_report 05:51:46 INFO - PROCESS | 2000 | __startTimestamp1457790706909__endTimestamp 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | ------- Summary: start ------- 05:51:46 INFO - PROCESS | 2000 | Number of tests: 14 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.46 (2.2%) stddev-sans-first:2.55 05:51:46 INFO - PROCESS | 2000 | Values: 113.0 108.0 110.0 112.0 112.0 110.0 117.0 110.0 113.0 111.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:152.00 stddev:26.27 (17.3%) stddev-sans-first:27.67 05:51:46 INFO - PROCESS | 2000 | Values: 156.0 128.0 148.0 190.0 145.0 125.0 161.0 103.0 181.0 135.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.50 stddev:2.84 (1.5%) stddev-sans-first:2.69 05:51:46 INFO - PROCESS | 2000 | Values: 188.0 187.0 185.0 184.0 186.0 184.0 187.0 179.0 183.0 181.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:72.40 Median:78.50 stddev:11.25 (14.3%) stddev-sans-first:11.49 05:51:46 INFO - PROCESS | 2000 | Values: 81.0 72.0 84.0 78.0 56.0 57.0 58.0 79.0 84.0 75.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:80.00 stddev:18.36 (22.9%) stddev-sans-first:19.43 05:51:46 INFO - PROCESS | 2000 | Values: 91.0 96.0 131.0 80.0 78.0 87.0 115.0 77.0 80.0 109.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:87.00 stddev:17.51 (20.1%) stddev-sans-first:18.40 05:51:46 INFO - PROCESS | 2000 | Values: 88.0 86.0 88.0 86.0 133.0 122.0 89.0 84.0 88.0 84.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:93.00 stddev:7.52 (8.1%) stddev-sans-first:7.83 05:51:46 INFO - PROCESS | 2000 | Values: 92.0 93.0 117.0 93.0 93.0 94.0 93.0 98.0 96.0 93.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 05:51:46 INFO - PROCESS | 2000 | Values: 87.0 87.0 85.0 88.0 88.0 86.0 85.0 87.0 84.0 87.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.82 (7.1%) stddev-sans-first:4.03 05:51:46 INFO - PROCESS | 2000 | Values: 56.0 55.0 53.0 54.0 53.0 54.0 53.0 65.0 54.0 51.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:4.02 (5.7%) stddev-sans-first:3.68 05:51:46 INFO - PROCESS | 2000 | Values: 64.0 75.0 76.0 74.0 71.0 67.0 67.0 67.0 69.0 68.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:0.92 (1.1%) stddev-sans-first:0.93 05:51:46 INFO - PROCESS | 2000 | Values: 83.0 83.0 82.0 82.0 83.0 82.0 80.0 82.0 82.0 83.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:129.00 stddev:7.65 (5.9%) stddev-sans-first:7.93 05:51:46 INFO - PROCESS | 2000 | Values: 130.0 129.0 131.0 107.0 131.0 128.0 129.0 129.0 120.0 120.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:164.50 stddev:18.17 (11.0%) stddev-sans-first:19.26 05:51:46 INFO - PROCESS | 2000 | Values: 157.0 165.0 176.0 120.0 164.0 165.0 173.0 162.0 136.0 138.0 05:51:46 INFO - PROCESS | 2000 | 05:51:46 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 05:51:46 INFO - PROCESS | 2000 | Values: 68.0 66.0 66.0 67.0 68.0 66.0 69.0 68.0 66.0 69.0 05:51:46 INFO - PROCESS | 2000 | -------- Summary: end -------- 05:51:46 INFO - PROCESS | 2000 | 05:51:47 INFO - TEST-INFO | 2000: exit 0 05:51:47 INFO - TEST-OK | kraken | took 56989ms 05:51:47 INFO - SUITE-END | took 1170s 05:51:48 INFO - Completed test suite (00:19:30) 05:51:48 INFO - javascript benchmark 05:51:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3122.484790009648, 3311.817850018249, 3419.9487007694875, 3448.0862571418593, 3492.930141397172, 4604.677672562918, 5439.5920305977115, 5523.972380138103, 5536.667799932007, 5555.0, 5433.26650902129, 5483.177523371496, 5521.972390138044, 5533.474319939599, 5550.0, 4977.07924034053, 4986.152354099793, 4994.051130285252, 5067.239914012909, 5073.670211436245, 5007.2489126630935, 5063.063333283336, 5063.316452278932, 5075.9746201268945, 5090.0, 4980.153373926423, 5017.473165317644, 5030.899382012376, 5048.596112311006, 5068.138416469191, 5055.898882022358, 5112.36095488064, 5120.820771273025, 5138.203578445347, 5190.948090519103, 4906.901861962777, 4950.7029578225065, 5051.116054690415, 5055.747212639353, 5066.569341605968, 5407.080796264644, 5454.781808727646, 5467.17992301158, 5467.535259502947, 5567.0, 6025.397460253984, 6043.758249670052, 6058.878822423571, 6062.181605483247, 6076.817695469099, 6010.669413182273, 6012.248468941382, 6163.414475624809, 6169.907451388232, 6172.4136207060255, 5638.548916086745, 5643.661380317194, 5658.207850900877, 5680.4319568043275, 5699.401562835926, 6203.937960620427, 6257.56197066201, 6270.843228919313, 6285.779997700059, 6287.528435367274, 5750.02249617566, 5901.970490147608, 5945.078512830518, 5997.820065398045, 6065.999110146777, 6083.939160608337, 6085.6348619083, 6086.391360863879, 6094.238220222473, 6104.4200800923845, 5514.420985796514, 5819.476247137778, 5926.762929482858, 5980.671063091485, 5981.581289309794, 5913.935491611465, 6023.6385816851125, 6113.202667687823, 6125.907024958145, 6138.202033735586, 4772.546608072227, 4774.427068751772, 4784.760761961888, 4805.8558243252755, 4820.0, 4225.9788701056295, 4305.31115021595, 4318.050028993616, 4331.480222373272, 4374.62815660666, 5424.05079111154, 5440.0, 5482.80810171642, 5490.588205884575, 5492.450754924475, 6069.0, 6078.3921607838865, 6082.270127584629, 6091.482224011009, 6091.5735898487565, 5461.0716178249795, 5497.120460726344, 5498.0, 5506.779728810883, 5508.531774799187, 5214.113600687816, 5234.633575649668, 5267.104592219332, 5283.815066472655, 5290.047791397586, 6246.937530624727, 6275.058741188767, 6314.0844577536, 6323.27282362525, 6330.335314791972, 6133.0, 6136.877262454636, 6169.259688837368, 6170.259568851767, 6190.783322583688, 6118.010103775157, 6219.253689557101, 6312.84217894538, 6315.621062736251, 6344.555881088464, 6003.7898673546215, 6007.459328660441, 6009.579329446897, 6034.63792172471, 6053.939460605337, 6112.877742445037, 6120.3267640558615, 6136.539759518143, 6159.384061593805, 6166.660833654192, 5765.106408506688, 5880.206172166702, 5908.409159084057, 5927.288725352985, 6043.3050199227655, 5927.822165334875, 5938.317093534126, 5938.376470470538, 5949.434803693643, 5953.374895636069, 5615.157726341082, 5802.622829516068, 5807.970960145172, 5814.534837212928, 5815.709214539341, 5778.653280803165, 5819.592628515963, 5832.708364581838, 5892.440218179266, 5895.174675545341, 5690.2887139107615, 5717.514011309086, 5731.656100633975, 5739.684317362585, 5742.109972954198], "unit": "score", "name": "dojo.html", "value": 5547.008740758339}, {"lowerIsBetter": false, "replicates": [538.3889285660774, 558.059669456965, 576.9240366716073, 621.2296752027485, 633.762339122829, 29149.562756558644, 36811.447828282595, 37247.813760931225, 37418.43872341917, 37437.81281093591, 33238.670453181905, 39730.801345993226, 40335.79832100843, 40356.19287614246, 40582.59417405825, 7566.810829729259, 9573.090556397132, 9573.329866909318, 9579.80840383192, 9590.280728945358, 9390.671326503574, 9577.760555986086, 9588.0, 9590.664326748565, 9707.077827606401, 8749.693760718375, 9436.103570160823, 9647.855282170773, 9746.171575416063, 9748.463834489101, 9637.61449542021, 9686.0, 9712.3201375903, 9742.366746161477, 9764.656482444234, 9499.715008549685, 9653.469059201741, 9654.0, 9656.662016829378, 9661.806763864754, 39246.803765980985, 39617.80191099055, 39697.0, 39706.0, 39718.20563588741, 3171.841407929617, 3183.9681603183903, 3350.5141754445467, 3535.876244331436, 3788.3749181385037, 28102.0, 28130.015449459377, 28194.85902570474, 28715.994940177203, 28776.71223287782, 2643.616675582049, 2671.9332016699736, 2746.4644394343113, 2772.7781777457753, 2834.603155558203, 489065.0, 490871.5456422695, 492421.0, 492841.0, 493725.0, 63215.73568528604, 63236.0, 63369.683151583944, 63595.36404635895, 63603.6819815898, 68681.0, 69737.3026269741, 69776.65111674409, 69787.65106174437, 70011.29988700048, 16199.271032803552, 16247.918760406123, 16443.506694798936, 16465.753013704805, 16475.423360182336, 12607.684807879876, 12694.365281735876, 12710.936445317715, 12713.745725085631, 12726.618201453972, 19963.900180499004, 20630.0, 20666.0, 20678.276260331117, 20807.58384832295, 8845.203931646183, 9029.0, 9052.004279529247, 9058.184763371328, 9160.587773550205, 829.8049958259804, 932.4591736792644, 947.0907928388687, 958.4441024205944, 1174.2074099982478, 28565.714342856307, 29031.41937161245, 29268.41463170725, 29437.852810736236, 29820.701792982225, 972.2125078686287, 1022.8056669232822, 1065.9147268218524, 1106.1427393769732, 1144.7767685301453, 14595.343209555596, 14779.40662827936, 14793.92603036978, 14915.925420372829, 15268.465603703817, 451540.0, 456759.0, 460717.0, 462103.0, 462916.0, 57502.424975750546, 57881.13178302329, 58027.41972580305, 58081.0, 58127.70936145292, 1336.6057013180941, 1466.7359875222562, 1468.8090548228663, 1478.3347493627696, 1490.7763835424555, 27577.724222757515, 27790.0, 28207.57688634631, 28289.0, 28332.191900660728, 44120.779396102815, 44514.77742611396, 44549.0, 44573.77713111414, 44642.3303650452, 301702.0, 313300.0, 314518.0, 314675.0, 316134.0, 28186.0, 32509.02472925816, 32697.019089427355, 33451.16372090717, 33470.665293346756, 40960.0, 46327.30509042434, 47653.523464764905, 48368.5163148364, 48499.51500485091, 33562.0, 35311.64688353083, 37000.444993324585, 37890.0527486804, 37972.62027379691, 29495.11514654564, 29998.55002175013, 34982.30035399328, 36546.0, 36634.45048324331, 36805.44791828071, 36997.0, 37116.628833711315, 37818.62181378261, 38335.0, 24548.754512454645, 31067.84466077655, 31245.531317029807, 32503.0, 32887.34225315528, 24191.637125443485, 24226.63660045136, 24370.390740231636, 24390.75609243956, 24718.0], "unit": "score", "name": "ext.html", "value": 19288.522284621635}, {"lowerIsBetter": false, "replicates": [359.7481762766064, 362.74607774557813, 366.3552148219134, 369.6599128801502, 374.9568799588048, 19626.901865490672, 20385.388438346854, 20886.37340879772, 21089.894550527246, 21585.812780297078, 20204.29284975026, 20616.07227674758, 20968.26611068613, 20980.0, 21168.788312116874, 5857.79497717581, 5979.850503737398, 6064.3026052003925, 6067.7572897084065, 6083.117947897552, 5856.297244330665, 5895.498882594985, 5947.583669143161, 5955.910661340084, 6048.576599638027, 5972.79095231667, 5978.163057172, 5998.310194327664, 6006.8498287542725, 6009.819705408823, 5723.456271654186, 5842.415758424166, 5889.352171261158, 5892.675902825343, 5913.940860591403, 5093.617978651616, 5121.948780512184, 5129.794808207667, 5131.076406246874, 5151.45909679482, 24865.7567121645, 25271.62092568613, 25573.74426255751, 25705.0, 25747.485050299078, 2222.4777177363308, 2226.7995880370845, 2293.6674182243646, 2423.8182136339847, 2766.73715996982, 14197.716045679132, 14482.927585362111, 14572.562823115324, 14977.625559360995, 15160.545183644508, 1721.5179749670112, 1731.4372828830556, 1756.5608597850537, 1782.3583509936414, 1789.346888385743, 94915.52542237313, 97986.0, 98046.50976745143, 98085.0191498083, 98546.0, 10322.380657160595, 10791.352518848895, 11093.0, 11144.052755515871, 11291.661250162508, 13592.796108058386, 13626.659333516543, 13734.931325343508, 13736.45054197841, 13742.725145497034, 8440.957795210985, 8476.321894248445, 8509.702160424355, 8534.103919088531, 8609.268212201907, 8685.0, 8692.348073894484, 8699.739007829776, 8789.121087891288, 8822.117788221127, 4428.3136113901755, 4439.178751930903, 4445.844395446144, 4456.64346852251, 4513.413256276663, 1796.5508622844288, 1838.9701767010517, 1839.8804077734903, 1843.3548258109554, 1884.9434516964513, 911.7036962987056, 956.3257903178381, 1014.5992333028413, 1039.3348257115451, 1056.99471502642, 19972.700409493867, 20352.89823550873, 20554.0, 20593.485162870747, 21203.575928481652, 858.7380848841163, 952.3666761603456, 955.3121752338305, 987.2595553334999, 992.9453880036523, 8418.452800567944, 9668.598053282234, 10798.190135739851, 10963.256009110957, 11081.556737730562, 638529.0, 645126.0, 651049.0, 656997.0, 658496.0, 98813.50593247132, 102094.95810083757, 111536.44231778789, 111887.0, 112742.74514509663, 988.8615593816871, 992.4243938515643, 1010.1968934696934, 1014.0214692821463, 1014.974625634365, 18265.812722173017, 18539.536511587317, 18579.81420185835, 18667.626647467245, 18704.906475467535, 37546.87359379223, 51719.741401292755, 52300.0, 52737.0, 53766.92466150577, 70539.64730176317, 71872.9219061725, 72830.0, 73922.52154956764, 74001.0, 7625.961870190614, 7665.080190377191, 7672.6547305372505, 7737.729179478692, 7967.442279040411, 10212.285140040125, 12132.636020919033, 12238.87761122413, 12472.251664900135, 12537.686557835763, 9938.552765125442, 10081.14310283634, 10170.135538479017, 10226.23303252274, 10246.436445995541, 10339.379637221791, 10407.427591482541, 10585.417802020962, 10588.735281618021, 10750.946245269037, 8978.326625502983, 10087.243456740627, 10382.221333399873, 10492.422916739348, 10520.263581549218, 7501.099868015873, 7714.5756983366455, 7718.189590092959, 7798.025246844145, 7994.680212791423, 9330.253579713471, 10220.528830329482, 10261.794764104825, 10290.588376464857, 10443.738906527398], "unit": "score", "name": "jquery.html", "value": 9386.512263629804}, {"lowerIsBetter": false, "replicates": [1439.79842822005, 1571.2929181868158, 1601.6636506333673, 1901.3155264104928, 2036.5112373030477, 7941.0867750208745, 8552.48685078895, 8724.781880452976, 8726.86909696355, 8732.825343493134, 8339.708110216143, 8627.396082274243, 8659.047504774486, 8663.003754568226, 8666.090060543647, 2178.36827320077, 2423.273018094573, 2470.234227389506, 2500.599904015358, 2504.912328068518, 2494.114589320792, 2503.123906632682, 2506.8997240110375, 2509.5859183234834, 2511.3847107458605, 2421.8425802322795, 2470.555300046, 2489.601663733803, 2491.402063504764, 2492.887820048093, 1845.3356791555098, 2432.6837511123617, 2485.751424857518, 2486.0677246032737, 2486.8880900359436, 2457.8771061447037, 2461.7661322174363, 2498.025769949721, 2498.387894965745, 2502.0742325339743, 8591.957040214822, 8680.739577812612, 8685.001224859096, 8686.782830429227, 8723.12768723129, 5377.865553361197, 5494.450554944514, 5498.257735205736, 5524.116141417354, 5546.223528705985, 3565.2156525564333, 3583.4087375583, 3677.613850545681, 3711.3319602471543, 3733.8879833605033, 1037.3101887244973, 1055.3034996902009, 1057.746140926172, 1060.607575197182, 1068.5779117248644, 11847.052235821113, 11872.584459543961, 11873.762524749456, 11884.940575297069, 11903.285802851857, 4877.487863774252, 4901.877453063702, 4915.58217551505, 4951.653384263067, 4953.331300274489, 10065.34575252621, 10088.344257623232, 10100.848487272697, 10196.541155648014, 10197.031282028196, 5452.890942181134, 5456.372517160498, 5457.863553411117, 5458.372287187024, 5464.0711079116645, 4359.542248063971, 4437.245668236407, 4437.400950871655, 4444.2222611042935, 4536.251518499476, 3870.148567315186, 3937.2322397132284, 3980.6616437602547, 3996.0609256824623, 4006.2988976928923, 1326.8739469750358, 1330.0955350361653, 1331.9933400332936, 1334.0594880609146, 1338.5649663859285, 1320.4850108457708, 1324.4304948872077, 1353.5127354152498, 1387.7848933415135, 1388.5487216654628, 7973.521588704581, 8058.274755272054, 8185.918140818635, 8201.466904651179, 8201.8359632807, 502.9069622119919, 513.2199057432681, 514.5343464164937, 516.0581937963157, 516.9870753231199, 6180.072989051589, 6225.906611400833, 6259.624422534663, 6271.247450305992, 6275.901717199472, 10294.0, 10696.358218506915, 10792.676219713421, 10805.783884322269, 10820.621278255223, 10427.009434103747, 10430.956904309509, 10610.151187904949, 10667.83998240027, 10670.83993740079, 6506.837329066717, 8261.967254093359, 8268.875966860502, 8338.666453341799, 8363.03825060126, 6342.587731797418, 7701.961490192513, 7833.060032796101, 7835.0, 8033.638486268015, 9337.393069450463, 9364.110409511086, 9377.671781487616, 9433.386829856037, 9433.764155895882, 9375.578098985425, 9657.0, 9701.417914925127, 9798.65704700332, 9843.360181588174, 6751.696173672295, 6798.898016529657, 7361.484696071224, 7463.962680186564, 7470.215627359049, 8091.474054186459, 8172.468789528662, 8185.4270201085355, 8201.09787923316, 8210.261076503144, 7176.641167941478, 7264.0, 7280.9271907280245, 7386.630668466662, 7397.260273972775, 7148.606826624586, 7153.0, 7221.205667376479, 7308.817279568053, 7310.013148224922, 7396.704131834666, 7605.125410577854, 7664.578448185403, 7672.462927595015, 7688.961555192188, 6933.82665433348, 6952.478564107611, 6987.441004719509, 6992.895106573304, 6999.1950925644205, 6436.774712885027, 6768.0, 6971.337722916315, 6987.825304367431, 7068.257832927468], "unit": "score", "name": "mootools.html", "value": 4813.810495956758}, {"lowerIsBetter": false, "replicates": [266.7919023161934, 331.312526507497, 332.9700326970573, 337.5645417411539, 337.71463113668943, 6400.1359816424765, 6648.434883034942, 6649.035889795977, 6672.232693240278, 6684.29814869439, 6511.479081673467, 6551.4431273341825, 6566.146400967879, 6567.408933196023, 6611.504137189718, 4620.907581848361, 4716.669833111683, 4731.929021064687, 4886.755662216884, 4900.289458028584, 4817.735024573647, 4835.806567737286, 4843.806247750086, 4865.6107511399005, 4890.706557606537, 4762.761861906891, 4770.928436073462, 4784.78468468918, 4794.1610218211845, 4795.0, 4568.132054909556, 4647.814087436498, 4774.928376074362, 4778.80884764609, 4778.976105119469, 4110.568390319003, 4124.896877578085, 4136.255474014676, 4137.40007698885, 4143.3370660694145, 6162.691865406757, 6168.136460895478, 6198.132261483396, 6241.375862413768, 6322.589031712924, 5725.570582206351, 5728.570357223183, 5736.024875771129, 5736.569757268222, 5739.110437882093, 5759.913601295984, 6965.79102626922, 6980.057692211588, 6990.790276291719, 6991.916252980796, 4372.781360931941, 4530.637548996073, 4556.0, 4680.765961701935, 4681.50844161365, 6648.534602577822, 6739.1239138912115, 7223.747168849118, 7302.634868256566, 7327.267273272683, 4615.9076818463445, 4619.099275641218, 4620.422447194101, 4624.260118381043, 4635.3742244797195, 4669.813207471663, 4696.8590942271785, 4700.412448443944, 4702.788374523155, 4739.123262196505, 5555.055640541118, 5570.916436253459, 5576.665400075927, 5577.6932268724795, 5581.860453488614, 6747.291534388916, 6993.89509157363, 6995.26549712283, 7006.474514411338, 7015.9298407016295, 1606.6224437257235, 1614.5398561409943, 1631.9718577296228, 1634.7466142747894, 1637.6806522727954, 865.35098675993, 1028.6194108179873, 1048.1038711901367, 1050.3435352904435, 1055.4933631856752, 6284.842878928063, 6460.612363258219, 6474.320196379406, 6591.736330546724, 6624.834379140464, 7331.303526165006, 7341.192468828424, 7345.70617175307, 7373.631318434057, 7410.5183163094225, 6538.215414150332, 6548.508861835381, 6548.574342667712, 6555.016747487915, 6558.475321974231, 3848.5766565677754, 3895.824687889052, 3898.785566793797, 3901.5318161820765, 3904.902377440587, 6251.499880009588, 7270.563766174047, 7606.771796846104, 7621.847563048708, 7683.0, 5508.228847961289, 6131.478824299896, 6182.443580077725, 7552.811179720551, 7562.168161502231, 6139.293981192041, 6205.472534834499, 7595.0, 7627.389808815282, 7634.923650763532, 7322.1579518356075, 7339.522931009467, 7350.77947661571, 7374.225706300761, 7383.187849336676, 6929.09449901261, 7190.280971902768, 7218.0, 7226.349628533457, 7229.530080544748, 7523.0, 7586.734464293723, 7587.58268295249, 7597.810054748676, 7599.050118735158, 4654.813807447664, 4657.301404789308, 4662.254039353687, 4675.555822196886, 4675.719456832601, 7254.419646428168, 7262.237465066092, 7268.636568171676, 7270.382017528569, 7274.127104747464, 6838.93161068383, 7081.964590177222, 7120.608366539683, 7120.715171393086, 7123.323284287984, 7027.297270273137, 7045.11936007999, 7061.929380706332, 7080.787576372717, 7091.290870912868, 5610.438956104357, 6906.585604863724, 6941.826454338682, 6944.097267355211, 6953.895691564529, 6763.830904227434, 7075.433965282868, 7100.502964792415, 7107.111611048619, 7120.145582530129, 6615.735370585123, 6788.9660551696925, 6802.387785099365, 6908.032875397348, 6942.757003504853], "unit": "score", "name": "prototype.html", "value": 5094.024579798507}, {"lowerIsBetter": false, "replicates": [654.5876098058222, 685.4276678973057, 710.1371833222637, 718.4037249083261, 775.9834616652186, 14252.786208206886, 14318.785218221721, 14528.564143075724, 14533.200673962929, 14538.927305363472, 13295.135816171942, 13431.529896453627, 13433.798493022588, 13435.26106064166, 13476.393562289695, 760.1941941541955, 920.0569416348229, 936.840737074699, 947.6777895515523, 949.0746522140892, 769.0118198115423, 919.5907821019649, 949.1125797379437, 950.7765675066354, 952.5189779161514, 1000.7197984564334, 1000.9099181073702, 1005.3214080495673, 1007.2043085962081, 1008.2387797213094, 790.2413682864457, 790.8102055506695, 1000.8198524265629, 1002.8245057115012, 1003.9759445365722, 594.7234535940809, 602.5691630484181, 726.3426598927979, 739.7484855149221, 740.0120838680368, 14214.005019648628, 14283.21442320672, 14298.714025719531, 14302.356393962296, 14312.42750289987, 10308.896911030868, 12052.276863388137, 12139.453724582416, 12233.388330583524, 12535.56125535611, 9721.56252968611, 9747.220222382193, 9772.169365603932, 9873.259505537042, 10039.89960100397, 3294.044727029159, 3322.1694576355912, 3326.417876871538, 3354.1446931032674, 3403.3363494118657, 82330.53008409757, 82349.0, 82413.0, 82418.76371854427, 82534.0, 9147.954260228656, 9150.908490915006, 9245.676401325922, 9342.439453632804, 9749.707508774749, 20890.268840590812, 20918.372448826558, 20968.370948871558, 20972.475688107614, 21002.579948400948, 7272.63636818157, 7302.415806735448, 7311.268873112646, 7403.592802395812, 7449.515781474187, 3910.8631197907935, 3980.3432433648704, 3989.6209860063245, 4000.4999375078114, 4019.0354314964197, 3400.8639654413546, 3426.9143271417915, 3448.655134486531, 3451.2579795344122, 3452.016175390002, 593.6171169595586, 625.1966223402906, 633.8256979330721, 642.3095172689377, 646.802725168828, 528.6273177409917, 555.7443575955025, 568.863472766533, 587.7267070812093, 609.868878191191, 7596.354309883612, 7797.844043119106, 7877.7636670899965, 8112.391570632109, 8202.0, 500.47950131863183, 509.6508891409396, 563.7660370946094, 570.1675553691657, 576.6770608459276, 3639.8544058237903, 3640.8179591020344, 3684.1894783147663, 3810.580836108026, 3869.542840296432, 87874.56062719645, 89484.5525772367, 89958.0, 90143.0, 90220.0, 77071.0, 78961.0, 79102.41795164064, 79254.01864953422, 80427.19572804314, 69413.65293173502, 69483.30516694768, 69562.0, 70478.0, 70536.64731676309, 7354.411647068328, 7373.262673732584, 7435.442341824277, 7579.810504737426, 7795.259450352208, 46479.0, 50524.49475505345, 50564.988700225054, 50801.74599126981, 51105.2113176037, 62895.0, 68463.3153668457, 69828.30171698218, 70320.29679703138, 71600.64199678968, 8229.95885020595, 9898.455584942898, 9900.35647682927, 9938.006199380005, 10376.481175941022, 8704.56477176126, 10637.734056648645, 10809.837852432063, 10845.511951962339, 10906.61826836057, 10063.868386391545, 10147.594096236067, 10148.188144948239, 10173.949130254301, 10367.844482332923, 10004.699859004242, 10415.68752937413, 10554.208434367607, 10927.617533386294, 11048.392338421463, 10671.413072281099, 10735.194860385658, 11055.22613417053, 11062.502187401748, 11070.446477675923, 9105.0, 9148.862767058366, 9424.905750942402, 9467.810643786948, 9537.998510156334, 8331.67330677291, 8473.83052338962, 9292.907070929205, 9296.767580810534, 9392.389494682824], "unit": "score", "name": "yui.html", "value": 6668.922216290094}], "name": "dromaeo_css", "value": 7400.320818527159}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 110.0, 112.0, 112.0, 110.0, 117.0, 110.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 148.0, 190.0, 145.0, 125.0, 161.0, 103.0, 181.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [188.0, 187.0, 185.0, 184.0, 186.0, 184.0, 187.0, 179.0, 183.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [81.0, 72.0, 84.0, 78.0, 56.0, 57.0, 58.0, 79.0, 84.0, 75.0], "unit": "score", "name": "audio-fft", "value": 72.4}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 131.0, 80.0, 78.0, 87.0, 115.0, 77.0, 80.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 94.4}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 88.0, 86.0, 133.0, 122.0, 89.0, 84.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 117.0, 93.0, 93.0, 94.0, 93.0, 98.0, 96.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 96.2}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 85.0, 88.0, 88.0, 86.0, 85.0, 87.0, 84.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.4}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 53.0, 54.0, 53.0, 54.0, 53.0, 65.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [64.0, 75.0, 76.0, 74.0, 71.0, 67.0, 67.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 82.0, 83.0, 82.0, 80.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [130.0, 129.0, 131.0, 107.0, 131.0, 128.0, 129.0, 129.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [157.0, 165.0, 176.0, 120.0, 164.0, 165.0, 173.0, 162.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.6}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 67.0, 68.0, 66.0, 69.0, 68.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1442.4999999999998}]} 05:51:48 INFO - Return code: 0 05:51:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:51:48 ERROR - # TBPL SUCCESS # 05:51:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:48 INFO - 2016-03-12 05:51:48.218 screenresolution[2004:18561] starting screenresolution argv=screenresolution get 05:51:48 INFO - 2016-03-12 05:51:48.221 screenresolution[2004:18561] Display 0: 1600x1200x32@60 05:51:48 INFO - 2016-03-12 05:51:48.227 screenresolution[2005:18564] starting screenresolution argv=screenresolution list 05:51:48 INFO - Available Modes on Display 0 05:51:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:48 INFO - Intel Iris: 05:51:48 INFO - Chipset Model: Intel Iris 05:51:48 INFO - Type: GPU 05:51:48 INFO - Bus: Built-In 05:51:48 INFO - VRAM (Dynamic, Max): 1536 MB 05:51:48 INFO - Vendor: Intel (0x8086) 05:51:48 INFO - Device ID: 0x0a2e 05:51:48 INFO - Revision ID: 0x0009 05:51:48 INFO - Displays: 05:51:48 INFO - Display: 05:51:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:48 INFO - Display Serial Number: 1600x1200 60 05:51:48 INFO - Main Display: Yes 05:51:48 INFO - Mirror: Off 05:51:48 INFO - Online: Yes 05:51:48 INFO - Rotation: Supported 05:51:48 INFO - Return code: 0 05:51:48 INFO - Running post-action listener: _resource_record_post_action 05:51:48 INFO - Running post-run listener: _resource_record_post_run 05:51:49 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2383872; Write bytes: 704419840; Read time: 39; Write time: 1870 05:51:49 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399397376; Write bytes: 394061824; Read time: 30461; Write time: 771 05:51:49 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2383872; Write bytes: 299368448; Read time: 39; Write time: 1063 05:51:49 INFO - Running post-run listener: _upload_blobber_files 05:51:49 INFO - Blob upload gear active. 05:51:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:51:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:51:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:50 INFO - (blobuploader) - INFO - Done attempting. 05:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:51 INFO - (blobuploader) - INFO - Done attempting. 05:51:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:51 INFO - Return code: 0 05:51:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26d1fc9faed2fe591f9a3471e8b4f11b603395925559dd05d633b20c407dbf0f19e7b7ad2a99ac420a96d3f1f34ef9852ed62aa6d73cfb9db26c56afcb350e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/646e4a615b0b5b23f407dfc568968667723cffad590d8f43e49d0bedb209e364e2060aac930a579ba0b0c8d95966dd90cb3312d1e5f7497e42932cd7c26adbf2"} 05:51:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:51 INFO - Contents: 05:51:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26d1fc9faed2fe591f9a3471e8b4f11b603395925559dd05d633b20c407dbf0f19e7b7ad2a99ac420a96d3f1f34ef9852ed62aa6d73cfb9db26c56afcb350e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/646e4a615b0b5b23f407dfc568968667723cffad590d8f43e49d0bedb209e364e2060aac930a579ba0b0c8d95966dd90cb3312d1e5f7497e42932cd7c26adbf2"} 05:51:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:51 INFO - Copying logs to upload dir... 05:51:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1304.156014 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-03-12 05:51:51.936821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 05:51:51.941383) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26d1fc9faed2fe591f9a3471e8b4f11b603395925559dd05d633b20c407dbf0f19e7b7ad2a99ac420a96d3f1f34ef9852ed62aa6d73cfb9db26c56afcb350e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/646e4a615b0b5b23f407dfc568968667723cffad590d8f43e49d0bedb209e364e2060aac930a579ba0b0c8d95966dd90cb3312d1e5f7497e42932cd7c26adbf2"} build_url:https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26d1fc9faed2fe591f9a3471e8b4f11b603395925559dd05d633b20c407dbf0f19e7b7ad2a99ac420a96d3f1f34ef9852ed62aa6d73cfb9db26c56afcb350e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/646e4a615b0b5b23f407dfc568968667723cffad590d8f43e49d0bedb209e364e2060aac930a579ba0b0c8d95966dd90cb3312d1e5f7497e42932cd7c26adbf2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 05:51:51.972267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:51:51.972601) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WC2SRpnTpL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.2nXO9iRRep/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005273 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:51:52.021747) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 05:51:52.025097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 05:51:52.025480) ========= ========= Total master_lag: 0.50 =========