builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0132 starttime: 1459743335.3 results: success (0) buildid: 20160403184215 builduid: f411a7e016294932a094dfce1bd76bf0 revision: fc4a988ca8d61e809bb30ef635ad50e189f742b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.296152) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.297675) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.298301) ========= 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.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005402 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.390880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.391427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.452185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.452630) ========= 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.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005671 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.505401) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.506096) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.506938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.507603) ========= 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.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-03 21:15:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.8M=0.001s 2016-04-03 21:15:35 (16.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.732411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.732733) ========= 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.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.026707 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.799681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:35.800044) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc4a988ca8d61e809bb30ef635ad50e189f742b3 --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 fc4a988ca8d61e809bb30ef635ad50e189f742b3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-03 21:15:35,882 truncating revision to first 12 chars 2016-04-03 21:15:35,883 Setting DEBUG logging. 2016-04-03 21:15:35,883 attempt 1/10 2016-04-03 21:15:35,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc4a988ca8d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-03 21:15:36,547 unpacking tar archive at: fx-team-fc4a988ca8d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:36.732762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:36.733121) ========= echo fc4a988ca8d61e809bb30ef635ad50e189f742b3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fc4a988ca8d61e809bb30ef635ad50e189f742b3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 fc4a988ca8d61e809bb30ef635ad50e189f742b3 program finished with exit code 0 elapsedTime=0.005378 script_repo_revision: 'fc4a988ca8d61e809bb30ef635ad50e189f742b3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:36.786083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:36.786493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 21:15:36.804619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-03 21:15:36.804956) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:15:36 INFO - MultiFileLogger online at 20160403 21:15:36 in /builds/slave/test 21:15:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:15:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:15:36 INFO - {'append_to_log': False, 21:15:36 INFO - 'base_work_dir': '/builds/slave/test', 21:15:36 INFO - 'blob_upload_branch': 'Fx-Team', 21:15:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:15:36 INFO - 'branch': 'Fx-Team', 21:15:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:15:36 INFO - 'config_files': ('talos/mac_config.py',), 21:15:36 INFO - 'default_actions': ('clobber', 21:15:36 INFO - 'read-buildbot-config', 21:15:36 INFO - 'download-and-extract', 21:15:36 INFO - 'populate-webroot', 21:15:36 INFO - 'create-virtualenv', 21:15:36 INFO - 'install', 21:15:36 INFO - 'run-tests'), 21:15:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:15:36 INFO - 'download_minidump_stackwalk': True, 21:15:36 INFO - 'download_symbols': 'ondemand', 21:15:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:15:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:15:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:15:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:15:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:15:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:15:36 INFO - 'installer_path': 'installer.exe', 21:15:36 INFO - 'log_level': 'info', 21:15:36 INFO - 'log_name': 'talos', 21:15:36 INFO - 'log_to_console': True, 21:15:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:15:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:15:36 INFO - 'opt_config_files': (), 21:15:36 INFO - 'pip_index': False, 21:15:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:15:36 INFO - 'cmd': ('bash', 21:15:36 INFO - '-c', 21:15:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:15:36 INFO - 'enabled': True, 21:15:36 INFO - 'halt_on_failure': False, 21:15:36 INFO - 'name': 'check_screen_resolution'},), 21:15:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:15:36 INFO - 'cmd': ('bash', 21:15:36 INFO - '-c', 21:15:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:15:36 INFO - 'enabled': True, 21:15:36 INFO - 'halt_on_failure': False, 21:15:36 INFO - 'name': 'check_screen_resolution'},), 21:15:36 INFO - 'run_cmd_checks_enabled': True, 21:15:36 INFO - 'sps_profile': False, 21:15:36 INFO - 'sps_profile_interval': 0, 21:15:36 INFO - 'suite': 'dromaeojs-e10s', 21:15:36 INFO - 'system_bits': '32', 21:15:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:15:36 INFO - 'title': 't-yosemite-r7-0132', 21:15:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:15:37 INFO - 'use_talos_json': True, 21:15:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:15:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:15:37 INFO - 'work_dir': 'build'} 21:15:37 INFO - ##### 21:15:37 INFO - ##### Running clobber step. 21:15:37 INFO - ##### 21:15:37 INFO - Running pre-action listener: _resource_record_pre_action 21:15:37 INFO - Running main action method: clobber 21:15:37 INFO - rmtree: /builds/slave/test/build 21:15:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:15:38 INFO - Running post-action listener: _resource_record_post_action 21:15:38 INFO - ##### 21:15:38 INFO - ##### Running read-buildbot-config step. 21:15:38 INFO - ##### 21:15:38 INFO - Running pre-action listener: _resource_record_pre_action 21:15:38 INFO - Running main action method: read_buildbot_config 21:15:38 INFO - Using buildbot properties: 21:15:38 INFO - { 21:15:38 INFO - "project": "", 21:15:38 INFO - "product": "firefox", 21:15:38 INFO - "script_repo_revision": "production", 21:15:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 21:15:38 INFO - "repository": "", 21:15:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 21:15:38 INFO - "buildid": "20160403184215", 21:15:38 INFO - "pgo_build": "False", 21:15:38 INFO - "basedir": "/builds/slave/test", 21:15:38 INFO - "buildnumber": 584, 21:15:38 INFO - "slavename": "t-yosemite-r7-0132", 21:15:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:15:38 INFO - "platform": "yosemite_r7", 21:15:38 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 21:15:38 INFO - "branch": "fx-team", 21:15:38 INFO - "repo_path": "integration/fx-team", 21:15:38 INFO - "revision": "fc4a988ca8d61e809bb30ef635ad50e189f742b3", 21:15:38 INFO - "stage_platform": "macosx64", 21:15:38 INFO - "builduid": "f411a7e016294932a094dfce1bd76bf0", 21:15:38 INFO - "slavebuilddir": "test" 21:15:38 INFO - } 21:15:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 21:15:38 INFO - Running post-action listener: _resource_record_post_action 21:15:38 INFO - ##### 21:15:38 INFO - ##### Running download-and-extract step. 21:15:38 INFO - ##### 21:15:38 INFO - Running pre-action listener: _resource_record_pre_action 21:15:38 INFO - Running main action method: download_and_extract 21:15:38 INFO - mkdir: /builds/slave/test/build/tests 21:15:38 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')]} 21:15:38 INFO - https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:15:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:15:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:15:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:41 INFO - Downloaded 1199 bytes. 21:15:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:15:41 INFO - Using the following test package requirements: 21:15:41 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:15:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 21:15:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 21:15:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'jsshell-mac.zip'], 21:15:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 21:15:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:15:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 21:15:41 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 21:15:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 21:15:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:15:41 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 21:15:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:15: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')]} 21:15:41 INFO - https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:50 INFO - Downloaded 17959619 bytes. 21:15:50 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'] 21:15:50 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 21:15:53 INFO - Return code: 0 21:15:53 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 21:15: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')]} 21:15:53 INFO - https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:54 INFO - Downloaded 17959619 bytes. 21:15:54 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'] 21:15:54 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 21:15:58 INFO - Return code: 0 21:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:58 INFO - https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:15:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:15:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:15:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:15:59 INFO - Downloaded 10847584 bytes. 21:15:59 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'] 21:15:59 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 21:15:59 INFO - Return code: 0 21:15:59 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')]} 21:15:59 INFO - https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 21:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWplx0aySrmwbDOSxejCjA/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 21:16:04 INFO - Downloaded 111241346 bytes. 21:16:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:16:04 INFO - mkdir: /builds/slave/test/properties 21:16:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:16:04 INFO - Writing to file /builds/slave/test/properties/build_url 21:16:04 INFO - Contents: 21:16:04 INFO - build_url:https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:16:05 INFO - Running post-action listener: _resource_record_post_action 21:16:05 INFO - Running post-action listener: set_extra_try_arguments 21:16:05 INFO - ##### 21:16:05 INFO - ##### Running populate-webroot step. 21:16:05 INFO - ##### 21:16:05 INFO - Running pre-action listener: _resource_record_pre_action 21:16:05 INFO - Running main action method: populate_webroot 21:16:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:16:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:16:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:16:05 INFO - '--tppagecycles', 21:16:05 INFO - '7'], 21:16:05 INFO - 'tests': ['tsvgm']}}, 21:16:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:16:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:16:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:16:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:16:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:16:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:16:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'tests': ['damp', 'tps']}, 21:16:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['damp', 'tps']}, 21:16:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:16:05 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['dromaeo_dom']}, 21:16:05 INFO - 'other': {'tests': ['a11yr', 21:16:05 INFO - 'ts_paint', 21:16:05 INFO - 'tpaint', 21:16:05 INFO - 'sessionrestore', 21:16:05 INFO - 'sessionrestore_no_auto_restore', 21:16:05 INFO - 'tabpaint']}, 21:16:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['a11yr', 21:16:05 INFO - 'ts_paint', 21:16:05 INFO - 'tpaint', 21:16:05 INFO - 'sessionrestore', 21:16:05 INFO - 'sessionrestore_no_auto_restore', 21:16:05 INFO - 'tabpaint']}, 21:16:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['a11yr', 21:16:05 INFO - 'ts_paint', 21:16:05 INFO - 'tpaint', 21:16:05 INFO - 'sessionrestore', 21:16:05 INFO - 'sessionrestore_no_auto_restore', 21:16:05 INFO - 'tabpaint']}, 21:16:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['a11yr', 21:16:05 INFO - 'ts_paint', 21:16:05 INFO - 'tpaint', 21:16:05 INFO - 'sessionrestore', 21:16:05 INFO - 'sessionrestore_no_auto_restore', 21:16:05 INFO - 'tabpaint']}, 21:16:05 INFO - 'other_l64': {'tests': ['a11yr', 21:16:05 INFO - 'ts_paint', 21:16:05 INFO - 'tpaint', 21:16:05 INFO - 'sessionrestore', 21:16:05 INFO - 'sessionrestore_no_auto_restore', 21:16:05 INFO - 'tabpaint']}, 21:16:05 INFO - 'other_nol64': {'tests': ['a11yr', 21:16:05 INFO - 'ts_paint', 21:16:05 INFO - 'tpaint', 21:16:05 INFO - 'sessionrestore', 21:16:05 INFO - 'sessionrestore_no_auto_restore', 21:16:05 INFO - 'tabpaint']}, 21:16:05 INFO - 'svgr': {'tests': ['tsvgx', 21:16:05 INFO - 'tsvgr_opacity', 21:16:05 INFO - 'tart', 21:16:05 INFO - 'tscrollx', 21:16:05 INFO - 'cart']}, 21:16:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['tsvgx', 21:16:05 INFO - 'tsvgr_opacity', 21:16:05 INFO - 'tart', 21:16:05 INFO - 'tscrollx', 21:16:05 INFO - 'cart']}, 21:16:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'tests': ['tp5o']}, 21:16:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'talos_options': ['--e10s'], 21:16:05 INFO - 'tests': ['tp5o']}, 21:16:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'talos_options': ['--xperf_path', 21:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:16:05 INFO - 'tests': ['tp5n']}, 21:16:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:05 INFO - 'talos_options': ['--e10s', 21:16:05 INFO - '--xperf_path', 21:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:16:05 INFO - 'tests': ['tp5n']}}, 21:16:05 INFO - 'talos.zip': {'path': '', 21:16:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:16:05 INFO - Running post-action listener: _resource_record_post_action 21:16:05 INFO - ##### 21:16:05 INFO - ##### Running create-virtualenv step. 21:16:05 INFO - ##### 21:16:05 INFO - Running pre-action listener: _resource_record_pre_action 21:16:05 INFO - Running main action method: create_virtualenv 21:16:05 INFO - Creating virtualenv /builds/slave/test/build/venv 21:16:05 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 21:16:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:16:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:16:05 INFO - Using real prefix '/tools/python27' 21:16:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:16:06 INFO - Installing distribute.............................................................................................................................................................................................done. 21:16:09 INFO - Installing pip.................done. 21:16:09 INFO - Return code: 0 21:16:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:09 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:09 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 21:16:09 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 21:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:09 INFO - 'HOME': '/Users/cltbld', 21:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:09 INFO - 'LOGNAME': 'cltbld', 21:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:09 INFO - 'MOZ_NO_REMOTE': '1', 21:16:09 INFO - 'NO_EM_RESTART': '1', 21:16:09 INFO - 'PAGER': '/bin/cat', 21:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:09 INFO - 'PWD': '/builds/slave/test', 21:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:09 INFO - 'SHELL': '/bin/bash', 21:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:09 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:09 INFO - 'USER': 'cltbld', 21:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:09 INFO - 'XPC_FLAGS': '0x0', 21:16:09 INFO - 'XPC_SERVICE_NAME': '0', 21:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:09 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 21:16:09 INFO - Cleaning up... 21:16:09 INFO - Return code: 0 21:16:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:09 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:09 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 21:16:09 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 21:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:09 INFO - 'HOME': '/Users/cltbld', 21:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:09 INFO - 'LOGNAME': 'cltbld', 21:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:09 INFO - 'MOZ_NO_REMOTE': '1', 21:16:09 INFO - 'NO_EM_RESTART': '1', 21:16:09 INFO - 'PAGER': '/bin/cat', 21:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:09 INFO - 'PWD': '/builds/slave/test', 21:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:09 INFO - 'SHELL': '/bin/bash', 21:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:09 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:09 INFO - 'USER': 'cltbld', 21:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:09 INFO - 'XPC_FLAGS': '0x0', 21:16:09 INFO - 'XPC_SERVICE_NAME': '0', 21:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:09 INFO - Downloading/unpacking psutil>=0.7.1 21:16:09 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 21:16:09 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 21:16:09 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 21:16:09 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 21:16:09 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 21:16:09 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 21:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:16:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:16:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:16:12 INFO - Installing collected packages: psutil 21:16:12 INFO - Running setup.py install for psutil 21:16:12 INFO - building 'psutil._psutil_osx' extension 21:16:12 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 21:16:13 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 21:16:13 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 21:16:13 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 21:16:13 INFO - building 'psutil._psutil_posix' extension 21:16:13 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 21:16:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:16:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:16:13 INFO - ^ 21:16:13 INFO - 1 warning generated. 21:16:13 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 21:16:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:16:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:16:14 INFO - Successfully installed psutil 21:16:14 INFO - Cleaning up... 21:16:14 INFO - Return code: 0 21:16:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:14 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:14 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 21:16:14 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 21:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:14 INFO - 'HOME': '/Users/cltbld', 21:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:14 INFO - 'LOGNAME': 'cltbld', 21:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:14 INFO - 'MOZ_NO_REMOTE': '1', 21:16:14 INFO - 'NO_EM_RESTART': '1', 21:16:14 INFO - 'PAGER': '/bin/cat', 21:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:14 INFO - 'PWD': '/builds/slave/test', 21:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:14 INFO - 'SHELL': '/bin/bash', 21:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:14 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:14 INFO - 'USER': 'cltbld', 21:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:14 INFO - 'XPC_FLAGS': '0x0', 21:16:14 INFO - 'XPC_SERVICE_NAME': '0', 21:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:14 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 21:16:14 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 21:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:16:16 INFO - Installing collected packages: mozsystemmonitor 21:16:16 INFO - Running setup.py install for mozsystemmonitor 21:16:17 INFO - Successfully installed mozsystemmonitor 21:16:17 INFO - Cleaning up... 21:16:17 INFO - Return code: 0 21:16:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:17 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:17 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 21:16:17 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 21:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:17 INFO - 'HOME': '/Users/cltbld', 21:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:17 INFO - 'LOGNAME': 'cltbld', 21:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:17 INFO - 'MOZ_NO_REMOTE': '1', 21:16:17 INFO - 'NO_EM_RESTART': '1', 21:16:17 INFO - 'PAGER': '/bin/cat', 21:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:17 INFO - 'PWD': '/builds/slave/test', 21:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:17 INFO - 'SHELL': '/bin/bash', 21:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:17 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:17 INFO - 'USER': 'cltbld', 21:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:17 INFO - 'XPC_FLAGS': '0x0', 21:16:17 INFO - 'XPC_SERVICE_NAME': '0', 21:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:17 INFO - Downloading/unpacking blobuploader==1.2.4 21:16:17 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 21:16:17 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 21:16:17 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 21:16:17 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 21:16:17 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 21:16:17 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 21:16:19 INFO - Downloading blobuploader-1.2.4.tar.gz 21:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:16:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:16:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16:20 INFO - Downloading docopt-0.6.1.tar.gz 21:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:16:21 INFO - Installing collected packages: blobuploader, requests, docopt 21:16:21 INFO - Running setup.py install for blobuploader 21:16:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:16:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:16:21 INFO - Running setup.py install for requests 21:16:21 INFO - Running setup.py install for docopt 21:16:21 INFO - Successfully installed blobuploader requests docopt 21:16:21 INFO - Cleaning up... 21:16:21 INFO - Return code: 0 21:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:21 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:21 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 21:16:21 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 21:16:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:21 INFO - 'HOME': '/Users/cltbld', 21:16:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:21 INFO - 'LOGNAME': 'cltbld', 21:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:21 INFO - 'MOZ_NO_REMOTE': '1', 21:16:21 INFO - 'NO_EM_RESTART': '1', 21:16:21 INFO - 'PAGER': '/bin/cat', 21:16:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:21 INFO - 'PWD': '/builds/slave/test', 21:16:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:21 INFO - 'SHELL': '/bin/bash', 21:16:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:21 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:21 INFO - 'USER': 'cltbld', 21:16:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:21 INFO - 'XPC_FLAGS': '0x0', 21:16:21 INFO - 'XPC_SERVICE_NAME': '0', 21:16:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-BSHUkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-fSBLT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-qnKUMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Ef3y7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-G0DCFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-1yDuDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-pINE6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-cgBHfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:16:22 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Br9exB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-jaIW7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-eTcHKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-9G6MwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-RIUopU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-1oWgTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-aez8Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-buiyX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:16:23 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zkk1dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:16:23 INFO - Running setup.py install for manifestparser 21:16:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:16:24 INFO - Running setup.py install for mozcrash 21:16:24 INFO - Running setup.py install for mozdebug 21:16:24 INFO - Running setup.py install for mozdevice 21:16:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:16:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:16:24 INFO - Running setup.py install for mozfile 21:16:24 INFO - Running setup.py install for mozhttpd 21:16:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:16:24 INFO - Running setup.py install for mozinfo 21:16:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:16:24 INFO - Running setup.py install for mozInstall 21:16:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Running setup.py install for mozleak 21:16:25 INFO - Running setup.py install for mozlog 21:16:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Running setup.py install for moznetwork 21:16:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Running setup.py install for mozprocess 21:16:25 INFO - Running setup.py install for mozprofile 21:16:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:16:25 INFO - Running setup.py install for mozrunner 21:16:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:16:26 INFO - Running setup.py install for mozscreenshot 21:16:26 INFO - Running setup.py install for moztest 21:16:26 INFO - Running setup.py install for mozversion 21:16:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:16:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:16:26 INFO - Cleaning up... 21:16:26 INFO - Return code: 0 21:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:26 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:26 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 21:16:26 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 21:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:26 INFO - 'HOME': '/Users/cltbld', 21:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:26 INFO - 'LOGNAME': 'cltbld', 21:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:26 INFO - 'MOZ_NO_REMOTE': '1', 21:16:26 INFO - 'NO_EM_RESTART': '1', 21:16:26 INFO - 'PAGER': '/bin/cat', 21:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:26 INFO - 'PWD': '/builds/slave/test', 21:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:26 INFO - 'SHELL': '/bin/bash', 21:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:26 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:26 INFO - 'USER': 'cltbld', 21:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:26 INFO - 'XPC_FLAGS': '0x0', 21:16:26 INFO - 'XPC_SERVICE_NAME': '0', 21:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:16:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-63EsKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:16:26 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)) 21:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:16:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-3izSbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:16:26 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)) 21:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:16:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-rydogj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-AGGn6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-RWJ5R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-rjtlFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-gtR7lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-qsGmDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-B2yTxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-pAQkla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Lkcf51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:16:27 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)) 21:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:16:27 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-rYNXXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:16:28 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)) 21:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:16:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-7NIRYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:16:28 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)) 21:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:16:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-v_H6YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:16:28 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)) 21:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-8NBOf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:28 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)) 21:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:16:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Dek0AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:16:28 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)) 21:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:16:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-jgbqua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:28 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)) 21:16:28 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)) 21:16:28 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)) 21:16:28 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)) 21:16:28 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)) 21:16:28 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)) 21:16:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:16:28 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 21:16:28 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 21:16:28 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 21:16:28 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 21:16:28 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 21:16:28 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 21:16:30 INFO - Downloading blessings-1.6.tar.gz 21:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:16:31 INFO - Installing collected packages: blessings 21:16:31 INFO - Running setup.py install for blessings 21:16:31 INFO - Successfully installed blessings 21:16:31 INFO - Cleaning up... 21:16:31 INFO - Return code: 0 21:16:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:31 INFO - Reading from file tmpfile_stdout 21:16:31 INFO - Current package versions: 21:16:31 INFO - blessings == 1.6 21:16:31 INFO - blobuploader == 1.2.4 21:16:31 INFO - docopt == 0.6.1 21:16:31 INFO - manifestparser == 1.1 21:16:31 INFO - mozInstall == 1.12 21:16:31 INFO - mozcrash == 0.17 21:16:31 INFO - mozdebug == 0.1 21:16:31 INFO - mozdevice == 0.48 21:16:31 INFO - mozfile == 1.2 21:16:31 INFO - mozhttpd == 0.7 21:16:31 INFO - mozinfo == 0.9 21:16:31 INFO - mozleak == 0.1 21:16:31 INFO - mozlog == 3.1 21:16:31 INFO - moznetwork == 0.27 21:16:31 INFO - mozprocess == 0.22 21:16:31 INFO - mozprofile == 0.28 21:16:31 INFO - mozrunner == 6.11 21:16:31 INFO - mozscreenshot == 0.1 21:16:31 INFO - mozsystemmonitor == 0.0 21:16:31 INFO - moztest == 0.7 21:16:31 INFO - mozversion == 1.4 21:16:31 INFO - psutil == 3.1.1 21:16:31 INFO - requests == 1.2.3 21:16:31 INFO - wsgiref == 0.1.2 21:16:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:31 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:31 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 21:16:31 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 21:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:31 INFO - 'HOME': '/Users/cltbld', 21:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:31 INFO - 'LOGNAME': 'cltbld', 21:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:31 INFO - 'MOZ_NO_REMOTE': '1', 21:16:31 INFO - 'NO_EM_RESTART': '1', 21:16:31 INFO - 'PAGER': '/bin/cat', 21:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:31 INFO - 'PWD': '/builds/slave/test', 21:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:31 INFO - 'SHELL': '/bin/bash', 21:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:31 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:31 INFO - 'USER': 'cltbld', 21:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:31 INFO - 'XPC_FLAGS': '0x0', 21:16:31 INFO - 'XPC_SERVICE_NAME': '0', 21:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 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)) 21:16:31 INFO - Cleaning up... 21:16:31 INFO - Return code: 0 21:16:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:31 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:31 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 21:16:31 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 21:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:31 INFO - 'HOME': '/Users/cltbld', 21:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:31 INFO - 'LOGNAME': 'cltbld', 21:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:31 INFO - 'MOZ_NO_REMOTE': '1', 21:16:31 INFO - 'NO_EM_RESTART': '1', 21:16:31 INFO - 'PAGER': '/bin/cat', 21:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:31 INFO - 'PWD': '/builds/slave/test', 21:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:31 INFO - 'SHELL': '/bin/bash', 21:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:31 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:31 INFO - 'USER': 'cltbld', 21:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:31 INFO - 'XPC_FLAGS': '0x0', 21:16:31 INFO - 'XPC_SERVICE_NAME': '0', 21:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:32 INFO - Downloading/unpacking jsonschema 21:16:32 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 21:16:32 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 21:16:32 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 21:16:32 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 21:16:32 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 21:16:32 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 21:16:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:16:34 INFO - Downloading/unpacking functools32 (from jsonschema) 21:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:34 INFO - Downloading functools32-3.2.3-2.tar.gz 21:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:16:35 INFO - warning: no files found matching '*.txt' 21:16:35 INFO - no previously-included directories found matching 'build' 21:16:35 INFO - no previously-included directories found matching 'dist' 21:16:35 INFO - no previously-included directories found matching '.git*' 21:16:35 INFO - Installing collected packages: jsonschema, functools32 21:16:35 INFO - Running setup.py install for functools32 21:16:35 INFO - warning: no files found matching '*.txt' 21:16:35 INFO - no previously-included directories found matching 'build' 21:16:35 INFO - no previously-included directories found matching 'dist' 21:16:35 INFO - no previously-included directories found matching '.git*' 21:16:35 INFO - Successfully installed jsonschema functools32 21:16:35 INFO - Cleaning up... 21:16:35 INFO - Return code: 0 21:16:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:16:35 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')]} 21:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:35 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')]} 21:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:35 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 0x100c58a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c68420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc9bc5cc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, '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.uVCU4003qT/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.AeudbxW03x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 21:16:35 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 21:16:35 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 21:16:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:16:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:35 INFO - 'HOME': '/Users/cltbld', 21:16:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:35 INFO - 'LOGNAME': 'cltbld', 21:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:35 INFO - 'MOZ_NO_REMOTE': '1', 21:16:35 INFO - 'NO_EM_RESTART': '1', 21:16:35 INFO - 'PAGER': '/bin/cat', 21:16:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:35 INFO - 'PWD': '/builds/slave/test', 21:16:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:35 INFO - 'SHELL': '/bin/bash', 21:16:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:16:35 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:16:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:35 INFO - 'USER': 'cltbld', 21:16:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:35 INFO - 'XPC_FLAGS': '0x0', 21:16:35 INFO - 'XPC_SERVICE_NAME': '0', 21:16:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:35 INFO - Downloading/unpacking flake8 21:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:35 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 21:16:35 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 21:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:16:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:16:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:16:38 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 21:16:38 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 21:16:38 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 21:16:38 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 21:16:38 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 21:16:38 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 21:16:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:16:38 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 21:16:38 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 21:16:38 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 21:16:38 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 21:16:38 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 21:16:38 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 21:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:16:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:16:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:16:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:16:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:16:39 INFO - no previously-included directories found matching 'docs/_build' 21:16:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:16:39 INFO - Running setup.py install for pep8 21:16:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:16:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:16:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:16:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:16:39 INFO - no previously-included directories found matching 'docs/_build' 21:16:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:16:39 INFO - Cleaning up... 21:16:39 INFO - Return code: 0 21:16:39 INFO - Running post-action listener: _resource_record_post_action 21:16:39 INFO - Running post-action listener: _start_resource_monitoring 21:16:39 INFO - Starting resource monitoring. 21:16:39 INFO - ##### 21:16:39 INFO - ##### Running install step. 21:16:39 INFO - ##### 21:16:39 INFO - Running pre-action listener: _resource_record_pre_action 21:16:39 INFO - Running main action method: install 21:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:39 INFO - Reading from file tmpfile_stdout 21:16:39 INFO - Detecting whether we're running mozinstall >=1.0... 21:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:16:39 INFO - Reading from file tmpfile_stdout 21:16:39 INFO - Output received: 21:16:39 INFO - Usage: mozinstall [options] installer 21:16:39 INFO - Options: 21:16:39 INFO - -h, --help show this help message and exit 21:16:39 INFO - -d DEST, --destination=DEST 21:16:39 INFO - Directory to install application into. [default: 21:16:39 INFO - "/builds/slave/test"] 21:16:39 INFO - --app=APP Application being installed. [default: firefox] 21:16:39 INFO - mkdir: /builds/slave/test/build/application 21:16:39 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'] 21:16:39 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 21:17:13 INFO - Reading from file tmpfile_stdout 21:17:13 INFO - Output received: 21:17:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:17:13 INFO - Running post-action listener: _resource_record_post_action 21:17:13 INFO - ##### 21:17:13 INFO - ##### Running run-tests step. 21:17:13 INFO - ##### 21:17:13 INFO - Running pre-action listener: _resource_record_pre_action 21:17:13 INFO - Running main action method: run_tests 21:17:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:17:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:17:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:17:13 INFO - 2016-04-03 21:17:13.797 screenresolution[1647:8234] starting screenresolution argv=screenresolution get 21:17:13 INFO - 2016-04-03 21:17:13.799 screenresolution[1647:8234] Display 0: 1600x1200x32@60 21:17:13 INFO - 2016-04-03 21:17:13.805 screenresolution[1648:8236] starting screenresolution argv=screenresolution list 21:17:13 INFO - Available Modes on Display 0 21:17:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:17:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:17:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:17:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:17:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:17:14 INFO - Intel Iris: 21:17:14 INFO - Chipset Model: Intel Iris 21:17:14 INFO - Type: GPU 21:17:14 INFO - Bus: Built-In 21:17:14 INFO - VRAM (Dynamic, Max): 1536 MB 21:17:14 INFO - Vendor: Intel (0x8086) 21:17:14 INFO - Device ID: 0x0a2e 21:17:14 INFO - Revision ID: 0x0009 21:17:14 INFO - Displays: 21:17:14 INFO - Display: 21:17:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:17:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:17:14 INFO - Display Serial Number: 1600x1200 60 21:17:14 INFO - Main Display: Yes 21:17:14 INFO - Mirror: Off 21:17:14 INFO - Online: Yes 21:17:14 INFO - Rotation: Supported 21:17:14 INFO - Return code: 0 21:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:17:14 INFO - Python 2.7.3 21:17:14 INFO - Return code: 0 21:17:14 INFO - grabbing minidump binary from tooltool 21:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:17:14 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 0x100af7e00>, '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 0x100960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100af2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:17:14 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 21:17:14 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 21:17:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:17:14 INFO - Return code: 0 21:17:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:17:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:17:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:17:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:17:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:17:15 INFO - Return code: 0 21:17:15 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:17:15 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVCU4003qT/Render', 21:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:15 INFO - 'HOME': '/Users/cltbld', 21:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:15 INFO - 'LOGNAME': 'cltbld', 21:17:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:17:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:15 INFO - 'MOZ_NO_REMOTE': '1', 21:17:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:17:15 INFO - 'NO_EM_RESTART': '1', 21:17:15 INFO - 'PAGER': '/bin/cat', 21:17:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:15 INFO - 'PWD': '/builds/slave/test', 21:17:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:15 INFO - 'SHELL': '/bin/bash', 21:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AeudbxW03x/Listeners', 21:17:15 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 21:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:15 INFO - 'USER': 'cltbld', 21:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:15 INFO - 'XPC_FLAGS': '0x0', 21:17:15 INFO - 'XPC_SERVICE_NAME': '0', 21:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:17:15 INFO - mozversion application_buildid: 20160403184215 21:17:15 INFO - mozversion application_changeset: fc4a988ca8d61e809bb30ef635ad50e189f742b3 21:17:15 INFO - mozversion application_display_name: Nightly 21:17:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:17:15 INFO - mozversion application_name: Firefox 21:17:15 INFO - mozversion application_remotingname: firefox 21:17:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:17:15 INFO - mozversion application_vendor: Mozilla 21:17:15 INFO - mozversion application_version: 48.0a1 21:17:15 INFO - mozversion platform_buildid: 20160403184215 21:17:15 INFO - mozversion platform_changeset: fc4a988ca8d61e809bb30ef635ad50e189f742b3 21:17:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:17:15 INFO - mozversion platform_version: 48.0a1 21:17:15 INFO - using testdate: 1459743435 21:17:15 INFO - actual date: 1459743435 21:17:15 INFO - starting webserver on 'localhost:49270' 21:17:15 INFO - SUITE-START | Running 2 tests 21:17:15 INFO - TEST-START | dromaeo_css 21:17:15 INFO - operating with platform_type : mac_ 21:17:15 INFO - Initialising browser for dromaeo_css test... 21:17:15 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpxpSGCG/profile http://localhost:49270/getInfo.html) 21:17:18 INFO - PROCESS | 1666 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 21:17:18 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 21:17:18 INFO - PROCESS | 1666 | colorDepth:24 21:17:18 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 21:17:18 INFO - PROCESS | 1666 | __metrics 21:17:18 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 21:17:19 INFO - TEST-INFO | 1666: exit 0 21:17:19 INFO - Browser initialized. 21:17:19 INFO - Running cycle 1/1 for dromaeo_css test... 21:17:19 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpxpSGCG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:17:31 INFO - PROCESS | 1670 | RSS: Main: 246550528 21:17:31 INFO - PROCESS | 1670 | 21:18:20 INFO - PROCESS | 1670 | 1459743500942 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] 21:20:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 21:20:32 INFO - PROCESS | 1670 | RSS: Main: 260386816 21:20:32 INFO - PROCESS | 1670 | 21:23:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 21:23:35 INFO - PROCESS | 1670 | RSS: Main: 271048704 21:23:35 INFO - PROCESS | 1670 | 21:26:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 21:26:37 INFO - PROCESS | 1670 | RSS: Main: 273178624 21:26:37 INFO - PROCESS | 1670 | 21:29:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 21:29:40 INFO - PROCESS | 1670 | RSS: Main: 274706432 21:29:40 INFO - PROCESS | 1670 | 21:32:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 21:32:43 INFO - PROCESS | 1670 | RSS: Main: 277565440 21:32:43 INFO - PROCESS | 1670 | 21:35:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 21:35:46 INFO - PROCESS | 1670 | RSS: Main: 278863872 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | __start_tp_report 21:35:46 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 21:35:46 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 21:35:46 INFO - PROCESS | 1670 | |i|pagename|runs| 21:35:46 INFO - PROCESS | 1670 | |0;dojo.html;2903.8257704537727;3494.388482015647;3544.8404821783015;3547.432410814267;3586.3006713690843;5687.7156142192935;5704.8859022819515;5738.42615738426;5750.108733146364;5765.221695071169;5618.185363122345;5696.743646535905;5729.197912292282;5742.109972954188;5812.389699081599;5198;5235.921461178085;5279.656822306538;5312.229726689628;5322.760475778599;358.1665165734869;5234.895302093956;5254.57963362932;5306.867328316804;5344.22508736233;5223.294855194557;5241.764120614582;5253.894922101575;5268.420473747885;5278.498542638443;5166;5291.232771248186;5318.282031925679;5321.680699158062;5326.786928522854;5122.436531981479;5147.150720131174;5212.348456442945;5236.659617124875;5261.342332208474;5559.833205003856;5654.9151762723595;5663.207150998864;5705.6006079574445;5714.200011998323;6097.176881121036;6148.262208534959;6229.937700623026;6233.937660623426;6255.874882502325;6195.380461953813;6248;6251.156093927307;6261.843453913643;6268.5298602604535;4852.369192005052;5819.476247137735;5879.088741245114;5880.323762767336;5894.705264736746;6186.566940314135;6224.533160013018;6251.78118765841;6303.495720342454;6326.557141000086;6174.567780255429;6205.069239614004;6208.50331973441;6219.564630475914;6241.875162496724;6194.132821405007;6212.627242365382;6277.52918531112;6287.056941458726;6299.307076221612;6111.938880611137;6171.876562468815;6227.96886015567;6232.937670623326;6233.0338797486465;6106.430331452127;6157.692115394212;6232.220972378453;6243.500519958392;6277.403646653561;4852.684575502581;4932.706291574364;4933.55597996182;4950.18321976877;4959.380077490314;4326.134773045404;4364.716293440916;4405.801738921757;4468;4489.259272220047;5872.794452194153;5921.940780592225;5954.85112872173;5977.402259773988;5978.3124940631515;5428.5928555358505;5592.720363981784;5793.768249269982;6216.627002379872;6225.315215326311;5763.193152958589;5899.233099697012;5928.199693041471;5958.165856780054;5984.850378740566;4597.195490789099;5339.638392209961;5392;5410.513053825174;5423.3491980962535;5863.648181109147;5913.940860591425;6251.71867265965;6378.17083779115;6381.202349706286;6144.863200307957;6192.473639740492;6241.78153764616;6246.750129994931;6258.123862659322;6453.612783233021;6471.967640161769;6486.902696459651;6506.3493650634555;6510.121133647087;6013.729382177725;6128.387161283836;6129.938700612936;6160.661163636043;6163.137160797402;6103.6104255942055;6121.079909957769;6166.938330616816;6180.598261113193;6253.499720022296;6103.9694801527485;6120;6125.173101631401;6127.632342059491;6127.877442451215;5313.96377706359;5996.370381110095;6080.72636731357;6102.938970610415;6109.11124314113;5278;5838.678872661874;5965.075413310944;6075.787347442818;6121.84695382619;6161.568690191643;6167.198264225622;6177.011678131657;6185.072239164161;6186.536009799193;5442.673439593637;5586.692731899622;5852.06366981298;6005.939940600538;6048.606840555526 21:35:46 INFO - PROCESS | 1670 | |1;ext.html;510.16333213529794;525.2174260352076;559.6194587680378;559.683778665054;561.8005608009157;29597.556036659415;30295.848520757394;37717.057073573174;37718.62281377186;37905.43141852868;38628.22743545128;38902.610973890325;39354.40968385476;39387.24289299743;39410.80294598523;9425.151736343727;9611.66359177429;9638.469884156368;9647.951760241189;9664.03359664035;9411.388259763127;9621.085996830325;9635.084666956627;9639.855402168972;9649.807003859918;9599.90400095997;9606.519674016272;9607.4715890626;9655.5172241388;9694.22446204302;9467;9532.237421006303;9558.996305387938;9581.952090239503;9590.280728945358;9479.573419196153;9615.56729947154;9638.42169469834;9641.180499657537;9671.177949874269;37552.24895502075;38106.42840357397;38143.80928095342;38199.04502387463;38227.808860955796;2800.187945495804;2831.6602007758993;3192.170035790688;3273.508973653947;3503.929921401583;26474.941002359883;26511.337216569547;26581.867090664615;26823;27231.727682723315;2225.7662945390825;2689.3007817967273;2701;2844.5590933405356;2879.7696184305205;388233;389961.0501947501;391219;391325;396611;63578.68210658917;63951;63975.68012159909;63981;64093;71992;72315.2768472319;72356.63821680963;73173;73199.63400183071;14077.366518506691;14611.415543378358;16129.87090903649;16672.916635416987;16916;10740.194485413625;12279.017678585691;12334.013278937664;12369.381530923598;12798.744025119631;16749.413770517975;20742.688859667116;20974.895125524275;20985.265515706877;21107.26124585632;7460.253974602496;9179.495127767903;9196.080391960884;9199.310051746146;9215.63137474507;876.4960147914975;937.803061357109;944.631593678466;952.2762700347786;1075.1130317488103;29130.708692912798;29409.264768380533;29443.96946106876;29672.703272966995;30037.39925201484;984.7193549838262;1042.8904964978567;1047.8218702820539;1101.9944900275448;1171.5782318365382;14806.481773137888;14894.776578351333;15024.248787560578;15217.467388641344;15245;500148;501888;502491;506921;507996;47432.7628361856;57415;58309.12536311959;58319;58559;1387.5629176809273;1410.1186758276078;1430.3277459593974;1442.228407801842;1450.100937418807;29002.41995160127;29182.56226156652;29309.560356595095;29757.809687612254;29839.403211935205;46031;50230.497695024045;50596.73508162326;50646;50734;452495;464498;469845;469910;470234;32035.558399871596;32944.83527582347;33130.84042058516;33631.15922101967;33772.83113584515;44233.778831105636;44382.3342649867;44747.32879006882;45253.77373113245;46259.76870115628;29944.550831737975;37072.81463592665;37392.25215495729;38152.236955261294;38188;29540;33611.83194084014;35396;35583.64416355907;36049.63950360463;29389.26526836846;36764;36812;37083.814580926926;37092.81453592715;28690.426191476472;31320.843395783788;31731.365372691955;32466.83766581152;32911.670883291816;21553.461163471038;22709;24856.130035448674;25319.493610127327;25634 21:35:46 INFO - PROCESS | 1670 | |2;jquery.html;324.86193367818674;355.7598620930871;363.565539180679;366.71762742688134;367.8105775525603;18756.624867502658;19268.03659817009;19951.501212469695;19953;20070.096845641943;16634;19368.3221087262;19741.901290493526;20167.09248083836;20284.18863245472;5449.4005659377435;5632.211490391349;5634.521065709419;5711.742971566289;5752.108423194411;5368.221607866857;5657.801976930808;5702.600817942745;5757.280339957505;5761.366249712549;4777.426708794932;4781.8087276508895;5584.664920104807;5603.831885043455;5644.887102257952;5359.437259087778;5441.537469315113;5632;6353.205849268795;6379.904301435482;5526.115821468586;5532.28080349556;5536.2249285100115;5559.833205003856;5570.025245582047;12955.611331660066;23702.525949480914;24249.87875060631;24708.13521526756;24970.5005899881;2023.1401654296865;2043.7343145391153;2132.5734853029458;2697.5414179589516;2717;9661.516924153764;9804.607815687365;10329.535170917326;12199.14605977582;13791.965602579847;1465.1428914085272;1697.295622316737;1711.64055548335;1713.5459103337625;1761.1546457700376;97960.51019744856;101801;103403.96596034018;104443.4777826106;105657;10781.9460902695;10990.065844403156;11067.391293478775;11259.662210133709;11283.266587671775;13382.53161139375;13416.597502074954;13450.529231476852;13476.663083422993;13549.322533873266;8362.707305244408;8445.662173513114;8469.11074337198;8471.618777155043;8508.659653613786;8556.828863422697;8594.355423343275;8629.741107766777;8681.696140635173;8686.391952563386;4335.804888780012;4374.19077470669;4383.3863259143745;4403.669724770655;4451.821927122944;1727.2141175764996;1827.0681952204206;1848.5471059590218;1869.4016615793573;1873.7095750158746;940.0223767282087;943.6084025129494;965.5992763003416;989.9851502227473;1012.8480727890728;19015.42953711391;19192.904035479733;20027.699584506245;20035;20163.19347226124;881.5548148185254;946.0870260198803;971.3249291742312;1020.1838529176629;1036.3160314192596;10304.639337623297;10356.430396328275;10384.844227336596;10434;10519;560479;634451;644703.7764811146;653629;659579;94970.52514737382;108117.45941270243;108458;125715;127036.36481817532;868.8957325121025;1026.0867827633413;1030.9278350515542;1036.6268143468346;1083.7290677330668;17185.914070429568;17366.82633173652;17441.953482791072;17458.825411746227;17524.299028038735;43448.34827477527;45855.31217031681;47065;48657.27014094721;49813.50186498234;69937;70248.29751702417;73245.6337718308;74226.25773742194;74867.62566187134;7379.298966598165;7507.62461876893;7554.320111190019;7568.129665088585;7723.806904827425;10991;11755.588554400554;11756.0007399372;11900.226485278776;12034.458449369975;9031.909680903107;9765.560549775135;10149;10190.388576685422;10550.997655222742;10134.79730405373;10221.9488902555;10440.164786817188;10556.683299501028;10558.524866380878;9273.026332235288;9807.950960245153;10577.841332380174;10778.946105269737;10894.673159804901;7516.361109305771;7599.164091949991;7625.351845093229;7686.231376862269;7987.760367188994;8462.111478294937;9558.904410955802;10418.947905260426;10617.469126543487;10690.679279621623 21:35:46 INFO - PROCESS | 1670 | |3;mootools.html;1512.3118980863705;1624.8131464881537;1885.3684015854687;1973.4572992427072;1978.1395093134497;7930.405219608524;8518.446300990432;8648.827023459527;8868.645254189832;8878.467291962479;7986.361091112712;8005.239502247292;8109.310708589762;8126.715564955228;8146.185381461865;2426.2357357432443;2441.121196369306;2446.217210492643;2447.3881529617597;2454.1410506322823;2391.9834070520046;2437.195725410619;2443.8900249488725;2448.51029794041;2450.019992003195;2426.0659646036315;2431.9392015199674;2441.170002199252;2464.4578192797558;2468.3705655057934;2416.9395765105837;2449.0571130115036;2454.3741345956755;2454.864982425966;2458.754124587536;2418.818588605862;2447.8286519943613;2448.1431498975394;2450.399652085233;2452.5953217719057;8148.348132149414;8194.09864914859;8295;8303.709370172075;8385.993680758287;5430.864228394322;5565.387807341189;5579.246801681802;5593.021221286299;5602.1036634138745;3532.929341413183;3599.6760291573883;3641.581218159919;3654.853805847763;3666.8349924253207;1041.4792603698152;1055.952482138298;1059.2003037706481;1060.1042119409087;1062.282959002678;11775.764484710258;11817.704557386049;11901.285922844658;11919.344436055926;11951;4829.227323628203;4861.392325959255;4963.875903102451;4992.326035985168;5000.299958005882;7471.252874712594;9044.321675874337;9980.201583873273;10023;10034.946330635325;5492.5331346835965;5512.6692398456225;5560.193771903051;5582.24639673647;5603.551715862721;4527.660425468103;4877.926831097537;4963.081829861487;4986.775595098229;5037.924431133536;3322.5680661514334;3928.823202955874;4006.939895901564;4040.91918161641;4085.611866872642;1331.1946272505188;1331.8135461035463;1339.5378594384922;1354.4717560151548;1356.7354365898752;1078.455380033094;1079.6868908016588;1275.9744805103846;1341.1952828303135;1376.2224343246035;8110.270075693098;8112.1076681566165;8160.714374996846;8166.346692264605;8197.918020819834;510.084398504685;523.5026724611635;527.4777969809861;529.7774934527507;530.5649367518598;6066.998945173997;6191.84520386994;6200.3799620038535;6213.502919766408;6230.626162430269;10413.895861041445;10512.737181570523;10704.571817127227;10737.355758654505;10811.83782243267;10389.480525973822;10504.212184086224;10517.05346518817;10559.63041293551;10560.47197640115;8197.303229225463;8277.089520152898;8310.335173186251;8395.370347223983;8400.579971001425;7628;7649.923500764921;7767.184445633127;7863.135055143815;7874.803129921798;9175.22010629104;9492.620295188115;9530.618775248913;9557.283203759607;9621.759456013655;9590.616375344907;9800.901990979999;9840.507974601385;9868.50657467138;9880.258980576342;6560.081588577698;7007.369336759716;7219.386352160125;7266.455015873725;7319.304666056716;6843.349881761224;8006.799830004296;8141.470804397695;8152.062512811102;8180.713675021346;7189.856202876018;7281.854362912818;7294.270572942663;7300.087489063867;7435.107787065371;7114.039604653305;7165.964170179116;7193.136823581203;7195.280471952972;7202.96398518004;7579.848403031799;7606.315431611181;7684.9231507686445;7693.807654808675;7751.0311211098615;6939.895901561582;6949.027136201037;6985.1617805863625;6995.405390541658;7006.929930700628;6901.551399159039;7008.579485230903;7053.612051337021;7088.716451342095;7111.573305601681 21:35:46 INFO - PROCESS | 1670 | |4;prototype.html;327.8590206211329;328.0323047011316;330.45310011930263;335.60566334556887;335.70290293090613;6536.869262614745;6586.967065164674;6592.604443733373;6598.307177746339;6603.438707709851;4603.941093548486;5959.867625151229;6605.966970165155;6608.801735947929;6635.701393437294;4626.4910859805395;4764.737939413331;4866.683665561744;4917.975410122945;5048.520390562909;4835.661503694742;4841.443234028079;4850.12697714413;4867.075255701423;4867.537583929538;4233.8729838104755;4515.713021788791;4828.46886842447;4832.782524786376;4857.125717370872;3942.7634341939574;4812.711237325754;4833.9516604834025;4850.151223535867;4903.705777653352;4202.85290014851;4219.38818871262;4226.154769046172;4234.068504928941;4235.703500754948;6030.758769649253;6332.841678958017;6341.8097457076365;6365.586236894634;6394.113736447759;5687.687177205252;5705.1727499512335;5740.196372507852;5754.510866576346;5760.711964401763;7083.256258092878;7096;7100;7119.857602847914;7126.857462850714;4562.954370456286;4564.931526027112;4569.634429245652;4574.153781550391;4581;7476.626168691598;7511.323980841696;7535.434842386843;7535.434842386843;7539.208383119803;3669.834857431422;4638.304254361805;4655.092257009851;4657.604103651228;4663.253879379283;3852.3836186210633;4744.4543877454535;4753.904921901542;4756.548127927841;4757.191277482767;5640.915386269209;5671.943280567224;5674.631148975303;5681.829545113653;5690.601657883908;5837.883242335214;7228.638568071576;7228.783136505913;7234.276572342724;7245.275472452712;1615.192403798101;1641.1384023387816;1641.6142206581444;1644.4902080355128;1646.9505914822576;1009.2985375164191;1043.2175868098925;1054.862867827193;1057.8148823955778;1061.6337363609543;5463.590230732631;6627.900581491282;6716.261211266757;6717.932820671828;6734.225564060098;7363.410927125817;7386.2613738625705;7413.666385012687;7423.480356375002;7459.477836551389;6452.903206451907;6534.183227096613;6741.089952856301;6802.795916122524;6825.317468253234;3907.2185562887535;3951.150502641946;3955;3960.5049368828895;3968.40473928913;7848.21517848222;7870.370370370357;7870.567118808521;7893.368530517545;7900.565468899151;7371.557706537517;7737.92262077372;7750.534967901944;7751.496152750054;7770.378369730408;7737.264959828807;7783.844323113619;7823.530588164728;7844.450888437868;7873.763787086396;7420.6660700269695;7435.7025718970635;7444.73943411978;7449.143348514774;7482.551046937201;7294.489385743159;7310.707571697285;7350.889736653848;7374.741884034033;7383;7535.623218838927;7820;7825.843483130419;7833.725819596287;7836.177201393772;4084.8766589188212;4392.3850660906855;4582.175208462376;4635.794693379813;4638.420197475316;7330.560166390033;7335.669894854637;7370.520916140434;7373.446991475554;7387.224341444071;5549.361823390362;7072.9646351767915;7079.2566780487305;7109.786706398816;7131.7503887365765;4995.675281106716;5481.945180548303;5661.518770904355;6410.775622853178;6627.237867645283;6859.5541289816;6879.415249703831;6914.377706006484;6933.826654333682;6937.375636192767;7062.117235345582;7074.151101867808;7078;7080.327368899946;7105.822354440974;6894.965525172543;6896.551724137915;6911.205211400753;6939.687714052779;6940.375366217065 21:35:46 INFO - PROCESS | 1670 | |5;yui.html;675.7330854312546;695.2144077192771;736.6721808795087;756.833496630741;774.8953891224686;14417.495387661435;14536.854631453682;14677.266136693175;14724.926375368135;14729.705405891877;13298.667533311673;13320;13330.133541319832;13370.398332075056;13413.396397162127;720.5604581205461;890.470170248701;905.1175104273347;917.6833992272656;919.071737545081;882.5543100734152;903.2367649336334;913.118840319092;916.3906002508324;917.8118485710447;931.4457897550947;965.8068386322728;966.8984756600561;967.8644989701447;967.8644989701447;925.0610630210308;925.9861102083474;926.0230456868002;933.5985526223722;955.7467271173144;703.3845385287873;716.6273537760387;717.2827172827173;717.8492516571526;719.8524302517972;14599.41602335916;14728.042677226053;14759;14839.480618178311;14872.405103795834;12317;12321.260724356478;12432.502699892084;12585.181963172365;12622.558210462681;7465.552066875951;9310.301727370406;9361;9442;9593.616255349778;3436.295559410315;3467.133216695826;3488.7034602058857;3509.4034014217646;3710.666040056408;80352;80644;81809.59095204546;82106.17893821104;82245.17754822435;7746.225377462209;9177.587008584629;9217.308701847389;9383.906160938439;9406.341556091145;18086.819131808777;18390.080495975148;18456.723149152775;18534.907325463555;18649;7305.744298949511;7364.116306043309;7488.625568721543;7559.697612095564;7698.653560589675;4092.120194158211;4144.5026596808575;4153.7507749535125;4170.124273902515;4203.747775133502;3556.342076715816;3574.2136729919375;3618.0231337538717;3619.366610843092;3643.5263415756312;580.7803612413982;663.5587334422652;668.254895791199;669.220358282605;670.3196255800269;507.97968081277077;536.0752701589727;547.9780808767684;600.2766666167258;603.6528995827417;7299.5255308404785;7734.613269336511;7993.960030199812;8093.1502192270145;8215.424920255644;577.2149876168407;586.3257254157668;587.0929414055295;596.2219303808572;598.7126179433809;3498.7900725956524;3778.886633401002;3787.450819631138;3828.674562662205;3917.87382718958;88749.55625221833;90068;95251.57122643165;95878.52060739652;98425;82442;84011.5799420999;84891.57554212313;85103.14896851077;85653.57173214095;74390.25609743941;74570.5085898279;74581.25418745851;74867;74949;6579.638119903259;7726.806829829299;7736.690532378867;7833.647485863264;7865.528068315691;45808.854778630805;52059.739701302766;52744.73627631837;53436.19845702395;53896.73051634873;52802.73598632136;65558;69393;70461;71976.64011679908;9035.683751068682;9127.954360228421;9145.5884485197;9165.358424910191;9384.343095983215;10662.680119596425;10778.407425986134;10792.175672637275;10872.782544348911;11096.889031109586;9953.950230248802;10130.124527773725;10187.745306367104;10193.235507337127;10570.947145264225;8117.79705507367;10176.389416635026;10391.324563903323;10558.8416173759;10650.627228046982;9876.604935802774;10035.749106272402;10078.798424031625;10224.591016359262;10673.306235094695;8349.039860415887;8392.916070839214;8747.475151490931;8863.379563430499;8900.109989001048;8708.521031343336;8715.956420217859;8769.824603508021;8818.11818818113;8864.379493435397 21:35:46 INFO - PROCESS | 1670 | __end_tp_report 21:35:46 INFO - PROCESS | 1670 | __start_cc_report 21:35:46 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,381 21:35:46 INFO - PROCESS | 1670 | __end_cc_report 21:35:46 INFO - PROCESS | 1670 | __startTimestamp1459744546037__endTimestamp 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | ------- Summary: start ------- 21:35:46 INFO - PROCESS | 1670 | Number of tests: 6 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5706.82 Median:5958.17 stddev:764.22 (12.8%) stddev-sans-first:734.25 21:35:46 INFO - PROCESS | 1670 | Values: 2903.8 3494.4 3544.8 3547.4 3586.3 5687.7 5704.9 5738.4 5750.1 5765.2 5618.2 5696.7 5729.2 5742.1 5812.4 5198.0 5235.9 5279.7 5312.2 5322.8 358.2 5234.9 5254.6 5306.9 5344.2 5223.3 5241.8 5253.9 5268.4 5278.5 5166.0 5291.2 5318.3 5321.7 5326.8 5122.4 5147.2 5212.3 5236.7 5261.3 5559.8 5654.9 5663.2 5705.6 5714.2 6097.2 6148.3 6229.9 6233.9 6255.9 6195.4 6248.0 6251.2 6261.8 6268.5 4852.4 5819.5 5879.1 5880.3 5894.7 6186.6 6224.5 6251.8 6303.5 6326.6 6174.6 6205.1 6208.5 6219.6 6241.9 6194.1 6212.6 6277.5 6287.1 6299.3 6111.9 6171.9 6228.0 6232.9 6233.0 6106.4 6157.7 6232.2 6243.5 6277.4 4852.7 4932.7 4933.6 4950.2 4959.4 4326.1 4364.7 4405.8 4468.0 4489.3 5872.8 5921.9 5954.9 5977.4 5978.3 5428.6 5592.7 5793.8 6216.6 6225.3 5763.2 5899.2 5928.2 5958.2 5984.9 4597.2 5339.6 5392.0 5410.5 5423.3 5863.6 5913.9 6251.7 6378.2 6381.2 6144.9 6192.5 6241.8 6246.8 6258.1 6453.6 6472.0 6486.9 6506.3 6510.1 6013.7 6128.4 6129.9 6160.7 6163.1 6103.6 6121.1 6166.9 6180.6 6253.5 6104.0 6120.0 6125.2 6127.6 6127.9 5314.0 5996.4 6080.7 6102.9 6109.1 5278.0 5838.7 5965.1 6075.8 6121.8 6161.6 6167.2 6177.0 6185.1 6186.5 5442.7 5586.7 5852.1 6005.9 6048.6 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:60253.36 Median:38148.02 stddev:121070.92 (317.4%) stddev-sans-first:121327.46 21:35:46 INFO - PROCESS | 1670 | Values: 510.2 525.2 559.6 559.7 561.8 29597.6 30295.8 37717.1 37718.6 37905.4 38628.2 38902.6 39354.4 39387.2 39410.8 9425.2 9611.7 9638.5 9648.0 9664.0 9411.4 9621.1 9635.1 9639.9 9649.8 9599.9 9606.5 9607.5 9655.5 9694.2 9467.0 9532.2 9559.0 9582.0 9590.3 9479.6 9615.6 9638.4 9641.2 9671.2 37552.2 38106.4 38143.8 38199.0 38227.8 2800.2 2831.7 3192.2 3273.5 3503.9 26474.9 26511.3 26581.9 26823.0 27231.7 2225.8 2689.3 2701.0 2844.6 2879.8 388233.0 389961.1 391219.0 391325.0 396611.0 63578.7 63951.0 63975.7 63981.0 64093.0 71992.0 72315.3 72356.6 73173.0 73199.6 14077.4 14611.4 16129.9 16672.9 16916.0 10740.2 12279.0 12334.0 12369.4 12798.7 16749.4 20742.7 20974.9 20985.3 21107.3 7460.3 9179.5 9196.1 9199.3 9215.6 876.5 937.8 944.6 952.3 1075.1 29130.7 29409.3 29444.0 29672.7 30037.4 984.7 1042.9 1047.8 1102.0 1171.6 14806.5 14894.8 15024.2 15217.5 15245.0 500148.0 501888.0 502491.0 506921.0 507996.0 47432.8 57415.0 58309.1 58319.0 58559.0 1387.6 1410.1 1430.3 1442.2 1450.1 29002.4 29182.6 29309.6 29757.8 29839.4 46031.0 50230.5 50596.7 50646.0 50734.0 452495.0 464498.0 469845.0 469910.0 470234.0 32035.6 32944.8 33130.8 33631.2 33772.8 44233.8 44382.3 44747.3 45253.8 46259.8 29944.6 37072.8 37392.3 38152.2 38188.0 29540.0 33611.8 35396.0 35583.6 36049.6 29389.3 36764.0 36812.0 37083.8 37092.8 28690.4 31320.8 31731.4 32466.8 32911.7 21553.5 22709.0 24856.1 25319.5 25634.0 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:34324.33 Median:2707.27 stddev:104494.04 (3859.8%) stddev-sans-first:104755.98 21:35:46 INFO - PROCESS | 1670 | Values: 324.9 355.8 363.6 366.7 367.8 18756.6 19268.0 19951.5 19953.0 20070.1 16634.0 19368.3 19741.9 20167.1 20284.2 5449.4 5632.2 5634.5 5711.7 5752.1 5368.2 5657.8 5702.6 5757.3 5761.4 4777.4 4781.8 5584.7 5603.8 5644.9 5359.4 5441.5 5632.0 6353.2 6379.9 5526.1 5532.3 5536.2 5559.8 5570.0 12955.6 23702.5 24249.9 24708.1 24970.5 2023.1 2043.7 2132.6 2697.5 2717.0 9661.5 9804.6 10329.5 12199.1 13792.0 1465.1 1697.3 1711.6 1713.5 1761.2 97960.5 101801.0 103404.0 104443.5 105657.0 10781.9 10990.1 11067.4 11259.7 11283.3 13382.5 13416.6 13450.5 13476.7 13549.3 8362.7 8445.7 8469.1 8471.6 8508.7 8556.8 8594.4 8629.7 8681.7 8686.4 4335.8 4374.2 4383.4 4403.7 4451.8 1727.2 1827.1 1848.5 1869.4 1873.7 940.0 943.6 965.6 990.0 1012.8 19015.4 19192.9 20027.7 20035.0 20163.2 881.6 946.1 971.3 1020.2 1036.3 10304.6 10356.4 10384.8 10434.0 10519.0 560479.0 634451.0 644703.8 653629.0 659579.0 94970.5 108117.5 108458.0 125715.0 127036.4 868.9 1026.1 1030.9 1036.6 1083.7 17185.9 17366.8 17442.0 17458.8 17524.3 43448.3 45855.3 47065.0 48657.3 49813.5 69937.0 70248.3 73245.6 74226.3 74867.6 7379.3 7507.6 7554.3 7568.1 7723.8 10991.0 11755.6 11756.0 11900.2 12034.5 9031.9 9765.6 10149.0 10190.4 10551.0 10134.8 10221.9 10440.2 10556.7 10558.5 9273.0 9808.0 10577.8 10778.9 10894.7 7516.4 7599.2 7625.4 7686.2 7987.8 8462.1 9558.9 10418.9 10617.5 10690.7 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5960.15 Median:5562.79 stddev:3126.10 (56.2%) stddev-sans-first:3116.99 21:35:46 INFO - PROCESS | 1670 | Values: 1512.3 1624.8 1885.4 1973.5 1978.1 7930.4 8518.4 8648.8 8868.6 8878.5 7986.4 8005.2 8109.3 8126.7 8146.2 2426.2 2441.1 2446.2 2447.4 2454.1 2392.0 2437.2 2443.9 2448.5 2450.0 2426.1 2431.9 2441.2 2464.5 2468.4 2416.9 2449.1 2454.4 2454.9 2458.8 2418.8 2447.8 2448.1 2450.4 2452.6 8148.3 8194.1 8295.0 8303.7 8386.0 5430.9 5565.4 5579.2 5593.0 5602.1 3532.9 3599.7 3641.6 3654.9 3666.8 1041.5 1056.0 1059.2 1060.1 1062.3 11775.8 11817.7 11901.3 11919.3 11951.0 4829.2 4861.4 4963.9 4992.3 5000.3 7471.3 9044.3 9980.2 10023.0 10034.9 5492.5 5512.7 5560.2 5582.2 5603.6 4527.7 4877.9 4963.1 4986.8 5037.9 3322.6 3928.8 4006.9 4040.9 4085.6 1331.2 1331.8 1339.5 1354.5 1356.7 1078.5 1079.7 1276.0 1341.2 1376.2 8110.3 8112.1 8160.7 8166.3 8197.9 510.1 523.5 527.5 529.8 530.6 6067.0 6191.8 6200.4 6213.5 6230.6 10413.9 10512.7 10704.6 10737.4 10811.8 10389.5 10504.2 10517.1 10559.6 10560.5 8197.3 8277.1 8310.3 8395.4 8400.6 7628.0 7649.9 7767.2 7863.1 7874.8 9175.2 9492.6 9530.6 9557.3 9621.8 9590.6 9800.9 9840.5 9868.5 9880.3 6560.1 7007.4 7219.4 7266.5 7319.3 6843.3 8006.8 8141.5 8152.1 8180.7 7189.9 7281.9 7294.3 7300.1 7435.1 7114.0 7166.0 7193.1 7195.3 7203.0 7579.8 7606.3 7684.9 7693.8 7751.0 6939.9 6949.0 6985.2 6995.4 7006.9 6901.6 7008.6 7053.6 7088.7 7111.6 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5765.47 Median:6535.53 stddev:1893.51 (29.0%) stddev-sans-first:1854.31 21:35:46 INFO - PROCESS | 1670 | Values: 327.9 328.0 330.5 335.6 335.7 6536.9 6587.0 6592.6 6598.3 6603.4 4603.9 5959.9 6606.0 6608.8 6635.7 4626.5 4764.7 4866.7 4918.0 5048.5 4835.7 4841.4 4850.1 4867.1 4867.5 4233.9 4515.7 4828.5 4832.8 4857.1 3942.8 4812.7 4834.0 4850.2 4903.7 4202.9 4219.4 4226.2 4234.1 4235.7 6030.8 6332.8 6341.8 6365.6 6394.1 5687.7 5705.2 5740.2 5754.5 5760.7 7083.3 7096.0 7100.0 7119.9 7126.9 4563.0 4564.9 4569.6 4574.2 4581.0 7476.6 7511.3 7535.4 7535.4 7539.2 3669.8 4638.3 4655.1 4657.6 4663.3 3852.4 4744.5 4753.9 4756.5 4757.2 5640.9 5671.9 5674.6 5681.8 5690.6 5837.9 7228.6 7228.8 7234.3 7245.3 1615.2 1641.1 1641.6 1644.5 1647.0 1009.3 1043.2 1054.9 1057.8 1061.6 5463.6 6627.9 6716.3 6717.9 6734.2 7363.4 7386.3 7413.7 7423.5 7459.5 6452.9 6534.2 6741.1 6802.8 6825.3 3907.2 3951.2 3955.0 3960.5 3968.4 7848.2 7870.4 7870.6 7893.4 7900.6 7371.6 7737.9 7750.5 7751.5 7770.4 7737.3 7783.8 7823.5 7844.5 7873.8 7420.7 7435.7 7444.7 7449.1 7482.6 7294.5 7310.7 7350.9 7374.7 7383.0 7535.6 7820.0 7825.8 7833.7 7836.2 4084.9 4392.4 4582.2 4635.8 4638.4 7330.6 7335.7 7370.5 7373.4 7387.2 5549.4 7073.0 7079.3 7109.8 7131.8 4995.7 5481.9 5661.5 6410.8 6627.2 6859.6 6879.4 6914.4 6933.8 6937.4 7062.1 7074.2 7078.0 7080.3 7105.8 6895.0 6896.6 6911.2 6939.7 6940.4 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18225.06 Median:716.96 stddev:26643.31 (3716.2%) stddev-sans-first:26685.46 21:35:46 INFO - PROCESS | 1670 | Values: 675.7 695.2 736.7 756.8 774.9 14417.5 14536.9 14677.3 14724.9 14729.7 13298.7 13320.0 13330.1 13370.4 13413.4 720.6 890.5 905.1 917.7 919.1 882.6 903.2 913.1 916.4 917.8 931.4 965.8 966.9 967.9 967.9 925.1 926.0 926.0 933.6 955.7 703.4 716.6 717.3 717.8 719.9 14599.4 14728.0 14759.0 14839.5 14872.4 12317.0 12321.3 12432.5 12585.2 12622.6 7465.6 9310.3 9361.0 9442.0 9593.6 3436.3 3467.1 3488.7 3509.4 3710.7 80352.0 80644.0 81809.6 82106.2 82245.2 7746.2 9177.6 9217.3 9383.9 9406.3 18086.8 18390.1 18456.7 18534.9 18649.0 7305.7 7364.1 7488.6 7559.7 7698.7 4092.1 4144.5 4153.8 4170.1 4203.7 3556.3 3574.2 3618.0 3619.4 3643.5 580.8 663.6 668.3 669.2 670.3 508.0 536.1 548.0 600.3 603.7 7299.5 7734.6 7994.0 8093.2 8215.4 577.2 586.3 587.1 596.2 598.7 3498.8 3778.9 3787.5 3828.7 3917.9 88749.6 90068.0 95251.6 95878.5 98425.0 82442.0 84011.6 84891.6 85103.1 85653.6 74390.3 74570.5 74581.3 74867.0 74949.0 6579.6 7726.8 7736.7 7833.6 7865.5 45808.9 52059.7 52744.7 53436.2 53896.7 52802.7 65558.0 69393.0 70461.0 71976.6 9035.7 9128.0 9145.6 9165.4 9384.3 10662.7 10778.4 10792.2 10872.8 11096.9 9954.0 10130.1 10187.7 10193.2 10570.9 8117.8 10176.4 10391.3 10558.8 10650.6 9876.6 10035.7 10078.8 10224.6 10673.3 8349.0 8392.9 8747.5 8863.4 8900.1 8708.5 8716.0 8769.8 8818.1 8864.4 21:35:46 INFO - PROCESS | 1670 | -------- Summary: end -------- 21:35:46 INFO - PROCESS | 1670 | 21:35:46 INFO - TEST-INFO | 1670: exit 0 21:35:46 INFO - TEST-OK | dromaeo_css | took 1110998ms 21:35:46 INFO - TEST-START | kraken 21:35:46 INFO - operating with platform_type : mac_ 21:35:46 INFO - Initialising browser for kraken test... 21:35:46 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpFZ7hAW/profile http://localhost:49270/getInfo.html) 21:35:48 INFO - PROCESS | 1679 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 21:35:49 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 21:35:49 INFO - PROCESS | 1679 | colorDepth:24 21:35:49 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 21:35:49 INFO - PROCESS | 1679 | __metrics 21:35:49 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 21:35:50 INFO - TEST-INFO | 1679: exit 0 21:35:50 INFO - Browser initialized. 21:35:50 INFO - Running cycle 1/1 for kraken test... 21:35:50 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpFZ7hAW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:01 INFO - PROCESS | 1682 | RSS: Main: 246845440 21:36:01 INFO - PROCESS | 1682 | 21:36:04 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 21:36:05 INFO - PROCESS | 1682 | RSS: Main: 258813952 21:36:05 INFO - PROCESS | 1682 | 21:36:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 21:36:08 INFO - PROCESS | 1682 | RSS: Main: 267866112 21:36:08 INFO - PROCESS | 1682 | 21:36:11 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 21:36:12 INFO - PROCESS | 1682 | RSS: Main: 270807040 21:36:12 INFO - PROCESS | 1682 | 21:36:14 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 21:36:15 INFO - PROCESS | 1682 | RSS: Main: 271802368 21:36:15 INFO - PROCESS | 1682 | 21:36:17 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:36:17 INFO - PROCESS | 1682 | RSS: Main: 274071552 21:36:17 INFO - PROCESS | 1682 | 21:36:20 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 21:36:21 INFO - PROCESS | 1682 | RSS: Main: 273461248 21:36:21 INFO - PROCESS | 1682 | 21:36:24 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 21:36:24 INFO - PROCESS | 1682 | RSS: Main: 273403904 21:36:24 INFO - PROCESS | 1682 | 21:36:27 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 21:36:28 INFO - PROCESS | 1682 | RSS: Main: 273461248 21:36:28 INFO - PROCESS | 1682 | 21:36:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:36:30 INFO - PROCESS | 1682 | RSS: Main: 273469440 21:36:30 INFO - PROCESS | 1682 | 21:36:32 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:36:32 INFO - PROCESS | 1682 | RSS: Main: 273620992 21:36:32 INFO - PROCESS | 1682 | 21:36:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:36:35 INFO - PROCESS | 1682 | RSS: Main: 273960960 21:36:35 INFO - PROCESS | 1682 | 21:36:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:36:38 INFO - PROCESS | 1682 | RSS: Main: 274448384 21:36:38 INFO - PROCESS | 1682 | 21:36:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:36:42 INFO - PROCESS | 1682 | RSS: Main: 274329600 21:36:42 INFO - PROCESS | 1682 | 21:36:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 21:36:44 INFO - PROCESS | 1682 | RSS: Main: 275902464 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | __start_tp_report 21:36:44 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 21:36:44 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 21:36:44 INFO - PROCESS | 1682 | |i|pagename|runs| 21:36:44 INFO - PROCESS | 1682 | |0;ai-astar;116;110;114;115;117;127;117;115;118;116 21:36:44 INFO - PROCESS | 1682 | |1;audio-beat-detection;191;142;175;189;118;138;164;126;189;108 21:36:44 INFO - PROCESS | 1682 | |2;audio-dft;195;196;194;196;206;238;272;243;201;200 21:36:44 INFO - PROCESS | 1682 | |3;audio-fft;57;59;73;72;67;126;60;77;86;83 21:36:44 INFO - PROCESS | 1682 | |4;audio-oscillator;85;102;145;78;80;100;120;83;81;123 21:36:44 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;87;86;88;86;89;85;88;87;87;85 21:36:44 INFO - PROCESS | 1682 | |6;imaging-darkroom;95;95;101;95;97;150;128;95;121;147 21:36:44 INFO - PROCESS | 1682 | |7;imaging-desaturate;90;92;91;91;100;102;107;144;92;91 21:36:44 INFO - PROCESS | 1682 | |8;json-parse-financial;57;58;57;56;55;57;56;66;59;56 21:36:44 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;67;66;73;70;78;75;72;84;101;71 21:36:44 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;100;83;90;91;119;112;91;85;84;88 21:36:44 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;131;118;142;137;134;109;154;138;149;138 21:36:44 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;165;140;127;155;151;122;117;162;127;127 21:36:44 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;67;60;55;76;90;100;59;83;70;56 21:36:44 INFO - PROCESS | 1682 | __end_tp_report 21:36:44 INFO - PROCESS | 1682 | __start_cc_report 21:36:44 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,978 21:36:44 INFO - PROCESS | 1682 | __end_cc_report 21:36:44 INFO - PROCESS | 1682 | __startTimestamp1459744604092__endTimestamp 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | ------- Summary: start ------- 21:36:44 INFO - PROCESS | 1682 | Number of tests: 14 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:116.50 Median:116.50 stddev:4.30 (3.7%) stddev-sans-first:4.56 21:36:44 INFO - PROCESS | 1682 | Values: 116.0 110.0 114.0 115.0 117.0 127.0 117.0 115.0 118.0 116.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:169.50 stddev:31.55 (18.6%) stddev-sans-first:30.49 21:36:44 INFO - PROCESS | 1682 | Values: 191.0 142.0 175.0 189.0 118.0 138.0 164.0 126.0 189.0 108.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:214.10 Median:203.50 stddev:27.12 (13.3%) stddev-sans-first:27.87 21:36:44 INFO - PROCESS | 1682 | Values: 195.0 196.0 194.0 196.0 206.0 238.0 272.0 243.0 201.0 200.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:76.00 Median:72.50 stddev:20.17 (27.8%) stddev-sans-first:20.19 21:36:44 INFO - PROCESS | 1682 | Values: 57.0 59.0 73.0 72.0 67.0 126.0 60.0 77.0 86.0 83.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:99.70 Median:79.00 stddev:22.89 (29.0%) stddev-sans-first:23.65 21:36:44 INFO - PROCESS | 1682 | Values: 85.0 102.0 145.0 78.0 80.0 100.0 120.0 83.0 81.0 123.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:1.32 (1.5%) stddev-sans-first:1.39 21:36:44 INFO - PROCESS | 1682 | Values: 87.0 86.0 88.0 86.0 89.0 85.0 88.0 87.0 87.0 85.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:112.40 Median:95.00 stddev:22.38 (23.6%) stddev-sans-first:22.83 21:36:44 INFO - PROCESS | 1682 | Values: 95.0 95.0 101.0 95.0 97.0 150.0 128.0 95.0 121.0 147.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:91.00 stddev:16.53 (18.2%) stddev-sans-first:17.14 21:36:44 INFO - PROCESS | 1682 | Values: 90.0 92.0 91.0 91.0 100.0 102.0 107.0 144.0 92.0 91.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.13 (5.5%) stddev-sans-first:3.31 21:36:44 INFO - PROCESS | 1682 | Values: 57.0 58.0 57.0 56.0 55.0 57.0 56.0 66.0 59.0 56.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:72.50 stddev:10.33 (14.2%) stddev-sans-first:10.46 21:36:44 INFO - PROCESS | 1682 | Values: 67.0 66.0 73.0 70.0 78.0 75.0 72.0 84.0 101.0 71.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:86.50 stddev:12.28 (14.2%) stddev-sans-first:12.85 21:36:44 INFO - PROCESS | 1682 | Values: 100.0 83.0 90.0 91.0 119.0 112.0 91.0 85.0 84.0 88.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:138.00 stddev:13.37 (9.7%) stddev-sans-first:14.11 21:36:44 INFO - PROCESS | 1682 | Values: 131.0 118.0 142.0 137.0 134.0 109.0 154.0 138.0 149.0 138.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.30 Median:145.50 stddev:17.67 (12.1%) stddev-sans-first:16.11 21:36:44 INFO - PROCESS | 1682 | Values: 165.0 140.0 127.0 155.0 151.0 122.0 117.0 162.0 127.0 127.0 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:68.50 stddev:15.39 (22.5%) stddev-sans-first:16.23 21:36:44 INFO - PROCESS | 1682 | Values: 67.0 60.0 55.0 76.0 90.0 100.0 59.0 83.0 70.0 56.0 21:36:44 INFO - PROCESS | 1682 | -------- Summary: end -------- 21:36:44 INFO - PROCESS | 1682 | 21:36:44 INFO - TEST-INFO | 1682: exit 0 21:36:44 INFO - TEST-OK | kraken | took 58273ms 21:36:44 INFO - SUITE-END | took 1169s 21:36:45 INFO - Completed test suite (00:19:29) 21:36:45 INFO - javascript benchmark 21:36:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2903.8257704537727, 3494.388482015647, 3544.8404821783015, 3547.432410814267, 3586.3006713690843, 5687.7156142192935, 5704.8859022819515, 5738.42615738426, 5750.108733146364, 5765.221695071169, 5618.185363122345, 5696.743646535905, 5729.197912292282, 5742.109972954188, 5812.389699081599, 5198.0, 5235.921461178085, 5279.656822306538, 5312.229726689628, 5322.760475778599, 358.1665165734869, 5234.895302093956, 5254.57963362932, 5306.867328316804, 5344.22508736233, 5223.294855194557, 5241.764120614582, 5253.894922101575, 5268.420473747885, 5278.498542638443, 5166.0, 5291.232771248186, 5318.282031925679, 5321.680699158062, 5326.786928522854, 5122.436531981479, 5147.150720131174, 5212.348456442945, 5236.659617124875, 5261.342332208474, 5559.833205003856, 5654.9151762723595, 5663.207150998864, 5705.6006079574445, 5714.200011998323, 6097.176881121036, 6148.262208534959, 6229.937700623026, 6233.937660623426, 6255.874882502325, 6195.380461953813, 6248.0, 6251.156093927307, 6261.843453913643, 6268.5298602604535, 4852.369192005052, 5819.476247137735, 5879.088741245114, 5880.323762767336, 5894.705264736746, 6186.566940314135, 6224.533160013018, 6251.78118765841, 6303.495720342454, 6326.557141000086, 6174.567780255429, 6205.069239614004, 6208.50331973441, 6219.564630475914, 6241.875162496724, 6194.132821405007, 6212.627242365382, 6277.52918531112, 6287.056941458726, 6299.307076221612, 6111.938880611137, 6171.876562468815, 6227.96886015567, 6232.937670623326, 6233.0338797486465, 6106.430331452127, 6157.692115394212, 6232.220972378453, 6243.500519958392, 6277.403646653561, 4852.684575502581, 4932.706291574364, 4933.55597996182, 4950.18321976877, 4959.380077490314, 4326.134773045404, 4364.716293440916, 4405.801738921757, 4468.0, 4489.259272220047, 5872.794452194153, 5921.940780592225, 5954.85112872173, 5977.402259773988, 5978.3124940631515, 5428.5928555358505, 5592.720363981784, 5793.768249269982, 6216.627002379872, 6225.315215326311, 5763.193152958589, 5899.233099697012, 5928.199693041471, 5958.165856780054, 5984.850378740566, 4597.195490789099, 5339.638392209961, 5392.0, 5410.513053825174, 5423.3491980962535, 5863.648181109147, 5913.940860591425, 6251.71867265965, 6378.17083779115, 6381.202349706286, 6144.863200307957, 6192.473639740492, 6241.78153764616, 6246.750129994931, 6258.123862659322, 6453.612783233021, 6471.967640161769, 6486.902696459651, 6506.3493650634555, 6510.121133647087, 6013.729382177725, 6128.387161283836, 6129.938700612936, 6160.661163636043, 6163.137160797402, 6103.6104255942055, 6121.079909957769, 6166.938330616816, 6180.598261113193, 6253.499720022296, 6103.9694801527485, 6120.0, 6125.173101631401, 6127.632342059491, 6127.877442451215, 5313.96377706359, 5996.370381110095, 6080.72636731357, 6102.938970610415, 6109.11124314113, 5278.0, 5838.678872661874, 5965.075413310944, 6075.787347442818, 6121.84695382619, 6161.568690191643, 6167.198264225622, 6177.011678131657, 6185.072239164161, 6186.536009799193, 5442.673439593637, 5586.692731899622, 5852.06366981298, 6005.939940600538, 6048.606840555526], "unit": "score", "name": "dojo.html", "value": 5661.534206693088}, {"lowerIsBetter": false, "replicates": [510.16333213529794, 525.2174260352076, 559.6194587680378, 559.683778665054, 561.8005608009157, 29597.556036659415, 30295.848520757394, 37717.057073573174, 37718.62281377186, 37905.43141852868, 38628.22743545128, 38902.610973890325, 39354.40968385476, 39387.24289299743, 39410.80294598523, 9425.151736343727, 9611.66359177429, 9638.469884156368, 9647.951760241189, 9664.03359664035, 9411.388259763127, 9621.085996830325, 9635.084666956627, 9639.855402168972, 9649.807003859918, 9599.90400095997, 9606.519674016272, 9607.4715890626, 9655.5172241388, 9694.22446204302, 9467.0, 9532.237421006303, 9558.996305387938, 9581.952090239503, 9590.280728945358, 9479.573419196153, 9615.56729947154, 9638.42169469834, 9641.180499657537, 9671.177949874269, 37552.24895502075, 38106.42840357397, 38143.80928095342, 38199.04502387463, 38227.808860955796, 2800.187945495804, 2831.6602007758993, 3192.170035790688, 3273.508973653947, 3503.929921401583, 26474.941002359883, 26511.337216569547, 26581.867090664615, 26823.0, 27231.727682723315, 2225.7662945390825, 2689.3007817967273, 2701.0, 2844.5590933405356, 2879.7696184305205, 388233.0, 389961.0501947501, 391219.0, 391325.0, 396611.0, 63578.68210658917, 63951.0, 63975.68012159909, 63981.0, 64093.0, 71992.0, 72315.2768472319, 72356.63821680963, 73173.0, 73199.63400183071, 14077.366518506691, 14611.415543378358, 16129.87090903649, 16672.916635416987, 16916.0, 10740.194485413625, 12279.017678585691, 12334.013278937664, 12369.381530923598, 12798.744025119631, 16749.413770517975, 20742.688859667116, 20974.895125524275, 20985.265515706877, 21107.26124585632, 7460.253974602496, 9179.495127767903, 9196.080391960884, 9199.310051746146, 9215.63137474507, 876.4960147914975, 937.803061357109, 944.631593678466, 952.2762700347786, 1075.1130317488103, 29130.708692912798, 29409.264768380533, 29443.96946106876, 29672.703272966995, 30037.39925201484, 984.7193549838262, 1042.8904964978567, 1047.8218702820539, 1101.9944900275448, 1171.5782318365382, 14806.481773137888, 14894.776578351333, 15024.248787560578, 15217.467388641344, 15245.0, 500148.0, 501888.0, 502491.0, 506921.0, 507996.0, 47432.7628361856, 57415.0, 58309.12536311959, 58319.0, 58559.0, 1387.5629176809273, 1410.1186758276078, 1430.3277459593974, 1442.228407801842, 1450.100937418807, 29002.41995160127, 29182.56226156652, 29309.560356595095, 29757.809687612254, 29839.403211935205, 46031.0, 50230.497695024045, 50596.73508162326, 50646.0, 50734.0, 452495.0, 464498.0, 469845.0, 469910.0, 470234.0, 32035.558399871596, 32944.83527582347, 33130.84042058516, 33631.15922101967, 33772.83113584515, 44233.778831105636, 44382.3342649867, 44747.32879006882, 45253.77373113245, 46259.76870115628, 29944.550831737975, 37072.81463592665, 37392.25215495729, 38152.236955261294, 38188.0, 29540.0, 33611.83194084014, 35396.0, 35583.64416355907, 36049.63950360463, 29389.26526836846, 36764.0, 36812.0, 37083.814580926926, 37092.81453592715, 28690.426191476472, 31320.843395783788, 31731.365372691955, 32466.83766581152, 32911.670883291816, 21553.461163471038, 22709.0, 24856.130035448674, 25319.493610127327, 25634.0], "unit": "score", "name": "ext.html", "value": 19299.42759150509}, {"lowerIsBetter": false, "replicates": [324.86193367818674, 355.7598620930871, 363.565539180679, 366.71762742688134, 367.8105775525603, 18756.624867502658, 19268.03659817009, 19951.501212469695, 19953.0, 20070.096845641943, 16634.0, 19368.3221087262, 19741.901290493526, 20167.09248083836, 20284.18863245472, 5449.4005659377435, 5632.211490391349, 5634.521065709419, 5711.742971566289, 5752.108423194411, 5368.221607866857, 5657.801976930808, 5702.600817942745, 5757.280339957505, 5761.366249712549, 4777.426708794932, 4781.8087276508895, 5584.664920104807, 5603.831885043455, 5644.887102257952, 5359.437259087778, 5441.537469315113, 5632.0, 6353.205849268795, 6379.904301435482, 5526.115821468586, 5532.28080349556, 5536.2249285100115, 5559.833205003856, 5570.025245582047, 12955.611331660066, 23702.525949480914, 24249.87875060631, 24708.13521526756, 24970.5005899881, 2023.1401654296865, 2043.7343145391153, 2132.5734853029458, 2697.5414179589516, 2717.0, 9661.516924153764, 9804.607815687365, 10329.535170917326, 12199.14605977582, 13791.965602579847, 1465.1428914085272, 1697.295622316737, 1711.64055548335, 1713.5459103337625, 1761.1546457700376, 97960.51019744856, 101801.0, 103403.96596034018, 104443.4777826106, 105657.0, 10781.9460902695, 10990.065844403156, 11067.391293478775, 11259.662210133709, 11283.266587671775, 13382.53161139375, 13416.597502074954, 13450.529231476852, 13476.663083422993, 13549.322533873266, 8362.707305244408, 8445.662173513114, 8469.11074337198, 8471.618777155043, 8508.659653613786, 8556.828863422697, 8594.355423343275, 8629.741107766777, 8681.696140635173, 8686.391952563386, 4335.804888780012, 4374.19077470669, 4383.3863259143745, 4403.669724770655, 4451.821927122944, 1727.2141175764996, 1827.0681952204206, 1848.5471059590218, 1869.4016615793573, 1873.7095750158746, 940.0223767282087, 943.6084025129494, 965.5992763003416, 989.9851502227473, 1012.8480727890728, 19015.42953711391, 19192.904035479733, 20027.699584506245, 20035.0, 20163.19347226124, 881.5548148185254, 946.0870260198803, 971.3249291742312, 1020.1838529176629, 1036.3160314192596, 10304.639337623297, 10356.430396328275, 10384.844227336596, 10434.0, 10519.0, 560479.0, 634451.0, 644703.7764811146, 653629.0, 659579.0, 94970.52514737382, 108117.45941270243, 108458.0, 125715.0, 127036.36481817532, 868.8957325121025, 1026.0867827633413, 1030.9278350515542, 1036.6268143468346, 1083.7290677330668, 17185.914070429568, 17366.82633173652, 17441.953482791072, 17458.825411746227, 17524.299028038735, 43448.34827477527, 45855.31217031681, 47065.0, 48657.27014094721, 49813.50186498234, 69937.0, 70248.29751702417, 73245.6337718308, 74226.25773742194, 74867.62566187134, 7379.298966598165, 7507.62461876893, 7554.320111190019, 7568.129665088585, 7723.806904827425, 10991.0, 11755.588554400554, 11756.0007399372, 11900.226485278776, 12034.458449369975, 9031.909680903107, 9765.560549775135, 10149.0, 10190.388576685422, 10550.997655222742, 10134.79730405373, 10221.9488902555, 10440.164786817188, 10556.683299501028, 10558.524866380878, 9273.026332235288, 9807.950960245153, 10577.841332380174, 10778.946105269737, 10894.673159804901, 7516.361109305771, 7599.164091949991, 7625.351845093229, 7686.231376862269, 7987.760367188994, 8462.111478294937, 9558.904410955802, 10418.947905260426, 10617.469126543487, 10690.679279621623], "unit": "score", "name": "jquery.html", "value": 9124.15930839227}, {"lowerIsBetter": false, "replicates": [1512.3118980863705, 1624.8131464881537, 1885.3684015854687, 1973.4572992427072, 1978.1395093134497, 7930.405219608524, 8518.446300990432, 8648.827023459527, 8868.645254189832, 8878.467291962479, 7986.361091112712, 8005.239502247292, 8109.310708589762, 8126.715564955228, 8146.185381461865, 2426.2357357432443, 2441.121196369306, 2446.217210492643, 2447.3881529617597, 2454.1410506322823, 2391.9834070520046, 2437.195725410619, 2443.8900249488725, 2448.51029794041, 2450.019992003195, 2426.0659646036315, 2431.9392015199674, 2441.170002199252, 2464.4578192797558, 2468.3705655057934, 2416.9395765105837, 2449.0571130115036, 2454.3741345956755, 2454.864982425966, 2458.754124587536, 2418.818588605862, 2447.8286519943613, 2448.1431498975394, 2450.399652085233, 2452.5953217719057, 8148.348132149414, 8194.09864914859, 8295.0, 8303.709370172075, 8385.993680758287, 5430.864228394322, 5565.387807341189, 5579.246801681802, 5593.021221286299, 5602.1036634138745, 3532.929341413183, 3599.6760291573883, 3641.581218159919, 3654.853805847763, 3666.8349924253207, 1041.4792603698152, 1055.952482138298, 1059.2003037706481, 1060.1042119409087, 1062.282959002678, 11775.764484710258, 11817.704557386049, 11901.285922844658, 11919.344436055926, 11951.0, 4829.227323628203, 4861.392325959255, 4963.875903102451, 4992.326035985168, 5000.299958005882, 7471.252874712594, 9044.321675874337, 9980.201583873273, 10023.0, 10034.946330635325, 5492.5331346835965, 5512.6692398456225, 5560.193771903051, 5582.24639673647, 5603.551715862721, 4527.660425468103, 4877.926831097537, 4963.081829861487, 4986.775595098229, 5037.924431133536, 3322.5680661514334, 3928.823202955874, 4006.939895901564, 4040.91918161641, 4085.611866872642, 1331.1946272505188, 1331.8135461035463, 1339.5378594384922, 1354.4717560151548, 1356.7354365898752, 1078.455380033094, 1079.6868908016588, 1275.9744805103846, 1341.1952828303135, 1376.2224343246035, 8110.270075693098, 8112.1076681566165, 8160.714374996846, 8166.346692264605, 8197.918020819834, 510.084398504685, 523.5026724611635, 527.4777969809861, 529.7774934527507, 530.5649367518598, 6066.998945173997, 6191.84520386994, 6200.3799620038535, 6213.502919766408, 6230.626162430269, 10413.895861041445, 10512.737181570523, 10704.571817127227, 10737.355758654505, 10811.83782243267, 10389.480525973822, 10504.212184086224, 10517.05346518817, 10559.63041293551, 10560.47197640115, 8197.303229225463, 8277.089520152898, 8310.335173186251, 8395.370347223983, 8400.579971001425, 7628.0, 7649.923500764921, 7767.184445633127, 7863.135055143815, 7874.803129921798, 9175.22010629104, 9492.620295188115, 9530.618775248913, 9557.283203759607, 9621.759456013655, 9590.616375344907, 9800.901990979999, 9840.507974601385, 9868.50657467138, 9880.258980576342, 6560.081588577698, 7007.369336759716, 7219.386352160125, 7266.455015873725, 7319.304666056716, 6843.349881761224, 8006.799830004296, 8141.470804397695, 8152.062512811102, 8180.713675021346, 7189.856202876018, 7281.854362912818, 7294.270572942663, 7300.087489063867, 7435.107787065371, 7114.039604653305, 7165.964170179116, 7193.136823581203, 7195.280471952972, 7202.96398518004, 7579.848403031799, 7606.315431611181, 7684.9231507686445, 7693.807654808675, 7751.0311211098615, 6939.895901561582, 6949.027136201037, 6985.1617805863625, 6995.405390541658, 7006.929930700628, 6901.551399159039, 7008.579485230903, 7053.612051337021, 7088.716451342095, 7111.573305601681], "unit": "score", "name": "mootools.html", "value": 4805.101383368395}, {"lowerIsBetter": false, "replicates": [327.8590206211329, 328.0323047011316, 330.45310011930263, 335.60566334556887, 335.70290293090613, 6536.869262614745, 6586.967065164674, 6592.604443733373, 6598.307177746339, 6603.438707709851, 4603.941093548486, 5959.867625151229, 6605.966970165155, 6608.801735947929, 6635.701393437294, 4626.4910859805395, 4764.737939413331, 4866.683665561744, 4917.975410122945, 5048.520390562909, 4835.661503694742, 4841.443234028079, 4850.12697714413, 4867.075255701423, 4867.537583929538, 4233.8729838104755, 4515.713021788791, 4828.46886842447, 4832.782524786376, 4857.125717370872, 3942.7634341939574, 4812.711237325754, 4833.9516604834025, 4850.151223535867, 4903.705777653352, 4202.85290014851, 4219.38818871262, 4226.154769046172, 4234.068504928941, 4235.703500754948, 6030.758769649253, 6332.841678958017, 6341.8097457076365, 6365.586236894634, 6394.113736447759, 5687.687177205252, 5705.1727499512335, 5740.196372507852, 5754.510866576346, 5760.711964401763, 7083.256258092878, 7096.0, 7100.0, 7119.857602847914, 7126.857462850714, 4562.954370456286, 4564.931526027112, 4569.634429245652, 4574.153781550391, 4581.0, 7476.626168691598, 7511.323980841696, 7535.434842386843, 7535.434842386843, 7539.208383119803, 3669.834857431422, 4638.304254361805, 4655.092257009851, 4657.604103651228, 4663.253879379283, 3852.3836186210633, 4744.4543877454535, 4753.904921901542, 4756.548127927841, 4757.191277482767, 5640.915386269209, 5671.943280567224, 5674.631148975303, 5681.829545113653, 5690.601657883908, 5837.883242335214, 7228.638568071576, 7228.783136505913, 7234.276572342724, 7245.275472452712, 1615.192403798101, 1641.1384023387816, 1641.6142206581444, 1644.4902080355128, 1646.9505914822576, 1009.2985375164191, 1043.2175868098925, 1054.862867827193, 1057.8148823955778, 1061.6337363609543, 5463.590230732631, 6627.900581491282, 6716.261211266757, 6717.932820671828, 6734.225564060098, 7363.410927125817, 7386.2613738625705, 7413.666385012687, 7423.480356375002, 7459.477836551389, 6452.903206451907, 6534.183227096613, 6741.089952856301, 6802.795916122524, 6825.317468253234, 3907.2185562887535, 3951.150502641946, 3955.0, 3960.5049368828895, 3968.40473928913, 7848.21517848222, 7870.370370370357, 7870.567118808521, 7893.368530517545, 7900.565468899151, 7371.557706537517, 7737.92262077372, 7750.534967901944, 7751.496152750054, 7770.378369730408, 7737.264959828807, 7783.844323113619, 7823.530588164728, 7844.450888437868, 7873.763787086396, 7420.6660700269695, 7435.7025718970635, 7444.73943411978, 7449.143348514774, 7482.551046937201, 7294.489385743159, 7310.707571697285, 7350.889736653848, 7374.741884034033, 7383.0, 7535.623218838927, 7820.0, 7825.843483130419, 7833.725819596287, 7836.177201393772, 4084.8766589188212, 4392.3850660906855, 4582.175208462376, 4635.794693379813, 4638.420197475316, 7330.560166390033, 7335.669894854637, 7370.520916140434, 7373.446991475554, 7387.224341444071, 5549.361823390362, 7072.9646351767915, 7079.2566780487305, 7109.786706398816, 7131.7503887365765, 4995.675281106716, 5481.945180548303, 5661.518770904355, 6410.775622853178, 6627.237867645283, 6859.5541289816, 6879.415249703831, 6914.377706006484, 6933.826654333682, 6937.375636192767, 7062.117235345582, 7074.151101867808, 7078.0, 7080.327368899946, 7105.822354440974, 6894.965525172543, 6896.551724137915, 6911.205211400753, 6939.687714052779, 6940.375366217065], "unit": "score", "name": "prototype.html", "value": 5137.908770026706}, {"lowerIsBetter": false, "replicates": [675.7330854312546, 695.2144077192771, 736.6721808795087, 756.833496630741, 774.8953891224686, 14417.495387661435, 14536.854631453682, 14677.266136693175, 14724.926375368135, 14729.705405891877, 13298.667533311673, 13320.0, 13330.133541319832, 13370.398332075056, 13413.396397162127, 720.5604581205461, 890.470170248701, 905.1175104273347, 917.6833992272656, 919.071737545081, 882.5543100734152, 903.2367649336334, 913.118840319092, 916.3906002508324, 917.8118485710447, 931.4457897550947, 965.8068386322728, 966.8984756600561, 967.8644989701447, 967.8644989701447, 925.0610630210308, 925.9861102083474, 926.0230456868002, 933.5985526223722, 955.7467271173144, 703.3845385287873, 716.6273537760387, 717.2827172827173, 717.8492516571526, 719.8524302517972, 14599.41602335916, 14728.042677226053, 14759.0, 14839.480618178311, 14872.405103795834, 12317.0, 12321.260724356478, 12432.502699892084, 12585.181963172365, 12622.558210462681, 7465.552066875951, 9310.301727370406, 9361.0, 9442.0, 9593.616255349778, 3436.295559410315, 3467.133216695826, 3488.7034602058857, 3509.4034014217646, 3710.666040056408, 80352.0, 80644.0, 81809.59095204546, 82106.17893821104, 82245.17754822435, 7746.225377462209, 9177.587008584629, 9217.308701847389, 9383.906160938439, 9406.341556091145, 18086.819131808777, 18390.080495975148, 18456.723149152775, 18534.907325463555, 18649.0, 7305.744298949511, 7364.116306043309, 7488.625568721543, 7559.697612095564, 7698.653560589675, 4092.120194158211, 4144.5026596808575, 4153.7507749535125, 4170.124273902515, 4203.747775133502, 3556.342076715816, 3574.2136729919375, 3618.0231337538717, 3619.366610843092, 3643.5263415756312, 580.7803612413982, 663.5587334422652, 668.254895791199, 669.220358282605, 670.3196255800269, 507.97968081277077, 536.0752701589727, 547.9780808767684, 600.2766666167258, 603.6528995827417, 7299.5255308404785, 7734.613269336511, 7993.960030199812, 8093.1502192270145, 8215.424920255644, 577.2149876168407, 586.3257254157668, 587.0929414055295, 596.2219303808572, 598.7126179433809, 3498.7900725956524, 3778.886633401002, 3787.450819631138, 3828.674562662205, 3917.87382718958, 88749.55625221833, 90068.0, 95251.57122643165, 95878.52060739652, 98425.0, 82442.0, 84011.5799420999, 84891.57554212313, 85103.14896851077, 85653.57173214095, 74390.25609743941, 74570.5085898279, 74581.25418745851, 74867.0, 74949.0, 6579.638119903259, 7726.806829829299, 7736.690532378867, 7833.647485863264, 7865.528068315691, 45808.854778630805, 52059.739701302766, 52744.73627631837, 53436.19845702395, 53896.73051634873, 52802.73598632136, 65558.0, 69393.0, 70461.0, 71976.64011679908, 9035.683751068682, 9127.954360228421, 9145.5884485197, 9165.358424910191, 9384.343095983215, 10662.680119596425, 10778.407425986134, 10792.175672637275, 10872.782544348911, 11096.889031109586, 9953.950230248802, 10130.124527773725, 10187.745306367104, 10193.235507337127, 10570.947145264225, 8117.79705507367, 10176.389416635026, 10391.324563903323, 10558.8416173759, 10650.627228046982, 9876.604935802774, 10035.749106272402, 10078.798424031625, 10224.591016359262, 10673.306235094695, 8349.039860415887, 8392.916070839214, 8747.475151490931, 8863.379563430499, 8900.109989001048, 8708.521031343336, 8715.956420217859, 8769.824603508021, 8818.11818818113, 8864.379493435397], "unit": "score", "name": "yui.html", "value": 6676.336560343614}], "name": "dromaeo_css", "value": 7400.973986361125}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 114.0, 115.0, 117.0, 127.0, 117.0, 115.0, 118.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.5}, {"lowerIsBetter": true, "replicates": [191.0, 142.0, 175.0, 189.0, 118.0, 138.0, 164.0, 126.0, 189.0, 108.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [195.0, 196.0, 194.0, 196.0, 206.0, 238.0, 272.0, 243.0, 201.0, 200.0], "unit": "score", "name": "audio-dft", "value": 214.1}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 73.0, 72.0, 67.0, 126.0, 60.0, 77.0, 86.0, 83.0], "unit": "score", "name": "audio-fft", "value": 76.0}, {"lowerIsBetter": true, "replicates": [85.0, 102.0, 145.0, 78.0, 80.0, 100.0, 120.0, 83.0, 81.0, 123.0], "unit": "score", "name": "audio-oscillator", "value": 99.7}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 86.0, 89.0, 85.0, 88.0, 87.0, 87.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 101.0, 95.0, 97.0, 150.0, 128.0, 95.0, 121.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 112.4}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 91.0, 91.0, 100.0, 102.0, 107.0, 144.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 100.0}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 57.0, 56.0, 55.0, 57.0, 56.0, 66.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 73.0, 70.0, 78.0, 75.0, 72.0, 84.0, 101.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.7}, {"lowerIsBetter": true, "replicates": [100.0, 83.0, 90.0, 91.0, 119.0, 112.0, 91.0, 85.0, 84.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.3}, {"lowerIsBetter": true, "replicates": [131.0, 118.0, 142.0, 137.0, 134.0, 109.0, 154.0, 138.0, 149.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.0}, {"lowerIsBetter": true, "replicates": [165.0, 140.0, 127.0, 155.0, 151.0, 122.0, 117.0, 162.0, 127.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.3}, {"lowerIsBetter": true, "replicates": [67.0, 60.0, 55.0, 76.0, 90.0, 100.0, 59.0, 83.0, 70.0, 56.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1533.1}]} 21:36:45 INFO - Return code: 0 21:36:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:36:45 ERROR - # TBPL SUCCESS # 21:36:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:36:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:36:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:36:45 INFO - 2016-04-03 21:36:45.447 screenresolution[1687:11110] starting screenresolution argv=screenresolution get 21:36:45 INFO - 2016-04-03 21:36:45.450 screenresolution[1687:11110] Display 0: 1600x1200x32@60 21:36:45 INFO - 2016-04-03 21:36:45.456 screenresolution[1688:11113] starting screenresolution argv=screenresolution list 21:36:45 INFO - Available Modes on Display 0 21:36:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:36:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:36:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:36:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:36:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:36:45 INFO - Intel Iris: 21:36:45 INFO - Chipset Model: Intel Iris 21:36:45 INFO - Type: GPU 21:36:45 INFO - Bus: Built-In 21:36:45 INFO - VRAM (Dynamic, Max): 1536 MB 21:36:45 INFO - Vendor: Intel (0x8086) 21:36:45 INFO - Device ID: 0x0a2e 21:36:45 INFO - Revision ID: 0x0009 21:36:45 INFO - Displays: 21:36:45 INFO - Display: 21:36:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:36:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:36:45 INFO - Display Serial Number: 1600x1200 60 21:36:45 INFO - Main Display: Yes 21:36:45 INFO - Mirror: Off 21:36:45 INFO - Online: Yes 21:36:45 INFO - Rotation: Supported 21:36:45 INFO - Return code: 0 21:36:45 INFO - Running post-action listener: _resource_record_post_action 21:36:45 INFO - Running post-run listener: _resource_record_post_run 21:36:46 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 31858176; Write bytes: 706563584; Read time: 325; Write time: 1972 21:36:46 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399004160; Write bytes: 394038272; Read time: 30417; Write time: 692 21:36:46 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30076416; Write bytes: 301363712; Read time: 307; Write time: 1250 21:36:46 INFO - Running post-run listener: _upload_blobber_files 21:36:46 INFO - Blob upload gear active. 21:36:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:36:46 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 21:36:46 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'] 21:36:46 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 21:36:47 INFO - (blobuploader) - INFO - Open directory for files ... 21:36:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:36:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:48 INFO - (blobuploader) - INFO - Done attempting. 21:36:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:36:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:36:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:49 INFO - (blobuploader) - INFO - Done attempting. 21:36:49 INFO - (blobuploader) - INFO - Iteration through files over. 21:36:49 INFO - Return code: 0 21:36:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:36:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:36:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68db6b6f489b799ccbf6754cac4f88e8c0f5e2600894a2997323aadf64c4449ecd295dd02d33ea5aeeab680c4a7f163396702d48f6bf3591cf53e90e302e59ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebffbd38a17207df1e2e832368e1ade42a125938bca59c7c678f15b5cd046a3043e5519f5cc394afea798c12db3bab4d228319bea8861d73722b29f1dc655986"} 21:36:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:36:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:36:49 INFO - Contents: 21:36:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68db6b6f489b799ccbf6754cac4f88e8c0f5e2600894a2997323aadf64c4449ecd295dd02d33ea5aeeab680c4a7f163396702d48f6bf3591cf53e90e302e59ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebffbd38a17207df1e2e832368e1ade42a125938bca59c7c678f15b5cd046a3043e5519f5cc394afea798c12db3bab4d228319bea8861d73722b29f1dc655986"} 21:36:49 INFO - Running post-run listener: copy_logs_to_upload_dir 21:36:49 INFO - Copying logs to upload dir... 21:36:49 INFO - mkdir: /builds/slave/test/build/upload/logs 21:36:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.497978 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-03 21:36:49.347654) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 21:36:49.351348) ========= 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.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68db6b6f489b799ccbf6754cac4f88e8c0f5e2600894a2997323aadf64c4449ecd295dd02d33ea5aeeab680c4a7f163396702d48f6bf3591cf53e90e302e59ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebffbd38a17207df1e2e832368e1ade42a125938bca59c7c678f15b5cd046a3043e5519f5cc394afea798c12db3bab4d228319bea8861d73722b29f1dc655986"} build_url:https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010801 build_url: 'https://queue.taskcluster.net/v1/task/CWplx0aySrmwbDOSxejCjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68db6b6f489b799ccbf6754cac4f88e8c0f5e2600894a2997323aadf64c4449ecd295dd02d33ea5aeeab680c4a7f163396702d48f6bf3591cf53e90e302e59ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebffbd38a17207df1e2e832368e1ade42a125938bca59c7c678f15b5cd046a3043e5519f5cc394afea798c12db3bab4d228319bea8861d73722b29f1dc655986"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 21:36:49.379033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:36:49.379381) ========= 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.uVCU4003qT/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.AeudbxW03x/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005052 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:36:49.427852) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 21:36:49.428221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 21:36:49.428667) ========= ========= Total master_lag: 0.37 =========