builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0067 starttime: 1459560634.99 results: success (0) buildid: 20160401173744 builduid: 3bcc6682f9624926aab4e4a37e0d52ee revision: 7e4c0bee56f35104a4809121e8672f1e659258f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:34.991424) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:34.991857) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-04-01 18:30:34.992138) ========= 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.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005568 basedir: '/builds/slave/test' ========= master_lag: 1.73 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-04-01 18:30:36.724732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:36.725068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:36.802943) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:36.803219) ========= 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.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005212 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:36.886453) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:36.886769) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:36.887117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:36.887423) ========= 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.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-04-01 18:30:36-- 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% 8.08M=0.001s 2016-04-01 18:30:37 (8.08 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.514855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:37.425107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:37.428450) ========= 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.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.020454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:37.477632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 18:30:37.477955) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7e4c0bee56f35104a4809121e8672f1e659258f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7e4c0bee56f35104a4809121e8672f1e659258f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-04-01 18:30:37,576 truncating revision to first 12 chars 2016-04-01 18:30:37,576 Setting DEBUG logging. 2016-04-01 18:30:37,576 attempt 1/10 2016-04-01 18:30:37,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7e4c0bee56f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 18:30:38,677 unpacking tar archive at: fx-team-7e4c0bee56f3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.347505 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 18:30:38.845010) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:38.848362) ========= echo 7e4c0bee56f35104a4809121e8672f1e659258f5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7e4c0bee56f35104a4809121e8672f1e659258f5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 7e4c0bee56f35104a4809121e8672f1e659258f5 program finished with exit code 0 elapsedTime=0.005096 script_repo_revision: '7e4c0bee56f35104a4809121e8672f1e659258f5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:38.905620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:38.905907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 18:30:38.925726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-01 18:30:38.925992) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:30:39 INFO - MultiFileLogger online at 20160401 18:30:39 in /builds/slave/test 18:30:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:30:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:39 INFO - {'append_to_log': False, 18:30:39 INFO - 'base_work_dir': '/builds/slave/test', 18:30:39 INFO - 'blob_upload_branch': 'Fx-Team', 18:30:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:39 INFO - 'branch': 'Fx-Team', 18:30:39 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:39 INFO - 'config_files': ('talos/mac_config.py',), 18:30:39 INFO - 'default_actions': ('clobber', 18:30:39 INFO - 'read-buildbot-config', 18:30:39 INFO - 'download-and-extract', 18:30:39 INFO - 'populate-webroot', 18:30:39 INFO - 'create-virtualenv', 18:30:39 INFO - 'install', 18:30:39 INFO - 'run-tests'), 18:30:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:39 INFO - 'download_minidump_stackwalk': True, 18:30:39 INFO - 'download_symbols': 'ondemand', 18:30:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:39 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:39 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:39 INFO - 'installer_path': 'installer.exe', 18:30:39 INFO - 'log_level': 'info', 18:30:39 INFO - 'log_name': 'talos', 18:30:39 INFO - 'log_to_console': True, 18:30:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:30:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:30:39 INFO - 'opt_config_files': (), 18:30:39 INFO - 'pip_index': False, 18:30:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:39 INFO - 'cmd': ('bash', 18:30:39 INFO - '-c', 18:30:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:39 INFO - 'enabled': True, 18:30:39 INFO - 'halt_on_failure': False, 18:30:39 INFO - 'name': 'check_screen_resolution'},), 18:30:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:39 INFO - 'cmd': ('bash', 18:30:39 INFO - '-c', 18:30:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:39 INFO - 'enabled': True, 18:30:39 INFO - 'halt_on_failure': False, 18:30:39 INFO - 'name': 'check_screen_resolution'},), 18:30:39 INFO - 'run_cmd_checks_enabled': True, 18:30:39 INFO - 'sps_profile': False, 18:30:39 INFO - 'sps_profile_interval': 0, 18:30:39 INFO - 'suite': 'dromaeojs', 18:30:39 INFO - 'system_bits': '32', 18:30:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:39 INFO - 'title': 't-yosemite-r7-0067', 18:30:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:39 INFO - 'use_talos_json': True, 18:30:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:39 INFO - 'work_dir': 'build'} 18:30:39 INFO - ##### 18:30:39 INFO - ##### Running clobber step. 18:30:39 INFO - ##### 18:30:39 INFO - Running pre-action listener: _resource_record_pre_action 18:30:39 INFO - Running main action method: clobber 18:30:39 INFO - rmtree: /builds/slave/test/build 18:30:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:40 INFO - Running post-action listener: _resource_record_post_action 18:30:40 INFO - ##### 18:30:40 INFO - ##### Running read-buildbot-config step. 18:30:40 INFO - ##### 18:30:40 INFO - Running pre-action listener: _resource_record_pre_action 18:30:40 INFO - Running main action method: read_buildbot_config 18:30:40 INFO - Using buildbot properties: 18:30:40 INFO - { 18:30:40 INFO - "project": "", 18:30:40 INFO - "product": "firefox", 18:30:40 INFO - "script_repo_revision": "production", 18:30:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:30:40 INFO - "repository": "", 18:30:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:30:40 INFO - "buildid": "20160401173744", 18:30:40 INFO - "pgo_build": "False", 18:30:40 INFO - "basedir": "/builds/slave/test", 18:30:40 INFO - "buildnumber": 665, 18:30:40 INFO - "slavename": "t-yosemite-r7-0067", 18:30:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:30:40 INFO - "platform": "yosemite_r7", 18:30:40 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:30:40 INFO - "branch": "fx-team", 18:30:40 INFO - "repo_path": "integration/fx-team", 18:30:40 INFO - "revision": "7e4c0bee56f35104a4809121e8672f1e659258f5", 18:30:40 INFO - "stage_platform": "macosx64", 18:30:40 INFO - "builduid": "3bcc6682f9624926aab4e4a37e0d52ee", 18:30:40 INFO - "slavebuilddir": "test" 18:30:40 INFO - } 18:30:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:30:40 INFO - Running post-action listener: _resource_record_post_action 18:30:40 INFO - ##### 18:30:40 INFO - ##### Running download-and-extract step. 18:30:40 INFO - ##### 18:30:40 INFO - Running pre-action listener: _resource_record_pre_action 18:30:40 INFO - Running main action method: download_and_extract 18:30:40 INFO - mkdir: /builds/slave/test/build/tests 18:30:40 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')]} 18:30:40 INFO - https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:30:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:30:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:30:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:41 INFO - Downloaded 1199 bytes. 18:30:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:30:41 INFO - Using the following test package requirements: 18:30:41 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:30:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:30:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:30:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'jsshell-mac.zip'], 18:30:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:30:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:30:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:30:41 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:30:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:30:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:30:41 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:30:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:30:41 INFO - https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:43 INFO - Downloaded 17959787 bytes. 18:30:43 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'] 18:30:43 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 18:30:46 INFO - Return code: 0 18:30:46 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 18:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:46 INFO - https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:30:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:30:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:30:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:47 INFO - Downloaded 17959787 bytes. 18:30:47 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'] 18:30:47 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 18:30:50 INFO - Return code: 0 18:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:50 INFO - https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:52 INFO - Downloaded 10847584 bytes. 18:30:52 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'] 18:30:52 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 18:30:53 INFO - Return code: 0 18:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:53 INFO - https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:30:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:30:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:30:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:30:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zkayfi3fSVOmhAOiOuzRXA/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 18:30:56 INFO - Downloaded 111479214 bytes. 18:30:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:30:56 INFO - mkdir: /builds/slave/test/properties 18:30:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:30:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:30:56 INFO - Contents: 18:30:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:30:57 INFO - Running post-action listener: _resource_record_post_action 18:30:57 INFO - Running post-action listener: set_extra_try_arguments 18:30:57 INFO - ##### 18:30:57 INFO - ##### Running populate-webroot step. 18:30:57 INFO - ##### 18:30:57 INFO - Running pre-action listener: _resource_record_pre_action 18:30:57 INFO - Running main action method: populate_webroot 18:30:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:30:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:30:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:30:57 INFO - '--tppagecycles', 18:30:57 INFO - '7'], 18:30:57 INFO - 'tests': ['tsvgm']}}, 18:30:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:30:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:30:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:30:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:30:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'tests': ['damp', 'tps']}, 18:30:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['damp', 'tps']}, 18:30:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:30:57 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['dromaeo_dom']}, 18:30:57 INFO - 'other': {'tests': ['a11yr', 18:30:57 INFO - 'ts_paint', 18:30:57 INFO - 'tpaint', 18:30:57 INFO - 'sessionrestore', 18:30:57 INFO - 'sessionrestore_no_auto_restore', 18:30:57 INFO - 'tabpaint']}, 18:30:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['a11yr', 18:30:57 INFO - 'ts_paint', 18:30:57 INFO - 'tpaint', 18:30:57 INFO - 'sessionrestore', 18:30:57 INFO - 'sessionrestore_no_auto_restore', 18:30:57 INFO - 'tabpaint']}, 18:30:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['a11yr', 18:30:57 INFO - 'ts_paint', 18:30:57 INFO - 'tpaint', 18:30:57 INFO - 'sessionrestore', 18:30:57 INFO - 'sessionrestore_no_auto_restore', 18:30:57 INFO - 'tabpaint']}, 18:30:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['a11yr', 18:30:57 INFO - 'ts_paint', 18:30:57 INFO - 'tpaint', 18:30:57 INFO - 'sessionrestore', 18:30:57 INFO - 'sessionrestore_no_auto_restore', 18:30:57 INFO - 'tabpaint']}, 18:30:57 INFO - 'other_l64': {'tests': ['a11yr', 18:30:57 INFO - 'ts_paint', 18:30:57 INFO - 'tpaint', 18:30:57 INFO - 'sessionrestore', 18:30:57 INFO - 'sessionrestore_no_auto_restore', 18:30:57 INFO - 'tabpaint']}, 18:30:57 INFO - 'other_nol64': {'tests': ['a11yr', 18:30:57 INFO - 'ts_paint', 18:30:57 INFO - 'tpaint', 18:30:57 INFO - 'sessionrestore', 18:30:57 INFO - 'sessionrestore_no_auto_restore', 18:30:57 INFO - 'tabpaint']}, 18:30:57 INFO - 'svgr': {'tests': ['tsvgx', 18:30:57 INFO - 'tsvgr_opacity', 18:30:57 INFO - 'tart', 18:30:57 INFO - 'tscrollx', 18:30:57 INFO - 'cart']}, 18:30:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['tsvgx', 18:30:57 INFO - 'tsvgr_opacity', 18:30:57 INFO - 'tart', 18:30:57 INFO - 'tscrollx', 18:30:57 INFO - 'cart']}, 18:30:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'tests': ['tp5o']}, 18:30:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'talos_options': ['--e10s'], 18:30:57 INFO - 'tests': ['tp5o']}, 18:30:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'talos_options': ['--xperf_path', 18:30:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:57 INFO - 'tests': ['tp5n']}, 18:30:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:57 INFO - 'talos_options': ['--e10s', 18:30:57 INFO - '--xperf_path', 18:30:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:57 INFO - 'tests': ['tp5n']}}, 18:30:57 INFO - 'talos.zip': {'path': '', 18:30:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:30:57 INFO - Running post-action listener: _resource_record_post_action 18:30:57 INFO - ##### 18:30:57 INFO - ##### Running create-virtualenv step. 18:30:57 INFO - ##### 18:30:57 INFO - Running pre-action listener: _resource_record_pre_action 18:30:57 INFO - Running main action method: create_virtualenv 18:30:57 INFO - Creating virtualenv /builds/slave/test/build/venv 18:30:57 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 18:30:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:30:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:30:57 INFO - Using real prefix '/tools/python27' 18:30:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:30:58 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:00 INFO - Installing pip.................done. 18:31:01 INFO - Return code: 0 18:31:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:01 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:01 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 18:31:01 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 18:31:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:01 INFO - 'HOME': '/Users/cltbld', 18:31:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:01 INFO - 'LOGNAME': 'cltbld', 18:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:01 INFO - 'MOZ_NO_REMOTE': '1', 18:31:01 INFO - 'NO_EM_RESTART': '1', 18:31:01 INFO - 'PAGER': '/bin/cat', 18:31:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:01 INFO - 'PWD': '/builds/slave/test', 18:31:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:01 INFO - 'SHELL': '/bin/bash', 18:31:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:01 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:01 INFO - 'USER': 'cltbld', 18:31:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:01 INFO - 'XPC_FLAGS': '0x0', 18:31:01 INFO - 'XPC_SERVICE_NAME': '0', 18:31:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:01 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 18:31:01 INFO - Cleaning up... 18:31:01 INFO - Return code: 0 18:31:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:01 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:01 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 18:31:01 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 18:31:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:01 INFO - 'HOME': '/Users/cltbld', 18:31:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:01 INFO - 'LOGNAME': 'cltbld', 18:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:01 INFO - 'MOZ_NO_REMOTE': '1', 18:31:01 INFO - 'NO_EM_RESTART': '1', 18:31:01 INFO - 'PAGER': '/bin/cat', 18:31:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:01 INFO - 'PWD': '/builds/slave/test', 18:31:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:01 INFO - 'SHELL': '/bin/bash', 18:31:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:01 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:01 INFO - 'USER': 'cltbld', 18:31:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:01 INFO - 'XPC_FLAGS': '0x0', 18:31:01 INFO - 'XPC_SERVICE_NAME': '0', 18:31:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:01 INFO - Downloading/unpacking psutil>=0.7.1 18:31:01 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 18:31:01 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 18:31:01 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 18:31:01 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 18:31:01 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 18:31:01 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 18:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:04 INFO - Installing collected packages: psutil 18:31:04 INFO - Running setup.py install for psutil 18:31:04 INFO - building 'psutil._psutil_osx' extension 18:31:04 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 18:31:05 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 18:31:05 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 18:31:05 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 18:31:05 INFO - building 'psutil._psutil_posix' extension 18:31:05 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 18:31:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:31:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:31:05 INFO - ^ 18:31:05 INFO - 1 warning generated. 18:31:05 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 18:31:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:05 INFO - Successfully installed psutil 18:31:05 INFO - Cleaning up... 18:31:05 INFO - Return code: 0 18:31:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:31:05 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')]} 18:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:05 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')]} 18:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:05 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:05 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 18:31:05 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 18:31:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:05 INFO - 'HOME': '/Users/cltbld', 18:31:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:05 INFO - 'LOGNAME': 'cltbld', 18:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:05 INFO - 'MOZ_NO_REMOTE': '1', 18:31:05 INFO - 'NO_EM_RESTART': '1', 18:31:05 INFO - 'PAGER': '/bin/cat', 18:31:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:05 INFO - 'PWD': '/builds/slave/test', 18:31:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:05 INFO - 'SHELL': '/bin/bash', 18:31:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:05 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:05 INFO - 'USER': 'cltbld', 18:31:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:05 INFO - 'XPC_FLAGS': '0x0', 18:31:05 INFO - 'XPC_SERVICE_NAME': '0', 18:31:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:31:06 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 18:31:06 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 18:31:06 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 18:31:06 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 18:31:06 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 18:31:06 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 18:31:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:31:08 INFO - Installing collected packages: mozsystemmonitor 18:31:08 INFO - Running setup.py install for mozsystemmonitor 18:31:08 INFO - Successfully installed mozsystemmonitor 18:31:08 INFO - Cleaning up... 18:31:08 INFO - Return code: 0 18:31:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:08 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:08 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 18:31:08 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 18:31:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:08 INFO - 'HOME': '/Users/cltbld', 18:31:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:08 INFO - 'LOGNAME': 'cltbld', 18:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:08 INFO - 'MOZ_NO_REMOTE': '1', 18:31:08 INFO - 'NO_EM_RESTART': '1', 18:31:08 INFO - 'PAGER': '/bin/cat', 18:31:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:08 INFO - 'PWD': '/builds/slave/test', 18:31:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:08 INFO - 'SHELL': '/bin/bash', 18:31:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:08 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:08 INFO - 'USER': 'cltbld', 18:31:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:08 INFO - 'XPC_FLAGS': '0x0', 18:31:08 INFO - 'XPC_SERVICE_NAME': '0', 18:31:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:08 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:08 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 18:31:08 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 18:31:08 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 18:31:08 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 18:31:08 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 18:31:08 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 18:31:11 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18: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 18: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 18: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 18: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 18: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 18: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 18:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:12 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 18:31:12 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 18:31:12 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 18:31:12 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 18:31:12 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 18:31:12 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 18:31:12 INFO - Downloading docopt-0.6.1.tar.gz 18:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:12 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:12 INFO - Running setup.py install for blobuploader 18:31:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:12 INFO - Running setup.py install for requests 18:31:13 INFO - Running setup.py install for docopt 18:31:13 INFO - Successfully installed blobuploader requests docopt 18:31:13 INFO - Cleaning up... 18:31:13 INFO - Return code: 0 18:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:13 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:13 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 18:31:13 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 18:31:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:13 INFO - 'HOME': '/Users/cltbld', 18:31:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:13 INFO - 'LOGNAME': 'cltbld', 18:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:13 INFO - 'MOZ_NO_REMOTE': '1', 18:31:13 INFO - 'NO_EM_RESTART': '1', 18:31:13 INFO - 'PAGER': '/bin/cat', 18:31:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:13 INFO - 'PWD': '/builds/slave/test', 18:31:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:13 INFO - 'SHELL': '/bin/bash', 18:31:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:13 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:13 INFO - 'USER': 'cltbld', 18:31:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:13 INFO - 'XPC_FLAGS': '0x0', 18:31:13 INFO - 'XPC_SERVICE_NAME': '0', 18:31:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:13 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-JZvY1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:13 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FdJQcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:13 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-JS3qVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-GPcQYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-4A0Z_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ApqHGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Y_gWjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-JA48OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-IY0zxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-xSKb8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Jv2mEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-i2_k2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-elWcEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Lmy8qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-I1f3r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-I3Fac5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-_uzAay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:15 INFO - Running setup.py install for manifestparser 18:31:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:15 INFO - Running setup.py install for mozcrash 18:31:15 INFO - Running setup.py install for mozdebug 18:31:15 INFO - Running setup.py install for mozdevice 18:31:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Running setup.py install for mozfile 18:31:16 INFO - Running setup.py install for mozhttpd 18:31:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Running setup.py install for mozinfo 18:31:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Running setup.py install for mozInstall 18:31:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:16 INFO - Running setup.py install for mozleak 18:31:16 INFO - Running setup.py install for mozlog 18:31:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:17 INFO - Running setup.py install for moznetwork 18:31:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:17 INFO - Running setup.py install for mozprocess 18:31:17 INFO - Running setup.py install for mozprofile 18:31:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:17 INFO - Running setup.py install for mozrunner 18:31:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:17 INFO - Running setup.py install for mozscreenshot 18:31:17 INFO - Running setup.py install for moztest 18:31:17 INFO - Running setup.py install for mozversion 18:31:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:18 INFO - Cleaning up... 18:31:18 INFO - Return code: 0 18:31:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:18 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')]} 18:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:18 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')]} 18:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:18 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:18 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 18:31:18 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 18:31:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:18 INFO - 'HOME': '/Users/cltbld', 18:31:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:18 INFO - 'LOGNAME': 'cltbld', 18:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:18 INFO - 'MOZ_NO_REMOTE': '1', 18:31:18 INFO - 'NO_EM_RESTART': '1', 18:31:18 INFO - 'PAGER': '/bin/cat', 18:31:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:18 INFO - 'PWD': '/builds/slave/test', 18:31:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:18 INFO - 'SHELL': '/bin/bash', 18:31:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:18 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:18 INFO - 'USER': 'cltbld', 18:31:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:18 INFO - 'XPC_FLAGS': '0x0', 18:31:18 INFO - 'XPC_SERVICE_NAME': '0', 18:31:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:18 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-7qZwC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:18 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)) 18:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:18 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Afki06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:18 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)) 18:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:18 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-IlRFIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:18 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)) 18:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:18 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-eLzAYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:18 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)) 18:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:18 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-A920Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:18 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)) 18:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:18 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ry2WO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Qld4u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-0n9OPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-wRByum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-fcfbYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-B0Wnaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-yqMTm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-wLbgXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-MOxVSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-_F7uCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:19 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)) 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FFzXQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:20 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)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-z2hLXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:20 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)) 18:31:20 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)) 18:31:20 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)) 18:31:20 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)) 18:31:20 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)) 18:31:20 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)) 18:31:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:20 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 18:31:20 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 18:31:20 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 18:31:20 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 18:31:20 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 18:31:20 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 18:31:22 INFO - Downloading blessings-1.6.tar.gz 18:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:22 INFO - Installing collected packages: blessings 18:31:22 INFO - Running setup.py install for blessings 18:31:22 INFO - Successfully installed blessings 18:31:22 INFO - Cleaning up... 18:31:22 INFO - Return code: 0 18:31:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:23 INFO - Reading from file tmpfile_stdout 18:31:23 INFO - Current package versions: 18:31:23 INFO - blessings == 1.6 18:31:23 INFO - blobuploader == 1.2.4 18:31:23 INFO - docopt == 0.6.1 18:31:23 INFO - manifestparser == 1.1 18:31:23 INFO - mozInstall == 1.12 18:31:23 INFO - mozcrash == 0.17 18:31:23 INFO - mozdebug == 0.1 18:31:23 INFO - mozdevice == 0.48 18:31:23 INFO - mozfile == 1.2 18:31:23 INFO - mozhttpd == 0.7 18:31:23 INFO - mozinfo == 0.9 18:31:23 INFO - mozleak == 0.1 18:31:23 INFO - mozlog == 3.1 18:31:23 INFO - moznetwork == 0.27 18:31:23 INFO - mozprocess == 0.22 18:31:23 INFO - mozprofile == 0.28 18:31:23 INFO - mozrunner == 6.11 18:31:23 INFO - mozscreenshot == 0.1 18:31:23 INFO - mozsystemmonitor == 0.0 18:31:23 INFO - moztest == 0.7 18:31:23 INFO - mozversion == 1.4 18:31:23 INFO - psutil == 3.1.1 18:31:23 INFO - requests == 1.2.3 18:31:23 INFO - wsgiref == 0.1.2 18:31:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18: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')]} 18:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:23 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:23 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 18:31:23 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 18:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:23 INFO - 'HOME': '/Users/cltbld', 18:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:23 INFO - 'LOGNAME': 'cltbld', 18:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:23 INFO - 'MOZ_NO_REMOTE': '1', 18:31:23 INFO - 'NO_EM_RESTART': '1', 18:31:23 INFO - 'PAGER': '/bin/cat', 18:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:23 INFO - 'PWD': '/builds/slave/test', 18:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:23 INFO - 'SHELL': '/bin/bash', 18:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:23 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:23 INFO - 'USER': 'cltbld', 18:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:23 INFO - 'XPC_FLAGS': '0x0', 18:31:23 INFO - 'XPC_SERVICE_NAME': '0', 18:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 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)) 18:31:23 INFO - Cleaning up... 18:31:23 INFO - Return code: 0 18:31:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18: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')]} 18:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:23 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:23 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 18:31:23 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 18:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:23 INFO - 'HOME': '/Users/cltbld', 18:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:23 INFO - 'LOGNAME': 'cltbld', 18:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:23 INFO - 'MOZ_NO_REMOTE': '1', 18:31:23 INFO - 'NO_EM_RESTART': '1', 18:31:23 INFO - 'PAGER': '/bin/cat', 18:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:23 INFO - 'PWD': '/builds/slave/test', 18:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:23 INFO - 'SHELL': '/bin/bash', 18:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:23 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:23 INFO - 'USER': 'cltbld', 18:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:23 INFO - 'XPC_FLAGS': '0x0', 18:31:23 INFO - 'XPC_SERVICE_NAME': '0', 18:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:23 INFO - Downloading/unpacking jsonschema 18:31:23 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 18:31:23 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 18:31:23 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 18:31:23 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 18:31:23 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 18:31:23 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 18:31:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:26 INFO - Downloading/unpacking functools32 (from jsonschema) 18:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:26 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 18:31:26 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 18:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:26 INFO - warning: no files found matching '*.txt' 18:31:26 INFO - no previously-included directories found matching 'build' 18:31:26 INFO - no previously-included directories found matching 'dist' 18:31:26 INFO - no previously-included directories found matching '.git*' 18:31:26 INFO - Installing collected packages: jsonschema, functools32 18:31:26 INFO - Running setup.py install for functools32 18:31:26 INFO - warning: no files found matching '*.txt' 18:31:26 INFO - no previously-included directories found matching 'build' 18:31:26 INFO - no previously-included directories found matching 'dist' 18:31:26 INFO - no previously-included directories found matching '.git*' 18:31:26 INFO - Successfully installed jsonschema functools32 18:31:26 INFO - Cleaning up... 18:31:26 INFO - Return code: 0 18:31:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:26 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 0x1091cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb082d721d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, '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.J9WLIARCAJ/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.TG1tEurzO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 18:31:26 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 18:31:26 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 18:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:26 INFO - 'HOME': '/Users/cltbld', 18:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:26 INFO - 'LOGNAME': 'cltbld', 18:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:26 INFO - 'MOZ_NO_REMOTE': '1', 18:31:26 INFO - 'NO_EM_RESTART': '1', 18:31:26 INFO - 'PAGER': '/bin/cat', 18:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:26 INFO - 'PWD': '/builds/slave/test', 18:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:26 INFO - 'SHELL': '/bin/bash', 18:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:31:26 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:26 INFO - 'USER': 'cltbld', 18:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:26 INFO - 'XPC_FLAGS': '0x0', 18:31:26 INFO - 'XPC_SERVICE_NAME': '0', 18:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:27 INFO - Downloading/unpacking flake8 18:31:27 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 18:31:27 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 18:31:27 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 18:31:27 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 18:31:27 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 18:31:27 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 18:31:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:31:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 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 18:31:29 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 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:31:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 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 18:31:29 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 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18: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 18: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 18: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 18: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 18: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 18: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 18:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:31:30 INFO - no previously-included directories found matching 'docs/_build' 18:31:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:31:30 INFO - Running setup.py install for pep8 18:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:31:30 INFO - no previously-included directories found matching 'docs/_build' 18:31:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:31:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:31:30 INFO - Cleaning up... 18:31:31 INFO - Return code: 0 18:31:31 INFO - Running post-action listener: _resource_record_post_action 18:31:31 INFO - Running post-action listener: _start_resource_monitoring 18:31:31 INFO - Starting resource monitoring. 18:31:31 INFO - ##### 18:31:31 INFO - ##### Running install step. 18:31:31 INFO - ##### 18:31:31 INFO - Running pre-action listener: _resource_record_pre_action 18:31:31 INFO - Running main action method: install 18:31:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:31 INFO - Reading from file tmpfile_stdout 18:31:31 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:31 INFO - Reading from file tmpfile_stdout 18:31:31 INFO - Output received: 18:31:31 INFO - Usage: mozinstall [options] installer 18:31:31 INFO - Options: 18:31:31 INFO - -h, --help show this help message and exit 18:31:31 INFO - -d DEST, --destination=DEST 18:31:31 INFO - Directory to install application into. [default: 18:31:31 INFO - "/builds/slave/test"] 18:31:31 INFO - --app=APP Application being installed. [default: firefox] 18:31:31 INFO - mkdir: /builds/slave/test/build/application 18:31:31 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'] 18:31:31 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 18:32:05 INFO - Reading from file tmpfile_stdout 18:32:05 INFO - Output received: 18:32:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:32:05 INFO - Running post-action listener: _resource_record_post_action 18:32:05 INFO - ##### 18:32:05 INFO - ##### Running run-tests step. 18:32:05 INFO - ##### 18:32:05 INFO - Running pre-action listener: _resource_record_pre_action 18:32:05 INFO - Running main action method: run_tests 18:32:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:05 INFO - 2016-04-01 18:32:05.301 screenresolution[1974:31670] starting screenresolution argv=screenresolution get 18:32:05 INFO - 2016-04-01 18:32:05.303 screenresolution[1974:31670] Display 0: 1600x1200x32@60 18:32:05 INFO - 2016-04-01 18:32:05.310 screenresolution[1975:31672] starting screenresolution argv=screenresolution list 18:32:05 INFO - Available Modes on Display 0 18:32:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:05 INFO - Intel Iris: 18:32:05 INFO - Chipset Model: Intel Iris 18:32:05 INFO - Type: GPU 18:32:05 INFO - Bus: Built-In 18:32:05 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:05 INFO - Vendor: Intel (0x8086) 18:32:05 INFO - Device ID: 0x0a2e 18:32:05 INFO - Revision ID: 0x0009 18:32:05 INFO - Displays: 18:32:05 INFO - Display: 18:32:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:05 INFO - Display Serial Number: 1600x1200 60 18:32:05 INFO - Main Display: Yes 18:32:05 INFO - Mirror: Off 18:32:05 INFO - Online: Yes 18:32:05 INFO - Rotation: Supported 18:32:05 INFO - Return code: 0 18:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:05 INFO - Python 2.7.3 18:32:05 INFO - Return code: 0 18:32:05 INFO - grabbing minidump binary from tooltool 18:32:05 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')]} 18:32:05 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 0x10906ee00>, '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 0x108e97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109069b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:05 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 18:32:05 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 18:32:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:05 INFO - Return code: 0 18:32:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:32:06 INFO - Return code: 0 18:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 18:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0067 --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 18:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J9WLIARCAJ/Render', 18:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:06 INFO - 'HOME': '/Users/cltbld', 18:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:06 INFO - 'LOGNAME': 'cltbld', 18:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:06 INFO - 'MOZ_NO_REMOTE': '1', 18:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:06 INFO - 'NO_EM_RESTART': '1', 18:32:06 INFO - 'PAGER': '/bin/cat', 18:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:06 INFO - 'PWD': '/builds/slave/test', 18:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:06 INFO - 'SHELL': '/bin/bash', 18:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TG1tEurzO1/Listeners', 18:32:06 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 18:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:06 INFO - 'USER': 'cltbld', 18:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:06 INFO - 'XPC_FLAGS': '0x0', 18:32:06 INFO - 'XPC_SERVICE_NAME': '0', 18:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 18:32:07 INFO - mozversion application_buildid: 20160401173744 18:32:07 INFO - mozversion application_changeset: 7e4c0bee56f35104a4809121e8672f1e659258f5 18:32:07 INFO - mozversion application_display_name: Nightly 18:32:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:07 INFO - mozversion application_name: Firefox 18:32:07 INFO - mozversion application_remotingname: firefox 18:32:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:32:07 INFO - mozversion application_vendor: Mozilla 18:32:07 INFO - mozversion application_version: 48.0a1 18:32:07 INFO - mozversion platform_buildid: 20160401173744 18:32:07 INFO - mozversion platform_changeset: 7e4c0bee56f35104a4809121e8672f1e659258f5 18:32:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:32:07 INFO - mozversion platform_version: 48.0a1 18:32:07 INFO - using testdate: 1459560727 18:32:07 INFO - actual date: 1459560727 18:32:07 INFO - starting webserver on 'localhost:57019' 18:32:07 INFO - SUITE-START | Running 2 tests 18:32:07 INFO - TEST-START | dromaeo_css 18:32:07 INFO - operating with platform_type : mac_ 18:32:07 INFO - Initialising browser for dromaeo_css test... 18:32:07 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpnZiGXy/profile http://localhost:57019/getInfo.html) 18:32:09 INFO - PROCESS | 1993 | __metrics Screen width/height:1600/1200 18:32:09 INFO - PROCESS | 1993 | colorDepth:24 18:32:09 INFO - PROCESS | 1993 | Browser inner width/height: 1024/689 18:32:09 INFO - PROCESS | 1993 | __metrics 18:32:09 INFO - PROCESS | 1993 | 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" 18:32:09 ERROR - PROCESS | 1993 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:32:09 INFO - TEST-INFO | 1993: exit 0 18:32:09 INFO - Browser initialized. 18:32:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:09 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpnZiGXy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:21 INFO - PROCESS | 1995 | RSS: Main: 236331008 18:32:21 INFO - PROCESS | 1995 | 18:33:12 INFO - PROCESS | 1995 | 1459560792706 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] 18:35:23 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:57019/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57019/tests/dromaeo/cssquery-ext.html) 18:35:24 INFO - PROCESS | 1995 | RSS: Main: 375459840 18:35:24 INFO - PROCESS | 1995 | 18:38:27 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:57019/tests/dromaeo/cssquery-ext.html (next: http://localhost:57019/tests/dromaeo/cssquery-jquery.html) 18:38:27 INFO - PROCESS | 1995 | RSS: Main: 361381888 18:38:27 INFO - PROCESS | 1995 | 18:41:29 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:57019/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57019/tests/dromaeo/cssquery-mootools.html) 18:41:30 INFO - PROCESS | 1995 | RSS: Main: 364142592 18:41:30 INFO - PROCESS | 1995 | 18:44:32 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:57019/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57019/tests/dromaeo/cssquery-prototype.html) 18:44:32 INFO - PROCESS | 1995 | RSS: Main: 326733824 18:44:32 INFO - PROCESS | 1995 | 18:47:35 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:57019/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57019/tests/dromaeo/cssquery-yui.html) 18:47:36 INFO - PROCESS | 1995 | RSS: Main: 327557120 18:47:36 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:57019/tests/dromaeo/cssquery-yui.html (next: http://localhost:57019/tests/dromaeo/cssquery-dojo.html) 18:50:39 INFO - PROCESS | 1995 | RSS: Main: 384086016 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | __start_tp_report 18:50:39 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 18:50:39 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 18:50:39 INFO - PROCESS | 1995 | |i|pagename|runs| 18:50:39 INFO - PROCESS | 1995 | |0;dojo.html;3389.6779805918436;3416.3679719251923;3443.6900678938923;3458.118179864134;3491.581010278767;4877.804937790237;5398.811041613544;5516.034693928556;5611.691356975365;5613.4386561343845;5595.244641973332;5654.519365853907;5671.602987790846;5746.569007324447;5758.884822303551;5077.416097148838;5090.9236361454605;5115.641905066647;5123.205903085028;5234.839031694534;5215.895682086356;5221.269022336857;5251.894962100756;5269.525742683158;5287.312649355578;5064.2403639454005;5068.189089745623;5170.948290517084;5183.818566350178;5239.318888544503;5149.742512874379;5160.045391602528;5168.379794424655;5169.715665638389;5178.249153872667;5087.542121209109;5142.845714628567;5146.485351464861;5159.948400516022;5168.8966220675375;5482.068048431776;5570.442955704438;5599.7480113394995;5624.606277560572;5684.261046063985;6114.023656277693;6142.692865356715;6161.599496032788;6178.38216178383;6187.597806142587;5833.679147646878;6257.436830685215;6263.373662633746;6269.3730626937395;6277.403646653561;5624.465675760837;5687.573431992617;5741.425857414309;5753.309602847643;5763.279590051244;6265.96867015662;6295.779647712399;6299.149614802035;6309.779157729549;6317.14718513004;5891.587588868823;6034.125051867454;6042.577019608673;6044.697765111727;6046.2139921809885;6077.3314935357075;6103.91351630514;6130.887362650998;6193.6903154842075;6204.937950620526;6073.908891366633;6082.726277317532;6084.209052823193;6084.726187321581;6090.269167699905;6098.390160983866;6105.572609917263;6106.114613381035;6114.908276375858;6119.724612392453;4800.591949684316;4836.951630483721;4837.56461918422;4850.75746212688;4859.416869975555;4240.406343111967;4307.784610769449;4347.304431290978;4363.593009508125;4407.184670835905;5497.945020549743;5598.440155984369;5610.4670056344585;5628.774849006076;5664.065429204135;6145.033589251397;6149.2313460817395;6268.49852011838;6268.937310626835;6274.215723034621;4773.331733557305;5337.946620533745;5598.608097433222;5627.746751396197;5641.069223578063;5219.086659834514;5336.1462166054025;5342.091844386464;5348.679079255257;5372.167314066326;6198.969005155035;6201.844953876099;6271.62370257786;6275.654838983808;6288.968555157195;6228.4705800007505;6250.593711408744;6265.216847894013;6266.279377871603;6274.215723034621;6143.60399444226;6264.342244064308;6265.279492858197;6267.529935254783;6274.905876411766;5161.845144645667;6087.421694938974;6158.815235542941;6163.722632481638;6165.784197553064;6189.597676151036;6203.8138855834395;6237.4698150657705;6250.906236406367;6256.812295631138;5895.086261629454;5960.433758792908;6012.098185272244;6046.7278972445465;6065.727042283196;6035;6048.334683184934;6049.909251361145;6055.122007308827;6087;5719.599628025998;5852.590318677651;5869.853253668693;5871.794487192928;5894.793682221101;5871.119332100219;5988.700564971647;6046.57673962836;6064;6074.149619053424;5896.086106653475;5912.349641539513;5917.053271476543;5926.911096333644;5927.081302398135 18:50:39 INFO - PROCESS | 1995 | |1;ext.html;563.0062938912822;568.0570253379391;579.0301245413933;629.2511910826119;633.4045996763043;30257.638406271715;30672.38655226894;38607;38905;39071.60928390722;41954.790226048906;42179.78910105453;42230.36654450178;42312;42473;9401.529923503815;9631.47026913523;9639.180669643089;9640.71077867665;9642;9446.338756287063;9611.66359177429;9612.134907858292;9614.471204083773;9638.951805240964;9539.379940303857;9561.521923903812;9714.514274286294;9736.172425343819;9765.90234097657;9666.854997175047;9721;9750.75623109428;9753.707388778348;9756.560954757053;9570.521473926276;9583.856242156373;9584.520773961274;9585.90414095864;9703.563339649732;40954.79522602368;41421.96445088897;41454.963625909295;41458;41583.792081039704;3324.1523411530147;3386.8137252451106;3395.5925288965236;3419.6580341965605;3479.9652003479896;28744.856275718696;28940.408277544728;28964.565531517044;29057.12828615145;29620.259493512618;2710.9593356099676;2756.2144788735313;2766.681831589373;2823.5058864698594;2864.4843928092937;350101;350397;350621.99999999744;350791;351314;45275.32087018697;45714.085718285445;45797.31304030442;45826.85432864205;64636;44823.32765008527;44983.875403115184;45034.77482612566;45208.54791452109;45279.77360113178;15464.994775339566;15638.45265415705;15654.982426142264;15669.843301567067;15674.373025079098;12497.625071247878;12576.37118144089;12584.81122783159;12594.370281486072;12666.556670516487;14776.113433194043;14797.852021479648;14812.407503699731;14825.70348593022;14926.850731492763;6074.969625151846;6193.318734939153;6251.843703907439;6257.561970662101;6279;950.7147855643418;973.1825266775942;1103.426218366461;1117.446863802423;1138.612871623652;29440.263993400335;30246.395072098876;30516.08451746451;30521;30732.692673072983;1076.262760009396;1078;1083.853679753239;1095.794625911507;1168.661088284388;14618.415263389557;14647.267636618126;15054.774178387333;15063.698726025637;15251.847481525265;641004;641394;646980;647703;647932;58232.7088364564;59167.70416147978;59193.70403147957;59293.11060334098;59390.95176909924;1305.3473263368505;1355.728854229158;1462.5539210540887;1496.1172907984342;1504.0599625234229;28301;29117;29381.11856644304;29778.10665680033;29880.069788484656;39545.60454395534;49394.75302623464;49426.50573494363;49472.75263623659;49700.75149624229;380376;393668;394682;394740;395249;27808.44383112286;32013.839930800197;32014.83992580022;32412.35175296528;32674.673253267163;32574.837125814218;35839.104022399646;39591.604083958795;40687.38968915409;41198.58801412067;30419.54370684486;32894;34135.658643414245;34651.78718744832;35018.12454688653;33488;33503.83248083744;34154.48768268428;34205.315893682484;34929.47605785966;35296.47055294121;35499.64500354963;36047;36095.27809443744;36190.8190459046;29600.851995739882;30746.077617671504;30900.1459912406;30954.226144346572;31128.066158015296;23620.763792362544;23689.407764805328;23949.880250598635;24056;24089.397765056015 18:50:39 INFO - PROCESS | 1995 | |2;jquery.html;354.62232722150907;359.5846796949524;360.02971990485634;364.08977556109727;371.7249235565682;19394.41816745498;19766.90116549417;20253.696194557095;20773.896130519326;20799.584008319824;19461.805381946175;20041.298554550594;20425.795742042574;20670.793292067076;20688.379348619565;5702.258706368177;5901.498372638331;5903.675297858616;5910.290765108193;5920.911186332209;3334.716549093318;4306.7631280279575;5854.73653685583;6437.452816510602;6485;6372.107904893319;6404.359564043605;6419;6422.550421470499;6423.775167869126;6189.350118237565;6283.5915665481825;6361.173047503841;6367.140436041168;6384.648844313561;3696.8890933271778;5269.815556455505;5455.618106732531;5479.4520547945285;5479.972600136974;21397.786022139735;23969;24210.39474013146;24538.386540336454;24550.754492455024;2049.333966460906;2057.6501994660944;2096.790320967906;2155.3641675705703;2361.504084142332;13279.601611951657;13598.456061757517;13941.86058139426;14435.566932991922;14488.20314882681;1667.5997760537505;1688.577855536116;1745.7992330881984;1755.7980832204332;1771.406578796105;89614;93497.53251233768;93634.59548106784;93700;94546.5088958538;10098.192144628412;10125.392476451289;10364.170866330676;10523.105536029523;10620.893791062144;10779;12636.2418254905;12745.17156384832;12753.171043882117;12757.617271481871;8136.511809291462;8280.544570048705;8281.95859020701;8366.665333386718;8374.748757537283;8498.405111642125;8518.87221691675;8533.573321333908;8619;8658.740237792876;5899.734511946886;5997.600959616188;6010.579259451883;6018.879622407528;6050.969745151246;1642.8439298266646;1724.1637805664243;1725.0770837601822;1728.1013872786082;1755.973660395095;836.5817091454273;972.3193764364972;997.5112195024386;1031.1338475680463;1108.1910205549993;19420;19894.50263743418;19976.500587485138;20092;20138.388928885655;853.6841368693623;918.4489306416231;932.4871320773548;958.5878072428923;980.4068538534227;10795.6221532246;11014.834777478345;11068.667939961813;11096.389698566494;11250.606228781953;558115;562876;568207;574707;583544;90425;90446.54776726074;92610.07389926014;93932.53033734788;95530.52234738781;1035.0994634667886;1053.2785042246087;1053.2995557953875;1070.7269646240159;1072.2065671403107;14836.554903352917;14934.925325373304;15836;16685.581725553464;18779.530511736768;37387.252254955296;45540.31689524726;47732.04535909193;48979.75510122427;49278;63626.68186659037;65177;65290.36774080496;67386.66306668436;69888.65055674688;6388.776392826228;7346.449016323691;7645.847083058419;7739.071311442663;7816.64825082884;10740.194485413782;11736.647900562997;12452.937735311265;12574.245545267313;12622.431990560262;10725.946370268099;10828.620998265023;10955.83566246491;11119.16606254518;11134.443277835913;8557.529335886586;10580.788384232426;10865.348079115278;10884.564617415215;11093.445327733742;11056.336619802838;11287.43562821872;11671.59149429766;11724.413779311171;11748;7068;7706.113796913202;7753.147153812964;7766.88349674744;7787.961060194662;10419;11164.776704466027;11423;11447.828282575601;11454.942725286654 18:50:39 INFO - PROCESS | 1995 | |3;mootools.html;1439.964000899978;1526.1377321813181;1529.4035326222775;1601.1913983438365;1887.6979683250684;6433.839154021146;7926.731722924334;8366.330693544516;8534.530600816968;8590.183932526415;8387.790305242357;8437.535935523543;8522.531260780655;8524.275436587897;8531.488110713362;2430.8906099225533;2460.5447992121517;2460.815438842085;2465.4575993281537;2469.148143890364;2400.063975049732;2406.65227472615;2485.179890636086;2489.3776555861036;2491.0658503061354;2440.792532634728;2454.5459090068393;2480.5659009673236;2486.639437281593;2486.9129580464687;2431.4529230923076;2444.9755502444928;2464.691913510811;2467.7408872068354;2470.110760126353;2424.527217192648;2444.401121725171;2455.2020593307248;2465.408302007523;2468.308873515419;8512.659493620247;8534.445261058012;8543.444676096096;8572.742817715478;8574.614142363609;5258.605604579672;5410.729463526808;5459.426760190163;5459.69971651559;5459.918101228484;3530.876419325337;3588.5693716753894;3652.2330310634798;3667.504886840269;3668.5054163169034;1046.7330830638214;1065.0787069185176;1070.454068425101;1075.8870318616512;1077.9245452818307;11599.768004639944;11614.070874330033;11624.476898539586;11651.708707282301;11660.88339116598;4021.3967904814513;4711.316859055418;4800.423949126127;4813.109574728686;4850.854474365775;9864.112229899343;9877.703668889944;9906.60373585063;9909.454979976026;9949;5392.838214853561;5397.892042159135;5400.62195646301;5403.162509810907;5423.457654234624;4388.890277743082;4535.138323718483;4777.092352453023;4913.9017219656125;4943.530364615428;3761.0851590017955;3839.212961342918;3848.846046158122;3883.980580097081;3902.434147048719;1277.6805798550363;1290.864459231786;1291.5479582146174;1301.225770666452;1303.7392521495549;1014.2747935226201;1033.5865653738565;1172.5427083437296;1263.532492977604;1394.874461298488;7774.028246469192;7815.296623303816;7821.960890195626;7896.842063158705;7909.762707118795;1174.1370092981651;1188.8157335612993;1189.381521608776;1191.4578866615668;1216.0818581970732;6151.815445536641;6173.228346456693;6188.721507532172;6219.60545190105;6223.813285601439;10078.949605251926;10249.487525623688;10279.640212592523;10286.177105831515;10412.635557755593;10002.099811017044;10099.242556808122;10148.543315550818;10178.847317290247;10255.33340332876;7777.57223352721;7896.7236146734585;7919.049714034353;7999.3200577950365;8013.799655008672;7615.923840761521;7756.069271687434;7807.063152421746;7838.647260873388;7851.803704907423;9136.908630913606;9273.86089208649;9496.335256531976;9517.904820951702;9552.283578731762;9496.952515237379;9830.606775728891;9872.259580531345;9900.752481188028;9975.551100200364;7375.446841487017;7411.4070874328845;7483.176850546544;7507.436942229246;7518.473706840468;7926.167752385916;8077.071136819106;8128.187181281824;8129.512229266263;8138.104808470945;5495.340559132929;7283.781486555412;7290.708371665074;7394.038774959221;7438;6292.898742720097;6445.581037232565;7116.181639111568;7250.927490725026;7277.563346199245;7471.290137757647;7632.923670763222;7705.30652241301;7722.768316950501;7732.8453430932195;6982.301769822977;6984.3364880336285;7043.330883566053;7048.929510704827;7057.929420705933;7033.331833475811;7079.504434689522;7085.574865508086;7111.43108551325;7114.395276401357 18:50:39 INFO - PROCESS | 1995 | |4;prototype.html;322.5774235751166;324.4792108665592;332.0966969842029;332.88681848171615;337.40616514933726;5120.436751957282;5936.910946335808;6249.093881387202;6294.244690637124;6357.554971152022;5411.648242864221;6254.624722516641;6291.1821463209835;6292.056191571267;6302.149209856668;4500.257457519506;4616.469106052797;4680.625549955996;4690.601298889582;4726.716397016182;4576.427946506687;4687.20317546018;4693.671442998992;4711.717296962193;4736.502667219944;3855.4024126260474;4646.395968524104;4658.790354434059;4680.485146633868;4684.789184486689;4425.712328698624;4645.02454484557;4650.86047418578;4671.5795578397765;4674.696144750597;3416.1630400551776;3876.186000939806;3988.441618173458;3994.460747799039;4000.159966407058;5782.971085144547;5840.532757379399;5864.736086876101;5912.3496415394275;5928.081147422156;5457.918131228034;5467.715086954562;5478.58910581708;5479.945200547983;5485.314335708036;6568.441682456997;6615.503837212228;6626.304238054983;6628.370304821083;6643.900341494881;4493.28107502798;4502.2571275739465;4505.5719706627815;4511.8646440606835;4513.736153876887;6689;6965.5124141310125;7036.612986285752;7041.823954401181;7056.576605403692;4355.08543205924;4431.313146462304;4440.4227450431235;4442.755648439367;4446.399736035659;4517.277235642281;4517.5256598057385;4521.547845215452;4527.501974782771;4529.433820772403;5304.204369344552;5311.575073994071;5313.760880760375;5317.175837745156;5320.2817619620855;5632.859178520488;6494.058361537551;6653.866922661519;6657.933420665731;6664.900026499607;1482.8285654333172;1555.5488908216491;1561.234994852514;1566.600516868214;1568.5843251538352;998.9500524973868;1002.173207104142;1007.2395341517108;1012.0436187802603;1021.1881554164457;5889.882202355929;6065.181200537871;6067.817965461043;6078.422549857756;6091.360407157184;6851.760188393482;6854.3145685432055;6854.554453960576;6865.0732151159955;6868.416184624363;5002.474740152305;5782.537397008229;6131.110988906584;6132.448079672851;6140.570160088841;3599.3341231872187;3641.471986561987;3648.5074514940675;3654.5066416033496;3659.2315613720884;6933;7218.927810721825;7222.494425390278;7226.1328640562415;7226.602536860418;7126.643667816588;7134.714611415589;7145.392641625416;7160.606166660884;7163.212046674862;7108.573485590881;7171.426285897116;7202.243764404767;7204.0994875640545;7205.531640443354;6025.367336429612;6459.5478316519275;6883.3116688330765;6891.414229790324;6899.379055884994;6523.24982627004;6793.354631310018;6794.524383293122;6805.251422343637;6816.693248803716;6146.801373732079;6943;7188.424926005802;7199.388052015637;7219.855602887807;3714.6627214202326;4354.325079612665;4367.585079417578;4418.867433976986;4419.977900110479;6904.861902762017;6906.136732908387;6912.896306555305;6915.132914113262;6915.930840691529;6664.83337916556;6676.132102826796;6702.497312701665;6702.994550817221;6714.6642667865435;6446.323136070645;6664.50016248793;6778.966105169443;6780.898286525608;6793.592384456949;6578.8355291118105;6598.67006649656;6607.00894865774;6616.503762217949;6621.966890165519;6726.8654626908165;6745.3591908768585;6751.696173672295;6753.358430949052;6768.390844823989;6596.934030659824;6608.107905432705;6613.305602911625;6617.43751781104;6621.1392518972225 18:50:39 INFO - PROCESS | 1995 | |5;yui.html;714.6426786606696;734.331758100129;764.1441585424325;767.612355760341;771.8109063279497;14778.482753103644;15138.470153544627;15144.924275378622;15149.621259468518;15154.545363639094;11628.592999245027;13706.58880233592;13841.653958651039;13853.515126970558;13897.583072507816;722.5989575785437;736.9042024536802;887.9733607991739;904.199783191875;909.6679711905173;900.6262401103534;905.2938707807921;906.5376657904483;908.7455512456522;909.3770767024577;967.9225661947063;978.5547575853005;979.7599588100925;979.8530220466952;983.3902980152316;760.1979911193661;943.834828904939;965.560669895196;966.4056605187794;970.1365784451843;691.8581690753383;707.3174386716792;723.3417589993081;723.3851226457522;724.344468256229;14480.275986200753;14535.636609084751;14542.70914581713;14546.781798273034;14576.927115364462;12685.873141268561;12705.364731763468;12933.417996190099;13075.607731767966;13206.73586528264;8438.4515006525;9839.409635421898;10117.544710487971;10138;10617.256792024562;3452.68925796677;3505.8772942946875;3549.2014296783277;3638.5451818522683;3776;78487;78753;80964;81033;81136.18863811345;9410.623575057058;9411.529423528797;9429.528523573794;9661.372010819274;9815.067568580973;20770.688439673417;20791.1683532657;20991.265305714227;20998.265060722802;21028.264010759856;7082.362587367162;7087.334247828148;7126.572405655677;7139.643017849086;7291.380232680175;3596.7122630189524;4003.799810009488;4056.492938382702;4090.611391917763;4121.876343709693;3406.8466918988706;3490.458978858281;3492.2666240089357;3494.7204223662047;3495.580530336325;646.8706258748269;647.1683886206202;653.5621133840339;664.7440735316937;667.4793660944471;526.3841305672372;541.4693600271677;566.3006187358609;590.1560768101656;592.7332700284803;7859.52842829432;8328.6668533258;8696.826063478695;8835.867461988075;8847.350781998106;547.7343488408119;584.9619774714715;609.9176611157437;614.6373639552685;627.2003195925141;3761.6426439488205;3840.577536470986;3865.729398942103;3888.786116763605;3935.0752573145287;89185.20296180858;97084.54373184408;99919.00080999098;100868;100930;70404.64797676081;85373.14626853776;85700.28599427977;86027;86685.99999999873;74706.99999999891;75217.24782752212;75346;75442;76739.61630191813;7735.497192682683;7839.216078392115;7843.820291816861;7976.960115199387;7993.920060799318;46201.537984619725;48567.514324856296;52455;52458.213126802366;52695.73652131868;47667.28499072586;68353.65823170853;70996.64501677458;72407;72889;9680.741503604486;10358.274920755475;10408.219383546113;10596.841047384141;10967.23229373968;10516.474176291307;10893.836592451278;10907.836382454429;10949.671509854717;11365.54537818478;10230.693079207338;10282.331648442827;10421.68734937953;10727.517261723086;10921.781564368826;10434.739131521468;10446.320989135682;10766.138708903425;10783.946080269548;10812.621558245739;8600.78498037554;10214.029667181605;10305.896941030494;10622.20333474977;10628.89371106279;7981.161977992228;8436.367272454714;8553.44402613853;8903.243224325746;9205.941683477049;8511.95744021276;8598.312135029308;8859.689910853347;8909.688160914597;8948.194662480408 18:50:39 INFO - PROCESS | 1995 | __end_tp_report 18:50:39 INFO - PROCESS | 1995 | __start_cc_report 18:50:39 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,1421 18:50:39 INFO - PROCESS | 1995 | __end_cc_report 18:50:39 INFO - PROCESS | 1995 | __startTimestamp1459561839653__endTimestamp 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | ------- Summary: start ------- 18:50:39 INFO - PROCESS | 1995 | Number of tests: 6 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | [#0] dojo.html Cycles:165 Average:5669.58 Median:5891.59 stddev:634.28 (10.8%) stddev-sans-first:610.49 18:50:39 INFO - PROCESS | 1995 | Values: 3389.7 3416.4 3443.7 3458.1 3491.6 4877.8 5398.8 5516.0 5611.7 5613.4 5595.2 5654.5 5671.6 5746.6 5758.9 5077.4 5090.9 5115.6 5123.2 5234.8 5215.9 5221.3 5251.9 5269.5 5287.3 5064.2 5068.2 5170.9 5183.8 5239.3 5149.7 5160.0 5168.4 5169.7 5178.2 5087.5 5142.8 5146.5 5159.9 5168.9 5482.1 5570.4 5599.7 5624.6 5684.3 6114.0 6142.7 6161.6 6178.4 6187.6 5833.7 6257.4 6263.4 6269.4 6277.4 5624.5 5687.6 5741.4 5753.3 5763.3 6266.0 6295.8 6299.1 6309.8 6317.1 5891.6 6034.1 6042.6 6044.7 6046.2 6077.3 6103.9 6130.9 6193.7 6204.9 6073.9 6082.7 6084.2 6084.7 6090.3 6098.4 6105.6 6106.1 6114.9 6119.7 4800.6 4837.0 4837.6 4850.8 4859.4 4240.4 4307.8 4347.3 4363.6 4407.2 5497.9 5598.4 5610.5 5628.8 5664.1 6145.0 6149.2 6268.5 6268.9 6274.2 4773.3 5337.9 5598.6 5627.7 5641.1 5219.1 5336.1 5342.1 5348.7 5372.2 6199.0 6201.8 6271.6 6275.7 6289.0 6228.5 6250.6 6265.2 6266.3 6274.2 6143.6 6264.3 6265.3 6267.5 6274.9 5161.8 6087.4 6158.8 6163.7 6165.8 6189.6 6203.8 6237.5 6250.9 6256.8 5895.1 5960.4 6012.1 6046.7 6065.7 6035.0 6048.3 6049.9 6055.1 6087.0 5719.6 5852.6 5869.9 5871.8 5894.8 5871.1 5988.7 6046.6 6064.0 6074.1 5896.1 5912.3 5917.1 5926.9 5927.1 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | [#1] ext.html Cycles:180 Average:59615.26 Median:193305.24 stddev:128497.81 (66.5%) stddev-sans-first:128781.79 18:50:39 INFO - PROCESS | 1995 | Values: 563.0 568.1 579.0 629.3 633.4 30257.6 30672.4 38607.0 38905.0 39071.6 41954.8 42179.8 42230.4 42312.0 42473.0 9401.5 9631.5 9639.2 9640.7 9642.0 9446.3 9611.7 9612.1 9614.5 9639.0 9539.4 9561.5 9714.5 9736.2 9765.9 9666.9 9721.0 9750.8 9753.7 9756.6 9570.5 9583.9 9584.5 9585.9 9703.6 40954.8 41422.0 41455.0 41458.0 41583.8 3324.2 3386.8 3395.6 3419.7 3480.0 28744.9 28940.4 28964.6 29057.1 29620.3 2711.0 2756.2 2766.7 2823.5 2864.5 350101.0 350397.0 350622.0 350791.0 351314.0 45275.3 45714.1 45797.3 45826.9 64636.0 44823.3 44983.9 45034.8 45208.5 45279.8 15465.0 15638.5 15655.0 15669.8 15674.4 12497.6 12576.4 12584.8 12594.4 12666.6 14776.1 14797.9 14812.4 14825.7 14926.9 6075.0 6193.3 6251.8 6257.6 6279.0 950.7 973.2 1103.4 1117.4 1138.6 29440.3 30246.4 30516.1 30521.0 30732.7 1076.3 1078.0 1083.9 1095.8 1168.7 14618.4 14647.3 15054.8 15063.7 15251.8 641004.0 641394.0 646980.0 647703.0 647932.0 58232.7 59167.7 59193.7 59293.1 59391.0 1305.3 1355.7 1462.6 1496.1 1504.1 28301.0 29117.0 29381.1 29778.1 29880.1 39545.6 49394.8 49426.5 49472.8 49700.8 380376.0 393668.0 394682.0 394740.0 395249.0 27808.4 32013.8 32014.8 32412.4 32674.7 32574.8 35839.1 39591.6 40687.4 41198.6 30419.5 32894.0 34135.7 34651.8 35018.1 33488.0 33503.8 34154.5 34205.3 34929.5 35296.5 35499.6 36047.0 36095.3 36190.8 29600.9 30746.1 30900.1 30954.2 31128.1 23620.8 23689.4 23949.9 24056.0 24089.4 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | [#2] jquery.html Cycles:180 Average:31858.30 Median:13942.74 stddev:93851.44 (673.1%) stddev-sans-first:94084.91 18:50:39 INFO - PROCESS | 1995 | Values: 354.6 359.6 360.0 364.1 371.7 19394.4 19766.9 20253.7 20773.9 20799.6 19461.8 20041.3 20425.8 20670.8 20688.4 5702.3 5901.5 5903.7 5910.3 5920.9 3334.7 4306.8 5854.7 6437.5 6485.0 6372.1 6404.4 6419.0 6422.6 6423.8 6189.4 6283.6 6361.2 6367.1 6384.6 3696.9 5269.8 5455.6 5479.5 5480.0 21397.8 23969.0 24210.4 24538.4 24550.8 2049.3 2057.7 2096.8 2155.4 2361.5 13279.6 13598.5 13941.9 14435.6 14488.2 1667.6 1688.6 1745.8 1755.8 1771.4 89614.0 93497.5 93634.6 93700.0 94546.5 10098.2 10125.4 10364.2 10523.1 10620.9 10779.0 12636.2 12745.2 12753.2 12757.6 8136.5 8280.5 8282.0 8366.7 8374.7 8498.4 8518.9 8533.6 8619.0 8658.7 5899.7 5997.6 6010.6 6018.9 6051.0 1642.8 1724.2 1725.1 1728.1 1756.0 836.6 972.3 997.5 1031.1 1108.2 19420.0 19894.5 19976.5 20092.0 20138.4 853.7 918.4 932.5 958.6 980.4 10795.6 11014.8 11068.7 11096.4 11250.6 558115.0 562876.0 568207.0 574707.0 583544.0 90425.0 90446.5 92610.1 93932.5 95530.5 1035.1 1053.3 1053.3 1070.7 1072.2 14836.6 14934.9 15836.0 16685.6 18779.5 37387.3 45540.3 47732.0 48979.8 49278.0 63626.7 65177.0 65290.4 67386.7 69888.7 6388.8 7346.4 7645.8 7739.1 7816.6 10740.2 11736.6 12452.9 12574.2 12622.4 10725.9 10828.6 10955.8 11119.2 11134.4 8557.5 10580.8 10865.3 10884.6 11093.4 11056.3 11287.4 11671.6 11724.4 11748.0 7068.0 7706.1 7753.1 7766.9 7788.0 10419.0 11164.8 11423.0 11447.8 11454.9 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | [#3] mootools.html Cycles:180 Average:5924.26 Median:5417.09 stddev:3078.20 (56.8%) stddev-sans-first:3068.38 18:50:39 INFO - PROCESS | 1995 | Values: 1440.0 1526.1 1529.4 1601.2 1887.7 6433.8 7926.7 8366.3 8534.5 8590.2 8387.8 8437.5 8522.5 8524.3 8531.5 2430.9 2460.5 2460.8 2465.5 2469.1 2400.1 2406.7 2485.2 2489.4 2491.1 2440.8 2454.5 2480.6 2486.6 2486.9 2431.5 2445.0 2464.7 2467.7 2470.1 2424.5 2444.4 2455.2 2465.4 2468.3 8512.7 8534.4 8543.4 8572.7 8574.6 5258.6 5410.7 5459.4 5459.7 5459.9 3530.9 3588.6 3652.2 3667.5 3668.5 1046.7 1065.1 1070.5 1075.9 1077.9 11599.8 11614.1 11624.5 11651.7 11660.9 4021.4 4711.3 4800.4 4813.1 4850.9 9864.1 9877.7 9906.6 9909.5 9949.0 5392.8 5397.9 5400.6 5403.2 5423.5 4388.9 4535.1 4777.1 4913.9 4943.5 3761.1 3839.2 3848.8 3884.0 3902.4 1277.7 1290.9 1291.5 1301.2 1303.7 1014.3 1033.6 1172.5 1263.5 1394.9 7774.0 7815.3 7822.0 7896.8 7909.8 1174.1 1188.8 1189.4 1191.5 1216.1 6151.8 6173.2 6188.7 6219.6 6223.8 10078.9 10249.5 10279.6 10286.2 10412.6 10002.1 10099.2 10148.5 10178.8 10255.3 7777.6 7896.7 7919.0 7999.3 8013.8 7615.9 7756.1 7807.1 7838.6 7851.8 9136.9 9273.9 9496.3 9517.9 9552.3 9497.0 9830.6 9872.3 9900.8 9975.6 7375.4 7411.4 7483.2 7507.4 7518.5 7926.2 8077.1 8128.2 8129.5 8138.1 5495.3 7283.8 7290.7 7394.0 7438.0 6292.9 6445.6 7116.2 7250.9 7277.6 7471.3 7632.9 7705.3 7722.8 7732.8 6982.3 6984.3 7043.3 7048.9 7057.9 7033.3 7079.5 7085.6 7111.4 7114.4 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | [#4] prototype.html Cycles:180 Average:5446.79 Median:6111.24 stddev:1729.12 (28.3%) stddev-sans-first:1690.66 18:50:39 INFO - PROCESS | 1995 | Values: 322.6 324.5 332.1 332.9 337.4 5120.4 5936.9 6249.1 6294.2 6357.6 5411.6 6254.6 6291.2 6292.1 6302.1 4500.3 4616.5 4680.6 4690.6 4726.7 4576.4 4687.2 4693.7 4711.7 4736.5 3855.4 4646.4 4658.8 4680.5 4684.8 4425.7 4645.0 4650.9 4671.6 4674.7 3416.2 3876.2 3988.4 3994.5 4000.2 5783.0 5840.5 5864.7 5912.3 5928.1 5457.9 5467.7 5478.6 5479.9 5485.3 6568.4 6615.5 6626.3 6628.4 6643.9 4493.3 4502.3 4505.6 4511.9 4513.7 6689.0 6965.5 7036.6 7041.8 7056.6 4355.1 4431.3 4440.4 4442.8 4446.4 4517.3 4517.5 4521.5 4527.5 4529.4 5304.2 5311.6 5313.8 5317.2 5320.3 5632.9 6494.1 6653.9 6657.9 6664.9 1482.8 1555.5 1561.2 1566.6 1568.6 999.0 1002.2 1007.2 1012.0 1021.2 5889.9 6065.2 6067.8 6078.4 6091.4 6851.8 6854.3 6854.6 6865.1 6868.4 5002.5 5782.5 6131.1 6132.4 6140.6 3599.3 3641.5 3648.5 3654.5 3659.2 6933.0 7218.9 7222.5 7226.1 7226.6 7126.6 7134.7 7145.4 7160.6 7163.2 7108.6 7171.4 7202.2 7204.1 7205.5 6025.4 6459.5 6883.3 6891.4 6899.4 6523.2 6793.4 6794.5 6805.3 6816.7 6146.8 6943.0 7188.4 7199.4 7219.9 3714.7 4354.3 4367.6 4418.9 4420.0 6904.9 6906.1 6912.9 6915.1 6915.9 6664.8 6676.1 6702.5 6703.0 6714.7 6446.3 6664.5 6779.0 6780.9 6793.6 6578.8 6598.7 6607.0 6616.5 6622.0 6726.9 6745.4 6751.7 6753.4 6768.4 6596.9 6608.1 6613.3 6617.4 6621.1 18:50:39 INFO - PROCESS | 1995 | 18:50:39 INFO - PROCESS | 1995 | [#5] yui.html Cycles:180 Average:18456.83 Median:650.37 stddev:26804.33 (4121.4%) stddev-sans-first:26846.42 18:50:39 INFO - PROCESS | 1995 | Values: 714.6 734.3 764.1 767.6 771.8 14778.5 15138.5 15144.9 15149.6 15154.5 11628.6 13706.6 13841.7 13853.5 13897.6 722.6 736.9 888.0 904.2 909.7 900.6 905.3 906.5 908.7 909.4 967.9 978.6 979.8 979.9 983.4 760.2 943.8 965.6 966.4 970.1 691.9 707.3 723.3 723.4 724.3 14480.3 14535.6 14542.7 14546.8 14576.9 12685.9 12705.4 12933.4 13075.6 13206.7 8438.5 9839.4 10117.5 10138.0 10617.3 3452.7 3505.9 3549.2 3638.5 3776.0 78487.0 78753.0 80964.0 81033.0 81136.2 9410.6 9411.5 9429.5 9661.4 9815.1 20770.7 20791.2 20991.3 20998.3 21028.3 7082.4 7087.3 7126.6 7139.6 7291.4 3596.7 4003.8 4056.5 4090.6 4121.9 3406.8 3490.5 3492.3 3494.7 3495.6 646.9 647.2 653.6 664.7 667.5 526.4 541.5 566.3 590.2 592.7 7859.5 8328.7 8696.8 8835.9 8847.4 547.7 585.0 609.9 614.6 627.2 3761.6 3840.6 3865.7 3888.8 3935.1 89185.2 97084.5 99919.0 100868.0 100930.0 70404.6 85373.1 85700.3 86027.0 86686.0 74707.0 75217.2 75346.0 75442.0 76739.6 7735.5 7839.2 7843.8 7977.0 7993.9 46201.5 48567.5 52455.0 52458.2 52695.7 47667.3 68353.7 70996.6 72407.0 72889.0 9680.7 10358.3 10408.2 10596.8 10967.2 10516.5 10893.8 10907.8 10949.7 11365.5 10230.7 10282.3 10421.7 10727.5 10921.8 10434.7 10446.3 10766.1 10783.9 10812.6 8600.8 10214.0 10305.9 10622.2 10628.9 7981.2 8436.4 8553.4 8903.2 9205.9 8512.0 8598.3 8859.7 8909.7 8948.2 18:50:39 INFO - PROCESS | 1995 | -------- Summary: end -------- 18:50:39 INFO - PROCESS | 1995 | 18:50:40 INFO - TEST-INFO | 1995: exit 0 18:50:40 INFO - TEST-OK | dromaeo_css | took 1113171ms 18:50:40 INFO - TEST-START | kraken 18:50:40 INFO - operating with platform_type : mac_ 18:50:40 INFO - Initialising browser for kraken test... 18:50:40 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpLGzI28/profile http://localhost:57019/getInfo.html) 18:50:42 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 18:50:42 INFO - PROCESS | 2001 | colorDepth:24 18:50:42 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 18:50:42 INFO - PROCESS | 2001 | __metrics 18:50:42 INFO - PROCESS | 2001 | 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" 18:50:42 ERROR - PROCESS | 2001 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:50:43 INFO - TEST-INFO | 2001: exit 0 18:50:43 INFO - Browser initialized. 18:50:43 INFO - Running cycle 1/1 for kraken test... 18:50:43 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpLGzI28/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:54 INFO - PROCESS | 2003 | RSS: Main: 236851200 18:50:54 INFO - PROCESS | 2003 | 18:50:57 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57019/tests/kraken/driver.html?testName=audio-beat-detection) 18:50:58 INFO - PROCESS | 2003 | RSS: Main: 282546176 18:50:58 INFO - PROCESS | 2003 | 18:51:00 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57019/tests/kraken/driver.html?testName=audio-dft) 18:51:01 INFO - PROCESS | 2003 | RSS: Main: 293085184 18:51:01 INFO - PROCESS | 2003 | 18:51:04 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57019/tests/kraken/driver.html?testName=audio-fft) 18:51:05 INFO - PROCESS | 2003 | RSS: Main: 280170496 18:51:05 INFO - PROCESS | 2003 | 18:51:07 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57019/tests/kraken/driver.html?testName=audio-oscillator) 18:51:07 INFO - PROCESS | 2003 | RSS: Main: 282062848 18:51:07 INFO - PROCESS | 2003 | 18:51:10 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57019/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:10 INFO - PROCESS | 2003 | RSS: Main: 282374144 18:51:10 INFO - PROCESS | 2003 | 18:51:13 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57019/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:13 INFO - PROCESS | 2003 | RSS: Main: 283127808 18:51:13 INFO - PROCESS | 2003 | 18:51:16 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57019/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:17 INFO - PROCESS | 2003 | RSS: Main: 282419200 18:51:17 INFO - PROCESS | 2003 | 18:51:20 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57019/tests/kraken/driver.html?testName=json-parse-financial) 18:51:20 INFO - PROCESS | 2003 | RSS: Main: 282857472 18:51:20 INFO - PROCESS | 2003 | 18:51:22 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57019/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:23 INFO - PROCESS | 2003 | RSS: Main: 315564032 18:51:23 INFO - PROCESS | 2003 | 18:51:24 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:25 INFO - PROCESS | 2003 | RSS: Main: 316407808 18:51:25 INFO - PROCESS | 2003 | 18:51:27 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:28 INFO - PROCESS | 2003 | RSS: Main: 322203648 18:51:28 INFO - PROCESS | 2003 | 18:51:30 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:31 INFO - PROCESS | 2003 | RSS: Main: 323379200 18:51:31 INFO - PROCESS | 2003 | 18:51:33 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:34 INFO - PROCESS | 2003 | RSS: Main: 323571712 18:51:34 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:57019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57019/tests/kraken/driver.html?testName=ai-astar) 18:51:36 INFO - PROCESS | 2003 | RSS: Main: 386760704 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | __start_tp_report 18:51:36 INFO - PROCESS | 2003 | _x_x_mozilla_page_load 18:51:36 INFO - PROCESS | 2003 | _x_x_mozilla_page_load_details 18:51:36 INFO - PROCESS | 2003 | |i|pagename|runs| 18:51:36 INFO - PROCESS | 2003 | |0;ai-astar;110;109;109;110;110;113;117;110;112;112 18:51:36 INFO - PROCESS | 2003 | |1;audio-beat-detection;158;124;146;164;119;144;139;119;164;113 18:51:36 INFO - PROCESS | 2003 | |2;audio-dft;186;184;185;185;184;188;193;259;179;184 18:51:36 INFO - PROCESS | 2003 | |3;audio-fft;81;73;83;81;76;83;83;100;80;58 18:51:36 INFO - PROCESS | 2003 | |4;audio-oscillator;90;101;126;81;78;80;114;79;77;117 18:51:36 INFO - PROCESS | 2003 | |5;imaging-gaussian-blur;87;85;135;85;88;85;89;85;88;85 18:51:36 INFO - PROCESS | 2003 | |6;imaging-darkroom;94;94;94;116;149;94;94;94;100;89 18:51:36 INFO - PROCESS | 2003 | |7;imaging-desaturate;84;86;88;84;86;108;109;84;84;87 18:51:36 INFO - PROCESS | 2003 | |8;json-parse-financial;55;54;53;51;52;54;53;63;54;50 18:51:36 INFO - PROCESS | 2003 | |9;json-stringify-tinderbox;64;70;76;74;71;66;66;69;68;68 18:51:36 INFO - PROCESS | 2003 | |10;stanford-crypto-aes;84;84;83;85;83;83;84;83;84;84 18:51:36 INFO - PROCESS | 2003 | |11;stanford-crypto-ccm;123;132;131;121;122;123;123;125;134;124 18:51:36 INFO - PROCESS | 2003 | |12;stanford-crypto-pbkdf2;137;130;140;151;178;172;146;134;140;138 18:51:36 INFO - PROCESS | 2003 | |13;stanford-crypto-sha256-iterative;68;67;67;67;69;66;64;66;66;66 18:51:36 INFO - PROCESS | 2003 | __end_tp_report 18:51:36 INFO - PROCESS | 2003 | __start_cc_report 18:51:36 INFO - PROCESS | 2003 | _x_x_mozilla_cycle_collect,1308 18:51:36 INFO - PROCESS | 2003 | __end_cc_report 18:51:36 INFO - PROCESS | 2003 | __startTimestamp1459561896458__endTimestamp 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | ------- Summary: start ------- 18:51:36 INFO - PROCESS | 2003 | Number of tests: 14 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:2.44 (2.2%) stddev-sans-first:2.55 18:51:36 INFO - PROCESS | 2003 | Values: 110.0 109.0 109.0 110.0 110.0 113.0 117.0 110.0 112.0 112.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:145.00 stddev:19.40 (13.4%) stddev-sans-first:19.32 18:51:36 INFO - PROCESS | 2003 | Values: 158.0 124.0 146.0 164.0 119.0 144.0 139.0 119.0 164.0 113.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#2] audio-dft Cycles:10 Average:192.70 Median:185.50 stddev:23.56 (12.7%) stddev-sans-first:24.87 18:51:36 INFO - PROCESS | 2003 | Values: 186.0 184.0 185.0 185.0 184.0 188.0 193.0 259.0 179.0 184.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#3] audio-fft Cycles:10 Average:79.80 Median:81.00 stddev:10.42 (12.9%) stddev-sans-first:11.05 18:51:36 INFO - PROCESS | 2003 | Values: 81.0 73.0 83.0 81.0 76.0 83.0 83.0 100.0 80.0 58.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:78.50 stddev:18.71 (23.8%) stddev-sans-first:19.78 18:51:36 INFO - PROCESS | 2003 | Values: 90.0 101.0 126.0 81.0 78.0 80.0 114.0 79.0 77.0 117.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:86.00 stddev:15.47 (18.0%) stddev-sans-first:16.33 18:51:36 INFO - PROCESS | 2003 | Values: 87.0 85.0 135.0 85.0 88.0 85.0 89.0 85.0 88.0 85.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:94.00 stddev:18.14 (19.3%) stddev-sans-first:19.02 18:51:36 INFO - PROCESS | 2003 | Values: 94.0 94.0 94.0 116.0 149.0 94.0 94.0 94.0 100.0 89.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#7] imaging-desaturate Cycles:10 Average:90.00 Median:85.00 stddev:9.85 (11.6%) stddev-sans-first:10.21 18:51:36 INFO - PROCESS | 2003 | Values: 84.0 86.0 88.0 84.0 86.0 108.0 109.0 84.0 84.0 87.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:3.54 (6.6%) stddev-sans-first:3.73 18:51:36 INFO - PROCESS | 2003 | Values: 55.0 54.0 53.0 51.0 52.0 54.0 53.0 63.0 54.0 50.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:3.71 (5.3%) stddev-sans-first:3.42 18:51:36 INFO - PROCESS | 2003 | Values: 64.0 70.0 76.0 74.0 71.0 66.0 66.0 69.0 68.0 68.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 18:51:36 INFO - PROCESS | 2003 | Values: 84.0 84.0 83.0 85.0 83.0 83.0 84.0 83.0 84.0 84.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:124.50 stddev:4.69 (3.8%) stddev-sans-first:4.86 18:51:36 INFO - PROCESS | 2003 | Values: 123.0 132.0 131.0 121.0 122.0 123.0 123.0 125.0 134.0 124.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:143.00 stddev:16.12 (11.3%) stddev-sans-first:16.72 18:51:36 INFO - PROCESS | 2003 | Values: 137.0 130.0 140.0 151.0 178.0 172.0 146.0 134.0 140.0 138.0 18:51:36 INFO - PROCESS | 2003 | 18:51:36 INFO - PROCESS | 2003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.33 18:51:36 INFO - PROCESS | 2003 | Values: 68.0 67.0 67.0 67.0 69.0 66.0 64.0 66.0 66.0 66.0 18:51:36 INFO - PROCESS | 2003 | -------- Summary: end -------- 18:51:36 INFO - PROCESS | 2003 | 18:51:37 INFO - TEST-INFO | 2003: exit 0 18:51:37 INFO - TEST-OK | kraken | took 57004ms 18:51:37 INFO - SUITE-END | took 1170s 18:51:37 INFO - Completed test suite (00:19:30) 18:51:37 INFO - javascript benchmark 18:51:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3389.6779805918436, 3416.3679719251923, 3443.6900678938923, 3458.118179864134, 3491.581010278767, 4877.804937790237, 5398.811041613544, 5516.034693928556, 5611.691356975365, 5613.4386561343845, 5595.244641973332, 5654.519365853907, 5671.602987790846, 5746.569007324447, 5758.884822303551, 5077.416097148838, 5090.9236361454605, 5115.641905066647, 5123.205903085028, 5234.839031694534, 5215.895682086356, 5221.269022336857, 5251.894962100756, 5269.525742683158, 5287.312649355578, 5064.2403639454005, 5068.189089745623, 5170.948290517084, 5183.818566350178, 5239.318888544503, 5149.742512874379, 5160.045391602528, 5168.379794424655, 5169.715665638389, 5178.249153872667, 5087.542121209109, 5142.845714628567, 5146.485351464861, 5159.948400516022, 5168.8966220675375, 5482.068048431776, 5570.442955704438, 5599.7480113394995, 5624.606277560572, 5684.261046063985, 6114.023656277693, 6142.692865356715, 6161.599496032788, 6178.38216178383, 6187.597806142587, 5833.679147646878, 6257.436830685215, 6263.373662633746, 6269.3730626937395, 6277.403646653561, 5624.465675760837, 5687.573431992617, 5741.425857414309, 5753.309602847643, 5763.279590051244, 6265.96867015662, 6295.779647712399, 6299.149614802035, 6309.779157729549, 6317.14718513004, 5891.587588868823, 6034.125051867454, 6042.577019608673, 6044.697765111727, 6046.2139921809885, 6077.3314935357075, 6103.91351630514, 6130.887362650998, 6193.6903154842075, 6204.937950620526, 6073.908891366633, 6082.726277317532, 6084.209052823193, 6084.726187321581, 6090.269167699905, 6098.390160983866, 6105.572609917263, 6106.114613381035, 6114.908276375858, 6119.724612392453, 4800.591949684316, 4836.951630483721, 4837.56461918422, 4850.75746212688, 4859.416869975555, 4240.406343111967, 4307.784610769449, 4347.304431290978, 4363.593009508125, 4407.184670835905, 5497.945020549743, 5598.440155984369, 5610.4670056344585, 5628.774849006076, 5664.065429204135, 6145.033589251397, 6149.2313460817395, 6268.49852011838, 6268.937310626835, 6274.215723034621, 4773.331733557305, 5337.946620533745, 5598.608097433222, 5627.746751396197, 5641.069223578063, 5219.086659834514, 5336.1462166054025, 5342.091844386464, 5348.679079255257, 5372.167314066326, 6198.969005155035, 6201.844953876099, 6271.62370257786, 6275.654838983808, 6288.968555157195, 6228.4705800007505, 6250.593711408744, 6265.216847894013, 6266.279377871603, 6274.215723034621, 6143.60399444226, 6264.342244064308, 6265.279492858197, 6267.529935254783, 6274.905876411766, 5161.845144645667, 6087.421694938974, 6158.815235542941, 6163.722632481638, 6165.784197553064, 6189.597676151036, 6203.8138855834395, 6237.4698150657705, 6250.906236406367, 6256.812295631138, 5895.086261629454, 5960.433758792908, 6012.098185272244, 6046.7278972445465, 6065.727042283196, 6035.0, 6048.334683184934, 6049.909251361145, 6055.122007308827, 6087.0, 5719.599628025998, 5852.590318677651, 5869.853253668693, 5871.794487192928, 5894.793682221101, 5871.119332100219, 5988.700564971647, 6046.57673962836, 6064.0, 6074.149619053424, 5896.086106653475, 5912.349641539513, 5917.053271476543, 5926.911096333644, 5927.081302398135], "unit": "score", "name": "dojo.html", "value": 5629.81497957255}, {"lowerIsBetter": false, "replicates": [563.0062938912822, 568.0570253379391, 579.0301245413933, 629.2511910826119, 633.4045996763043, 30257.638406271715, 30672.38655226894, 38607.0, 38905.0, 39071.60928390722, 41954.790226048906, 42179.78910105453, 42230.36654450178, 42312.0, 42473.0, 9401.529923503815, 9631.47026913523, 9639.180669643089, 9640.71077867665, 9642.0, 9446.338756287063, 9611.66359177429, 9612.134907858292, 9614.471204083773, 9638.951805240964, 9539.379940303857, 9561.521923903812, 9714.514274286294, 9736.172425343819, 9765.90234097657, 9666.854997175047, 9721.0, 9750.75623109428, 9753.707388778348, 9756.560954757053, 9570.521473926276, 9583.856242156373, 9584.520773961274, 9585.90414095864, 9703.563339649732, 40954.79522602368, 41421.96445088897, 41454.963625909295, 41458.0, 41583.792081039704, 3324.1523411530147, 3386.8137252451106, 3395.5925288965236, 3419.6580341965605, 3479.9652003479896, 28744.856275718696, 28940.408277544728, 28964.565531517044, 29057.12828615145, 29620.259493512618, 2710.9593356099676, 2756.2144788735313, 2766.681831589373, 2823.5058864698594, 2864.4843928092937, 350101.0, 350397.0, 350621.99999999744, 350791.0, 351314.0, 45275.32087018697, 45714.085718285445, 45797.31304030442, 45826.85432864205, 64636.0, 44823.32765008527, 44983.875403115184, 45034.77482612566, 45208.54791452109, 45279.77360113178, 15464.994775339566, 15638.45265415705, 15654.982426142264, 15669.843301567067, 15674.373025079098, 12497.625071247878, 12576.37118144089, 12584.81122783159, 12594.370281486072, 12666.556670516487, 14776.113433194043, 14797.852021479648, 14812.407503699731, 14825.70348593022, 14926.850731492763, 6074.969625151846, 6193.318734939153, 6251.843703907439, 6257.561970662101, 6279.0, 950.7147855643418, 973.1825266775942, 1103.426218366461, 1117.446863802423, 1138.612871623652, 29440.263993400335, 30246.395072098876, 30516.08451746451, 30521.0, 30732.692673072983, 1076.262760009396, 1078.0, 1083.853679753239, 1095.794625911507, 1168.661088284388, 14618.415263389557, 14647.267636618126, 15054.774178387333, 15063.698726025637, 15251.847481525265, 641004.0, 641394.0, 646980.0, 647703.0, 647932.0, 58232.7088364564, 59167.70416147978, 59193.70403147957, 59293.11060334098, 59390.95176909924, 1305.3473263368505, 1355.728854229158, 1462.5539210540887, 1496.1172907984342, 1504.0599625234229, 28301.0, 29117.0, 29381.11856644304, 29778.10665680033, 29880.069788484656, 39545.60454395534, 49394.75302623464, 49426.50573494363, 49472.75263623659, 49700.75149624229, 380376.0, 393668.0, 394682.0, 394740.0, 395249.0, 27808.44383112286, 32013.839930800197, 32014.83992580022, 32412.35175296528, 32674.673253267163, 32574.837125814218, 35839.104022399646, 39591.604083958795, 40687.38968915409, 41198.58801412067, 30419.54370684486, 32894.0, 34135.658643414245, 34651.78718744832, 35018.12454688653, 33488.0, 33503.83248083744, 34154.48768268428, 34205.315893682484, 34929.47605785966, 35296.47055294121, 35499.64500354963, 36047.0, 36095.27809443744, 36190.8190459046, 29600.851995739882, 30746.077617671504, 30900.1459912406, 30954.226144346572, 31128.066158015296, 23620.763792362544, 23689.407764805328, 23949.880250598635, 24056.0, 24089.397765056015], "unit": "score", "name": "ext.html", "value": 18742.329616362033}, {"lowerIsBetter": false, "replicates": [354.62232722150907, 359.5846796949524, 360.02971990485634, 364.08977556109727, 371.7249235565682, 19394.41816745498, 19766.90116549417, 20253.696194557095, 20773.896130519326, 20799.584008319824, 19461.805381946175, 20041.298554550594, 20425.795742042574, 20670.793292067076, 20688.379348619565, 5702.258706368177, 5901.498372638331, 5903.675297858616, 5910.290765108193, 5920.911186332209, 3334.716549093318, 4306.7631280279575, 5854.73653685583, 6437.452816510602, 6485.0, 6372.107904893319, 6404.359564043605, 6419.0, 6422.550421470499, 6423.775167869126, 6189.350118237565, 6283.5915665481825, 6361.173047503841, 6367.140436041168, 6384.648844313561, 3696.8890933271778, 5269.815556455505, 5455.618106732531, 5479.4520547945285, 5479.972600136974, 21397.786022139735, 23969.0, 24210.39474013146, 24538.386540336454, 24550.754492455024, 2049.333966460906, 2057.6501994660944, 2096.790320967906, 2155.3641675705703, 2361.504084142332, 13279.601611951657, 13598.456061757517, 13941.86058139426, 14435.566932991922, 14488.20314882681, 1667.5997760537505, 1688.577855536116, 1745.7992330881984, 1755.7980832204332, 1771.406578796105, 89614.0, 93497.53251233768, 93634.59548106784, 93700.0, 94546.5088958538, 10098.192144628412, 10125.392476451289, 10364.170866330676, 10523.105536029523, 10620.893791062144, 10779.0, 12636.2418254905, 12745.17156384832, 12753.171043882117, 12757.617271481871, 8136.511809291462, 8280.544570048705, 8281.95859020701, 8366.665333386718, 8374.748757537283, 8498.405111642125, 8518.87221691675, 8533.573321333908, 8619.0, 8658.740237792876, 5899.734511946886, 5997.600959616188, 6010.579259451883, 6018.879622407528, 6050.969745151246, 1642.8439298266646, 1724.1637805664243, 1725.0770837601822, 1728.1013872786082, 1755.973660395095, 836.5817091454273, 972.3193764364972, 997.5112195024386, 1031.1338475680463, 1108.1910205549993, 19420.0, 19894.50263743418, 19976.500587485138, 20092.0, 20138.388928885655, 853.6841368693623, 918.4489306416231, 932.4871320773548, 958.5878072428923, 980.4068538534227, 10795.6221532246, 11014.834777478345, 11068.667939961813, 11096.389698566494, 11250.606228781953, 558115.0, 562876.0, 568207.0, 574707.0, 583544.0, 90425.0, 90446.54776726074, 92610.07389926014, 93932.53033734788, 95530.52234738781, 1035.0994634667886, 1053.2785042246087, 1053.2995557953875, 1070.7269646240159, 1072.2065671403107, 14836.554903352917, 14934.925325373304, 15836.0, 16685.581725553464, 18779.530511736768, 37387.252254955296, 45540.31689524726, 47732.04535909193, 48979.75510122427, 49278.0, 63626.68186659037, 65177.0, 65290.36774080496, 67386.66306668436, 69888.65055674688, 6388.776392826228, 7346.449016323691, 7645.847083058419, 7739.071311442663, 7816.64825082884, 10740.194485413782, 11736.647900562997, 12452.937735311265, 12574.245545267313, 12622.431990560262, 10725.946370268099, 10828.620998265023, 10955.83566246491, 11119.16606254518, 11134.443277835913, 8557.529335886586, 10580.788384232426, 10865.348079115278, 10884.564617415215, 11093.445327733742, 11056.336619802838, 11287.43562821872, 11671.59149429766, 11724.413779311171, 11748.0, 7068.0, 7706.113796913202, 7753.147153812964, 7766.88349674744, 7787.961060194662, 10419.0, 11164.776704466027, 11423.0, 11447.828282575601, 11454.942725286654], "unit": "score", "name": "jquery.html", "value": 9227.237695747932}, {"lowerIsBetter": false, "replicates": [1439.964000899978, 1526.1377321813181, 1529.4035326222775, 1601.1913983438365, 1887.6979683250684, 6433.839154021146, 7926.731722924334, 8366.330693544516, 8534.530600816968, 8590.183932526415, 8387.790305242357, 8437.535935523543, 8522.531260780655, 8524.275436587897, 8531.488110713362, 2430.8906099225533, 2460.5447992121517, 2460.815438842085, 2465.4575993281537, 2469.148143890364, 2400.063975049732, 2406.65227472615, 2485.179890636086, 2489.3776555861036, 2491.0658503061354, 2440.792532634728, 2454.5459090068393, 2480.5659009673236, 2486.639437281593, 2486.9129580464687, 2431.4529230923076, 2444.9755502444928, 2464.691913510811, 2467.7408872068354, 2470.110760126353, 2424.527217192648, 2444.401121725171, 2455.2020593307248, 2465.408302007523, 2468.308873515419, 8512.659493620247, 8534.445261058012, 8543.444676096096, 8572.742817715478, 8574.614142363609, 5258.605604579672, 5410.729463526808, 5459.426760190163, 5459.69971651559, 5459.918101228484, 3530.876419325337, 3588.5693716753894, 3652.2330310634798, 3667.504886840269, 3668.5054163169034, 1046.7330830638214, 1065.0787069185176, 1070.454068425101, 1075.8870318616512, 1077.9245452818307, 11599.768004639944, 11614.070874330033, 11624.476898539586, 11651.708707282301, 11660.88339116598, 4021.3967904814513, 4711.316859055418, 4800.423949126127, 4813.109574728686, 4850.854474365775, 9864.112229899343, 9877.703668889944, 9906.60373585063, 9909.454979976026, 9949.0, 5392.838214853561, 5397.892042159135, 5400.62195646301, 5403.162509810907, 5423.457654234624, 4388.890277743082, 4535.138323718483, 4777.092352453023, 4913.9017219656125, 4943.530364615428, 3761.0851590017955, 3839.212961342918, 3848.846046158122, 3883.980580097081, 3902.434147048719, 1277.6805798550363, 1290.864459231786, 1291.5479582146174, 1301.225770666452, 1303.7392521495549, 1014.2747935226201, 1033.5865653738565, 1172.5427083437296, 1263.532492977604, 1394.874461298488, 7774.028246469192, 7815.296623303816, 7821.960890195626, 7896.842063158705, 7909.762707118795, 1174.1370092981651, 1188.8157335612993, 1189.381521608776, 1191.4578866615668, 1216.0818581970732, 6151.815445536641, 6173.228346456693, 6188.721507532172, 6219.60545190105, 6223.813285601439, 10078.949605251926, 10249.487525623688, 10279.640212592523, 10286.177105831515, 10412.635557755593, 10002.099811017044, 10099.242556808122, 10148.543315550818, 10178.847317290247, 10255.33340332876, 7777.57223352721, 7896.7236146734585, 7919.049714034353, 7999.3200577950365, 8013.799655008672, 7615.923840761521, 7756.069271687434, 7807.063152421746, 7838.647260873388, 7851.803704907423, 9136.908630913606, 9273.86089208649, 9496.335256531976, 9517.904820951702, 9552.283578731762, 9496.952515237379, 9830.606775728891, 9872.259580531345, 9900.752481188028, 9975.551100200364, 7375.446841487017, 7411.4070874328845, 7483.176850546544, 7507.436942229246, 7518.473706840468, 7926.167752385916, 8077.071136819106, 8128.187181281824, 8129.512229266263, 8138.104808470945, 5495.340559132929, 7283.781486555412, 7290.708371665074, 7394.038774959221, 7438.0, 6292.898742720097, 6445.581037232565, 7116.181639111568, 7250.927490725026, 7277.563346199245, 7471.290137757647, 7632.923670763222, 7705.30652241301, 7722.768316950501, 7732.8453430932195, 6982.301769822977, 6984.3364880336285, 7043.330883566053, 7048.929510704827, 7057.929420705933, 7033.331833475811, 7079.504434689522, 7085.574865508086, 7111.43108551325, 7114.395276401357], "unit": "score", "name": "mootools.html", "value": 4859.033281496008}, {"lowerIsBetter": false, "replicates": [322.5774235751166, 324.4792108665592, 332.0966969842029, 332.88681848171615, 337.40616514933726, 5120.436751957282, 5936.910946335808, 6249.093881387202, 6294.244690637124, 6357.554971152022, 5411.648242864221, 6254.624722516641, 6291.1821463209835, 6292.056191571267, 6302.149209856668, 4500.257457519506, 4616.469106052797, 4680.625549955996, 4690.601298889582, 4726.716397016182, 4576.427946506687, 4687.20317546018, 4693.671442998992, 4711.717296962193, 4736.502667219944, 3855.4024126260474, 4646.395968524104, 4658.790354434059, 4680.485146633868, 4684.789184486689, 4425.712328698624, 4645.02454484557, 4650.86047418578, 4671.5795578397765, 4674.696144750597, 3416.1630400551776, 3876.186000939806, 3988.441618173458, 3994.460747799039, 4000.159966407058, 5782.971085144547, 5840.532757379399, 5864.736086876101, 5912.3496415394275, 5928.081147422156, 5457.918131228034, 5467.715086954562, 5478.58910581708, 5479.945200547983, 5485.314335708036, 6568.441682456997, 6615.503837212228, 6626.304238054983, 6628.370304821083, 6643.900341494881, 4493.28107502798, 4502.2571275739465, 4505.5719706627815, 4511.8646440606835, 4513.736153876887, 6689.0, 6965.5124141310125, 7036.612986285752, 7041.823954401181, 7056.576605403692, 4355.08543205924, 4431.313146462304, 4440.4227450431235, 4442.755648439367, 4446.399736035659, 4517.277235642281, 4517.5256598057385, 4521.547845215452, 4527.501974782771, 4529.433820772403, 5304.204369344552, 5311.575073994071, 5313.760880760375, 5317.175837745156, 5320.2817619620855, 5632.859178520488, 6494.058361537551, 6653.866922661519, 6657.933420665731, 6664.900026499607, 1482.8285654333172, 1555.5488908216491, 1561.234994852514, 1566.600516868214, 1568.5843251538352, 998.9500524973868, 1002.173207104142, 1007.2395341517108, 1012.0436187802603, 1021.1881554164457, 5889.882202355929, 6065.181200537871, 6067.817965461043, 6078.422549857756, 6091.360407157184, 6851.760188393482, 6854.3145685432055, 6854.554453960576, 6865.0732151159955, 6868.416184624363, 5002.474740152305, 5782.537397008229, 6131.110988906584, 6132.448079672851, 6140.570160088841, 3599.3341231872187, 3641.471986561987, 3648.5074514940675, 3654.5066416033496, 3659.2315613720884, 6933.0, 7218.927810721825, 7222.494425390278, 7226.1328640562415, 7226.602536860418, 7126.643667816588, 7134.714611415589, 7145.392641625416, 7160.606166660884, 7163.212046674862, 7108.573485590881, 7171.426285897116, 7202.243764404767, 7204.0994875640545, 7205.531640443354, 6025.367336429612, 6459.5478316519275, 6883.3116688330765, 6891.414229790324, 6899.379055884994, 6523.24982627004, 6793.354631310018, 6794.524383293122, 6805.251422343637, 6816.693248803716, 6146.801373732079, 6943.0, 7188.424926005802, 7199.388052015637, 7219.855602887807, 3714.6627214202326, 4354.325079612665, 4367.585079417578, 4418.867433976986, 4419.977900110479, 6904.861902762017, 6906.136732908387, 6912.896306555305, 6915.132914113262, 6915.930840691529, 6664.83337916556, 6676.132102826796, 6702.497312701665, 6702.994550817221, 6714.6642667865435, 6446.323136070645, 6664.50016248793, 6778.966105169443, 6780.898286525608, 6793.592384456949, 6578.8355291118105, 6598.67006649656, 6607.00894865774, 6616.503762217949, 6621.966890165519, 6726.8654626908165, 6745.3591908768585, 6751.696173672295, 6753.358430949052, 6768.390844823989, 6596.934030659824, 6608.107905432705, 6613.305602911625, 6617.43751781104, 6621.1392518972225], "unit": "score", "name": "prototype.html", "value": 4874.628230909427}, {"lowerIsBetter": false, "replicates": [714.6426786606696, 734.331758100129, 764.1441585424325, 767.612355760341, 771.8109063279497, 14778.482753103644, 15138.470153544627, 15144.924275378622, 15149.621259468518, 15154.545363639094, 11628.592999245027, 13706.58880233592, 13841.653958651039, 13853.515126970558, 13897.583072507816, 722.5989575785437, 736.9042024536802, 887.9733607991739, 904.199783191875, 909.6679711905173, 900.6262401103534, 905.2938707807921, 906.5376657904483, 908.7455512456522, 909.3770767024577, 967.9225661947063, 978.5547575853005, 979.7599588100925, 979.8530220466952, 983.3902980152316, 760.1979911193661, 943.834828904939, 965.560669895196, 966.4056605187794, 970.1365784451843, 691.8581690753383, 707.3174386716792, 723.3417589993081, 723.3851226457522, 724.344468256229, 14480.275986200753, 14535.636609084751, 14542.70914581713, 14546.781798273034, 14576.927115364462, 12685.873141268561, 12705.364731763468, 12933.417996190099, 13075.607731767966, 13206.73586528264, 8438.4515006525, 9839.409635421898, 10117.544710487971, 10138.0, 10617.256792024562, 3452.68925796677, 3505.8772942946875, 3549.2014296783277, 3638.5451818522683, 3776.0, 78487.0, 78753.0, 80964.0, 81033.0, 81136.18863811345, 9410.623575057058, 9411.529423528797, 9429.528523573794, 9661.372010819274, 9815.067568580973, 20770.688439673417, 20791.1683532657, 20991.265305714227, 20998.265060722802, 21028.264010759856, 7082.362587367162, 7087.334247828148, 7126.572405655677, 7139.643017849086, 7291.380232680175, 3596.7122630189524, 4003.799810009488, 4056.492938382702, 4090.611391917763, 4121.876343709693, 3406.8466918988706, 3490.458978858281, 3492.2666240089357, 3494.7204223662047, 3495.580530336325, 646.8706258748269, 647.1683886206202, 653.5621133840339, 664.7440735316937, 667.4793660944471, 526.3841305672372, 541.4693600271677, 566.3006187358609, 590.1560768101656, 592.7332700284803, 7859.52842829432, 8328.6668533258, 8696.826063478695, 8835.867461988075, 8847.350781998106, 547.7343488408119, 584.9619774714715, 609.9176611157437, 614.6373639552685, 627.2003195925141, 3761.6426439488205, 3840.577536470986, 3865.729398942103, 3888.786116763605, 3935.0752573145287, 89185.20296180858, 97084.54373184408, 99919.00080999098, 100868.0, 100930.0, 70404.64797676081, 85373.14626853776, 85700.28599427977, 86027.0, 86685.99999999873, 74706.99999999891, 75217.24782752212, 75346.0, 75442.0, 76739.61630191813, 7735.497192682683, 7839.216078392115, 7843.820291816861, 7976.960115199387, 7993.920060799318, 46201.537984619725, 48567.514324856296, 52455.0, 52458.213126802366, 52695.73652131868, 47667.28499072586, 68353.65823170853, 70996.64501677458, 72407.0, 72889.0, 9680.741503604486, 10358.274920755475, 10408.219383546113, 10596.841047384141, 10967.23229373968, 10516.474176291307, 10893.836592451278, 10907.836382454429, 10949.671509854717, 11365.54537818478, 10230.693079207338, 10282.331648442827, 10421.68734937953, 10727.517261723086, 10921.781564368826, 10434.739131521468, 10446.320989135682, 10766.138708903425, 10783.946080269548, 10812.621558245739, 8600.78498037554, 10214.029667181605, 10305.896941030494, 10622.20333474977, 10628.89371106279, 7981.161977992228, 8436.367272454714, 8553.44402613853, 8903.243224325746, 9205.941683477049, 8511.95744021276, 8598.312135029308, 8859.689910853347, 8909.688160914597, 8948.194662480408], "unit": "score", "name": "yui.html", "value": 6788.086599054296}], "name": "dromaeo_css", "value": 7341.370991095649}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 113.0, 117.0, 110.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [158.0, 124.0, 146.0, 164.0, 119.0, 144.0, 139.0, 119.0, 164.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 139.0}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 185.0, 185.0, 184.0, 188.0, 193.0, 259.0, 179.0, 184.0], "unit": "score", "name": "audio-dft", "value": 192.7}, {"lowerIsBetter": true, "replicates": [81.0, 73.0, 83.0, 81.0, 76.0, 83.0, 83.0, 100.0, 80.0, 58.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [90.0, 101.0, 126.0, 81.0, 78.0, 80.0, 114.0, 79.0, 77.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 135.0, 85.0, 88.0, 85.0, 89.0, 85.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 116.0, 149.0, 94.0, 94.0, 94.0, 100.0, 89.0], "unit": "score", "name": "imaging-darkroom", "value": 101.8}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 88.0, 84.0, 86.0, 108.0, 109.0, 84.0, 84.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 90.0}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 53.0, 51.0, 52.0, 54.0, 53.0, 63.0, 54.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 53.9}, {"lowerIsBetter": true, "replicates": [64.0, 70.0, 76.0, 74.0, 71.0, 66.0, 66.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 85.0, 83.0, 83.0, 84.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [123.0, 132.0, 131.0, 121.0, 122.0, 123.0, 123.0, 125.0, 134.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [137.0, 130.0, 140.0, 151.0, 178.0, 172.0, 146.0, 134.0, 140.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 69.0, 66.0, 64.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1445.7999999999997}]} 18:51:37 INFO - Return code: 0 18:51:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:51:37 ERROR - # TBPL SUCCESS # 18:51:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:37 INFO - 2016-04-01 18:51:37.770 screenresolution[2007:33626] starting screenresolution argv=screenresolution get 18:51:37 INFO - 2016-04-01 18:51:37.773 screenresolution[2007:33626] Display 0: 1600x1200x32@60 18:51:37 INFO - 2016-04-01 18:51:37.778 screenresolution[2008:33628] starting screenresolution argv=screenresolution list 18:51:37 INFO - Available Modes on Display 0 18:51:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:38 INFO - Intel Iris: 18:51:38 INFO - Chipset Model: Intel Iris 18:51:38 INFO - Type: GPU 18:51:38 INFO - Bus: Built-In 18:51:38 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:38 INFO - Vendor: Intel (0x8086) 18:51:38 INFO - Device ID: 0x0a2e 18:51:38 INFO - Revision ID: 0x0009 18:51:38 INFO - Displays: 18:51:38 INFO - Display: 18:51:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:38 INFO - Display Serial Number: 1600x1200 60 18:51:38 INFO - Main Display: Yes 18:51:38 INFO - Mirror: Off 18:51:38 INFO - Online: Yes 18:51:38 INFO - Rotation: Supported 18:51:38 INFO - Return code: 0 18:51:38 INFO - Running post-action listener: _resource_record_post_action 18:51:38 INFO - Running post-run listener: _resource_record_post_run 18:51:39 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 475136; Write bytes: 702868992; Read time: 6; Write time: 1911 18:51:39 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403001856; Write bytes: 399767040; Read time: 30291; Write time: 708 18:51:39 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 475136; Write bytes: 297191424; Read time: 6; Write time: 1176 18:51:39 INFO - Running post-run listener: _upload_blobber_files 18:51:39 INFO - Blob upload gear active. 18:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:39 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 18:51:39 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:51:39 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:40 INFO - (blobuploader) - INFO - Done attempting. 18:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:41 INFO - (blobuploader) - INFO - Done attempting. 18:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:41 INFO - Return code: 0 18:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7604e06c64bfd22e29411858d8c6a78fa0c688d531a53721ccba064624576ef1e915e3ae65b18d642bd9104cdf13f79504ec107fedbee706a45c220fb7338dd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1583964da32cfa46dd4f40b7aaf8caa69cb15c432f1afa4af6109e0a7bced066edb29d7f1ce1f07d2dc5231b4781594da4bcf2d6749c3c38ccec3bca95c04249"} 18:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:51:41 INFO - Contents: 18:51:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7604e06c64bfd22e29411858d8c6a78fa0c688d531a53721ccba064624576ef1e915e3ae65b18d642bd9104cdf13f79504ec107fedbee706a45c220fb7338dd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1583964da32cfa46dd4f40b7aaf8caa69cb15c432f1afa4af6109e0a7bced066edb29d7f1ce1f07d2dc5231b4781594da4bcf2d6749c3c38ccec3bca95c04249"} 18:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:41 INFO - Copying logs to upload dir... 18:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 18:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.393708 ========= master_lag: 5.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-01 18:51:46.581983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-01 18:51:46.583244) ========= 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.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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/Fx-Team/sha512/7604e06c64bfd22e29411858d8c6a78fa0c688d531a53721ccba064624576ef1e915e3ae65b18d642bd9104cdf13f79504ec107fedbee706a45c220fb7338dd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1583964da32cfa46dd4f40b7aaf8caa69cb15c432f1afa4af6109e0a7bced066edb29d7f1ce1f07d2dc5231b4781594da4bcf2d6749c3c38ccec3bca95c04249"} build_url:https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011062 build_url: 'https://queue.taskcluster.net/v1/task/Zkayfi3fSVOmhAOiOuzRXA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7604e06c64bfd22e29411858d8c6a78fa0c688d531a53721ccba064624576ef1e915e3ae65b18d642bd9104cdf13f79504ec107fedbee706a45c220fb7338dd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1583964da32cfa46dd4f40b7aaf8caa69cb15c432f1afa4af6109e0a7bced066edb29d7f1ce1f07d2dc5231b4781594da4bcf2d6749c3c38ccec3bca95c04249"}' ========= master_lag: 1.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-01 18:51:47.784004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-04-01 18:51:47.784354) ========= 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.J9WLIARCAJ/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.TG1tEurzO1/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005155 ========= master_lag: 7.85 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-04-01 18:51:55.641066) ========= ========= Started reboot skipped (results: 3, elapsed: 16 secs) (at 2016-04-01 18:51:55.641374) ========= ========= Finished reboot skipped (results: 3, elapsed: 16 secs) (at 2016-04-01 18:52:12.562684) ========= ========= Total master_lag: 16.23 =========