builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0105 starttime: 1456392056.36 results: success (0) buildid: 20160225001026 builduid: 129738015c96428db34cd40b39314c21 revision: 5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:56.361951) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:56.362459) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:56.362820) ========= 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.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.006076 basedir: '/builds/slave/test' ========= master_lag: 0.30 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:56.670265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:56.670622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:57.349552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:57.349961) ========= 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.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005495 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:57.548689) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:57.549017) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:57.549382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:57.549686) ========= 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.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-02-25 01:20:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-02-25 01:20:58 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.566392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:58.136695) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:58.137049) ========= 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.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.019805 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:20:58.194013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-25 01:20:58.194394) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2 --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 5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-02-25 01:20:58,277 truncating revision to first 12 chars 2016-02-25 01:20:58,277 Setting DEBUG logging. 2016-02-25 01:20:58,277 attempt 1/10 2016-02-25 01:20:58,277 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b53d1dcb009?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 01:21:00,121 unpacking tar archive at: fx-team-5b53d1dcb009/testing/mozharness/ program finished with exit code 0 elapsedTime=2.081978 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-25 01:21:00.301608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:21:00.301983) ========= echo 5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2 program finished with exit code 0 elapsedTime=0.005174 script_repo_revision: '5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:21:00.357719) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 01:21:00.358090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 01:21:00.372106) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-25 01:21:00.372456) ========= /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.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:00 INFO - MultiFileLogger online at 20160225 01:21:00 in /builds/slave/test 01:21:00 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 01:21:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:21:00 INFO - {'append_to_log': False, 01:21:00 INFO - 'base_work_dir': '/builds/slave/test', 01:21:00 INFO - 'blob_upload_branch': 'Fx-Team', 01:21:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:21:00 INFO - 'branch': 'Fx-Team', 01:21:00 INFO - 'buildbot_json_path': 'buildprops.json', 01:21:00 INFO - 'config_files': ('talos/mac_config.py',), 01:21:00 INFO - 'default_actions': ('clobber', 01:21:00 INFO - 'read-buildbot-config', 01:21:00 INFO - 'download-and-extract', 01:21:00 INFO - 'populate-webroot', 01:21:00 INFO - 'create-virtualenv', 01:21:00 INFO - 'install', 01:21:00 INFO - 'run-tests'), 01:21:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:21:00 INFO - 'download_minidump_stackwalk': True, 01:21:00 INFO - 'download_symbols': 'ondemand', 01:21:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:21:00 INFO - 'tooltool.py': '/tools/tooltool.py', 01:21:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:21:00 INFO - '/tools/misc-python/virtualenv.py')}, 01:21:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:21:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:21:00 INFO - 'installer_path': 'installer.exe', 01:21:00 INFO - 'log_level': 'info', 01:21:00 INFO - 'log_name': 'talos', 01:21:00 INFO - 'log_to_console': True, 01:21:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:21:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:21:00 INFO - 'opt_config_files': (), 01:21:00 INFO - 'pip_index': False, 01:21:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:21:00 INFO - 'cmd': ('bash', 01:21:00 INFO - '-c', 01:21:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:21:00 INFO - 'enabled': True, 01:21:00 INFO - 'halt_on_failure': False, 01:21:00 INFO - 'name': 'check_screen_resolution'},), 01:21:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:21:00 INFO - 'cmd': ('bash', 01:21:00 INFO - '-c', 01:21:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:21:00 INFO - 'enabled': True, 01:21:00 INFO - 'halt_on_failure': False, 01:21:00 INFO - 'name': 'check_screen_resolution'},), 01:21:00 INFO - 'run_cmd_checks_enabled': True, 01:21:00 INFO - 'sps_profile': False, 01:21:00 INFO - 'sps_profile_interval': 0, 01:21:00 INFO - 'suite': 'dromaeojs-e10s', 01:21:00 INFO - 'system_bits': '32', 01:21:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:21:00 INFO - 'title': 't-yosemite-r7-0105', 01:21:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:21:00 INFO - 'use_talos_json': True, 01:21:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:21:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:21:00 INFO - 'work_dir': 'build'} 01:21:00 INFO - ##### 01:21:00 INFO - ##### Running clobber step. 01:21:00 INFO - ##### 01:21:00 INFO - Running pre-action listener: _resource_record_pre_action 01:21:00 INFO - Running main action method: clobber 01:21:00 INFO - rmtree: /builds/slave/test/build 01:21:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:21:01 INFO - Running post-action listener: _resource_record_post_action 01:21:01 INFO - ##### 01:21:01 INFO - ##### Running read-buildbot-config step. 01:21:01 INFO - ##### 01:21:01 INFO - Running pre-action listener: _resource_record_pre_action 01:21:01 INFO - Running main action method: read_buildbot_config 01:21:01 INFO - Using buildbot properties: 01:21:01 INFO - { 01:21:01 INFO - "project": "", 01:21:01 INFO - "product": "firefox", 01:21:01 INFO - "script_repo_revision": "production", 01:21:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:21:01 INFO - "repository": "", 01:21:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:21:01 INFO - "buildid": "20160225001026", 01:21:01 INFO - "pgo_build": "False", 01:21:01 INFO - "basedir": "/builds/slave/test", 01:21:01 INFO - "buildnumber": 449, 01:21:01 INFO - "slavename": "t-yosemite-r7-0105", 01:21:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:21:01 INFO - "platform": "yosemite_r7", 01:21:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:21:01 INFO - "branch": "fx-team", 01:21:01 INFO - "repo_path": "integration/fx-team", 01:21:01 INFO - "revision": "5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2", 01:21:01 INFO - "stage_platform": "macosx64", 01:21:01 INFO - "builduid": "129738015c96428db34cd40b39314c21", 01:21:01 INFO - "slavebuilddir": "test" 01:21:01 INFO - } 01:21:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:21:01 INFO - Running post-action listener: _resource_record_post_action 01:21:01 INFO - ##### 01:21:01 INFO - ##### Running download-and-extract step. 01:21:01 INFO - ##### 01:21:01 INFO - Running pre-action listener: _resource_record_pre_action 01:21:01 INFO - Running main action method: download_and_extract 01:21:01 INFO - mkdir: /builds/slave/test/build/tests 01:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:01 INFO - https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/test_packages.json 01:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/test_packages.json 01:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:21:09 INFO - Downloaded 1277 bytes. 01:21:09 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:21:09 INFO - Using the following test package requirements: 01:21:09 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:21:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:21:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:21:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'jsshell-mac.zip'], 01:21:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:21:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:21:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:21:09 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:21:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:21:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:21:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:21:09 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:21:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:21: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')]} 01:21:09 INFO - https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:21:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:21:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:21:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:21:14 INFO - Downloaded 17828732 bytes. 01:21:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:21:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:21:17 INFO - Return code: 0 01:21:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:21: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')]} 01:21:17 INFO - https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:21:18 INFO - Downloaded 17828732 bytes. 01:21:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:21:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:21:21 INFO - Return code: 0 01:21: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')]} 01:21:21 INFO - https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:21:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:21:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:21:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:21:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:21:22 INFO - Downloaded 10707015 bytes. 01:21:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:21:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:21:22 INFO - Return code: 0 01:21:22 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')]} 01:21:22 INFO - https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 01:21:25 INFO - Downloaded 111416592 bytes. 01:21:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:21:25 INFO - mkdir: /builds/slave/test/properties 01:21:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:21:25 INFO - Writing to file /builds/slave/test/properties/build_url 01:21:25 INFO - Contents: 01:21:25 INFO - build_url:https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:21:26 INFO - Running post-action listener: _resource_record_post_action 01:21:26 INFO - Running post-action listener: set_extra_try_arguments 01:21:26 INFO - ##### 01:21:26 INFO - ##### Running populate-webroot step. 01:21:26 INFO - ##### 01:21:26 INFO - Running pre-action listener: _resource_record_pre_action 01:21:26 INFO - Running main action method: populate_webroot 01:21:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:21:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:21:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:21:26 INFO - '--tppagecycles', 01:21:26 INFO - '7'], 01:21:26 INFO - 'tests': ['tsvgm']}}, 01:21:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:21:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:21:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:21:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:21:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'tests': ['damp', 'tps']}, 01:21:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['damp', 'tps']}, 01:21:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:21:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:21:26 INFO - 'other': {'tests': ['a11yr', 01:21:26 INFO - 'ts_paint', 01:21:26 INFO - 'tpaint', 01:21:26 INFO - 'sessionrestore', 01:21:26 INFO - 'sessionrestore_no_auto_restore']}, 01:21:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['a11yr', 01:21:26 INFO - 'ts_paint', 01:21:26 INFO - 'tpaint', 01:21:26 INFO - 'sessionrestore', 01:21:26 INFO - 'sessionrestore_no_auto_restore']}, 01:21:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['a11yr', 01:21:26 INFO - 'ts_paint', 01:21:26 INFO - 'tpaint', 01:21:26 INFO - 'sessionrestore', 01:21:26 INFO - 'sessionrestore_no_auto_restore']}, 01:21:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['a11yr', 01:21:26 INFO - 'ts_paint', 01:21:26 INFO - 'tpaint', 01:21:26 INFO - 'sessionrestore', 01:21:26 INFO - 'sessionrestore_no_auto_restore']}, 01:21:26 INFO - 'other_l64': {'tests': ['a11yr', 01:21:26 INFO - 'ts_paint', 01:21:26 INFO - 'tpaint', 01:21:26 INFO - 'sessionrestore', 01:21:26 INFO - 'sessionrestore_no_auto_restore']}, 01:21:26 INFO - 'other_nol64': {'tests': ['a11yr', 01:21:26 INFO - 'ts_paint', 01:21:26 INFO - 'tpaint', 01:21:26 INFO - 'sessionrestore', 01:21:26 INFO - 'sessionrestore_no_auto_restore']}, 01:21:26 INFO - 'svgr': {'tests': ['tsvgx', 01:21:26 INFO - 'tsvgr_opacity', 01:21:26 INFO - 'tart', 01:21:26 INFO - 'tscrollx', 01:21:26 INFO - 'cart']}, 01:21:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['tsvgx', 01:21:26 INFO - 'tsvgr_opacity', 01:21:26 INFO - 'tart', 01:21:26 INFO - 'tscrollx', 01:21:26 INFO - 'cart']}, 01:21:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'tests': ['tp5o']}, 01:21:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'talos_options': ['--e10s'], 01:21:26 INFO - 'tests': ['tp5o']}, 01:21:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'talos_options': ['--xperf_path', 01:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:26 INFO - 'tests': ['tp5n']}, 01:21:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:26 INFO - 'talos_options': ['--e10s', 01:21:26 INFO - '--xperf_path', 01:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:26 INFO - 'tests': ['tp5n']}}, 01:21:26 INFO - 'talos.zip': {'path': '', 01:21:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:21:26 INFO - Running post-action listener: _resource_record_post_action 01:21:26 INFO - ##### 01:21:26 INFO - ##### Running create-virtualenv step. 01:21:26 INFO - ##### 01:21:26 INFO - Running pre-action listener: _resource_record_pre_action 01:21:26 INFO - Running main action method: create_virtualenv 01:21:26 INFO - Creating virtualenv /builds/slave/test/build/venv 01:21:26 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 01:21:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:21:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:21:26 INFO - Using real prefix '/tools/python27' 01:21:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:21:27 INFO - Installing distribute.............................................................................................................................................................................................done. 01:21:30 INFO - Installing pip.................done. 01:21:30 INFO - Return code: 0 01:21:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:30 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:30 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 01:21:30 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 01:21:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:30 INFO - 'HOME': '/Users/cltbld', 01:21:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:30 INFO - 'LOGNAME': 'cltbld', 01:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:30 INFO - 'MOZ_NO_REMOTE': '1', 01:21:30 INFO - 'NO_EM_RESTART': '1', 01:21:30 INFO - 'PAGER': '/bin/cat', 01:21:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:30 INFO - 'PWD': '/builds/slave/test', 01:21:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:30 INFO - 'SHELL': '/bin/bash', 01:21:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:30 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:30 INFO - 'USER': 'cltbld', 01:21:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:30 INFO - 'XPC_FLAGS': '0x0', 01:21:30 INFO - 'XPC_SERVICE_NAME': '0', 01:21:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:30 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 01:21:30 INFO - Cleaning up... 01:21:30 INFO - Return code: 0 01:21:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:30 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:30 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 01:21:30 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 01:21:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:30 INFO - 'HOME': '/Users/cltbld', 01:21:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:30 INFO - 'LOGNAME': 'cltbld', 01:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:30 INFO - 'MOZ_NO_REMOTE': '1', 01:21:30 INFO - 'NO_EM_RESTART': '1', 01:21:30 INFO - 'PAGER': '/bin/cat', 01:21:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:30 INFO - 'PWD': '/builds/slave/test', 01:21:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:30 INFO - 'SHELL': '/bin/bash', 01:21:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:30 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:30 INFO - 'USER': 'cltbld', 01:21:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:30 INFO - 'XPC_FLAGS': '0x0', 01:21:30 INFO - 'XPC_SERVICE_NAME': '0', 01:21:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:31 INFO - Downloading/unpacking psutil>=0.7.1 01:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:31 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 01:21:31 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 01:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:34 INFO - Installing collected packages: psutil 01:21:34 INFO - Running setup.py install for psutil 01:21:34 INFO - building 'psutil._psutil_osx' extension 01:21:34 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 01:21:34 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 01:21:34 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 01:21:34 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 01:21:34 INFO - building 'psutil._psutil_posix' extension 01:21:34 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 01:21:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:21:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:21:34 INFO - ^ 01:21:35 INFO - 1 warning generated. 01:21:35 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 01:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:35 INFO - Successfully installed psutil 01:21:35 INFO - Cleaning up... 01:21:35 INFO - Return code: 0 01:21:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:21: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')]} 01:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21: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')]} 01:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21: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', '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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:21: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 mozsystemmonitor==0.0.0 01:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:35 INFO - 'HOME': '/Users/cltbld', 01:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:35 INFO - 'LOGNAME': 'cltbld', 01:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:35 INFO - 'MOZ_NO_REMOTE': '1', 01:21:35 INFO - 'NO_EM_RESTART': '1', 01:21:35 INFO - 'PAGER': '/bin/cat', 01:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:35 INFO - 'PWD': '/builds/slave/test', 01:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:35 INFO - 'SHELL': '/bin/bash', 01:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:35 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:35 INFO - 'USER': 'cltbld', 01:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:35 INFO - 'XPC_FLAGS': '0x0', 01:21:35 INFO - 'XPC_SERVICE_NAME': '0', 01:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21: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 01:21: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 01:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:21:37 INFO - Installing collected packages: mozsystemmonitor 01:21:37 INFO - Running setup.py install for mozsystemmonitor 01:21:38 INFO - Successfully installed mozsystemmonitor 01:21:38 INFO - Cleaning up... 01:21:38 INFO - Return code: 0 01:21:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:21: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')]} 01:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21: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')]} 01:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:38 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:38 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 01:21:38 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 01:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:38 INFO - 'HOME': '/Users/cltbld', 01:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:38 INFO - 'LOGNAME': 'cltbld', 01:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:38 INFO - 'MOZ_NO_REMOTE': '1', 01:21:38 INFO - 'NO_EM_RESTART': '1', 01:21:38 INFO - 'PAGER': '/bin/cat', 01:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:38 INFO - 'PWD': '/builds/slave/test', 01:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:38 INFO - 'SHELL': '/bin/bash', 01:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:38 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:38 INFO - 'USER': 'cltbld', 01:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:38 INFO - 'XPC_FLAGS': '0x0', 01:21:38 INFO - 'XPC_SERVICE_NAME': '0', 01:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:21:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:21:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:41 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 01:21:41 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 01:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:41 INFO - Downloading docopt-0.6.1.tar.gz 01:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:21:41 INFO - Installing collected packages: blobuploader, requests, docopt 01:21:41 INFO - Running setup.py install for blobuploader 01:21:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:21:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:21:42 INFO - Running setup.py install for requests 01:21:42 INFO - Running setup.py install for docopt 01:21:42 INFO - Successfully installed blobuploader requests docopt 01:21:42 INFO - Cleaning up... 01:21:42 INFO - Return code: 0 01:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:42 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:42 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 01:21:42 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 01:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:42 INFO - 'HOME': '/Users/cltbld', 01:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:42 INFO - 'LOGNAME': 'cltbld', 01:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:42 INFO - 'MOZ_NO_REMOTE': '1', 01:21:42 INFO - 'NO_EM_RESTART': '1', 01:21:42 INFO - 'PAGER': '/bin/cat', 01:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:42 INFO - 'PWD': '/builds/slave/test', 01:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:42 INFO - 'SHELL': '/bin/bash', 01:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:42 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:42 INFO - 'USER': 'cltbld', 01:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:42 INFO - 'XPC_FLAGS': '0x0', 01:21:42 INFO - 'XPC_SERVICE_NAME': '0', 01:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_M8WeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_3wSma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-hf74vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-TJ3Y3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-iZsngc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-51GXMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-dOd7Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Uuu4Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:21:43 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-YcuwKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-j057bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-pL1r0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Qo0Buj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-1v32Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-ScNuoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-xW9WKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-deMJC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:21:44 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-k3aEwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:21:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:21:44 INFO - Running setup.py install for manifestparser 01:21:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:21:45 INFO - Running setup.py install for mozcrash 01:21:45 INFO - Running setup.py install for mozdebug 01:21:45 INFO - Running setup.py install for mozdevice 01:21:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:21:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:21:45 INFO - Running setup.py install for mozfile 01:21:45 INFO - Running setup.py install for mozhttpd 01:21:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:21:45 INFO - Running setup.py install for mozinfo 01:21:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:21:45 INFO - Running setup.py install for mozInstall 01:21:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Running setup.py install for mozleak 01:21:46 INFO - Running setup.py install for mozlog 01:21:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Running setup.py install for moznetwork 01:21:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Running setup.py install for mozprocess 01:21:46 INFO - Running setup.py install for mozprofile 01:21:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:21:46 INFO - Running setup.py install for mozrunner 01:21:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:21:47 INFO - Running setup.py install for mozscreenshot 01:21:47 INFO - Running setup.py install for moztest 01:21:47 INFO - Running setup.py install for mozversion 01:21:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:21:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:21:47 INFO - Cleaning up... 01:21:47 INFO - Return code: 0 01:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:47 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')]} 01:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:47 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')]} 01:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:47 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:47 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 01:21:47 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 01:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:47 INFO - 'HOME': '/Users/cltbld', 01:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:47 INFO - 'LOGNAME': 'cltbld', 01:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:47 INFO - 'MOZ_NO_REMOTE': '1', 01:21:47 INFO - 'NO_EM_RESTART': '1', 01:21:47 INFO - 'PAGER': '/bin/cat', 01:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:47 INFO - 'PWD': '/builds/slave/test', 01:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:47 INFO - 'SHELL': '/bin/bash', 01:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:47 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:47 INFO - 'USER': 'cltbld', 01:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:47 INFO - 'XPC_FLAGS': '0x0', 01:21:47 INFO - 'XPC_SERVICE_NAME': '0', 01:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:21:47 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-lwRjmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:21:47 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)) 01:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:21:47 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-0QDCR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 01:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:21:47 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-rnTnSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-hcejbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-vlg1St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-XoS3Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-iHEbXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-3AWXAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-2h3kuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-P0ZvKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-OLdN8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:21:48 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)) 01:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:21:48 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-jH1WPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:21:49 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)) 01:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:21:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-cu2zf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:21:49 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)) 01:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:21:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-C5QhZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:21:49 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)) 01:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-87ivct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:49 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)) 01:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:21:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-wsqgcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:21:49 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)) 01:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:21:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-BryCC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:21:49 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)) 01:21:49 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:21:49 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:21:49 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)) 01:21:49 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)) 01:21:49 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)) 01:21:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:21:49 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 01:21:49 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 01:21:49 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 01:21:49 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 01:21:49 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 01:21:49 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 01:21:51 INFO - Downloading blessings-1.6.tar.gz 01:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:21:51 INFO - Installing collected packages: blessings 01:21:51 INFO - Running setup.py install for blessings 01:21:52 INFO - Successfully installed blessings 01:21:52 INFO - Cleaning up... 01:21:52 INFO - Return code: 0 01:21:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:21:52 INFO - Reading from file tmpfile_stdout 01:21:52 INFO - Current package versions: 01:21:52 INFO - blessings == 1.6 01:21:52 INFO - blobuploader == 1.2.4 01:21:52 INFO - docopt == 0.6.1 01:21:52 INFO - manifestparser == 1.1 01:21:52 INFO - mozInstall == 1.12 01:21:52 INFO - mozcrash == 0.16 01:21:52 INFO - mozdebug == 0.1 01:21:52 INFO - mozdevice == 0.48 01:21:52 INFO - mozfile == 1.2 01:21:52 INFO - mozhttpd == 0.7 01:21:52 INFO - mozinfo == 0.9 01:21:52 INFO - mozleak == 0.1 01:21:52 INFO - mozlog == 3.1 01:21:52 INFO - moznetwork == 0.27 01:21:52 INFO - mozprocess == 0.22 01:21:52 INFO - mozprofile == 0.28 01:21:52 INFO - mozrunner == 6.11 01:21:52 INFO - mozscreenshot == 0.1 01:21:52 INFO - mozsystemmonitor == 0.0 01:21:52 INFO - moztest == 0.7 01:21:52 INFO - mozversion == 1.4 01:21:52 INFO - psutil == 3.1.1 01:21:52 INFO - requests == 1.2.3 01:21:52 INFO - wsgiref == 0.1.2 01:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:52 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')]} 01:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:52 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')]} 01:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:52 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:52 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 01:21:52 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 01:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:52 INFO - 'HOME': '/Users/cltbld', 01:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:52 INFO - 'LOGNAME': 'cltbld', 01:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:52 INFO - 'MOZ_NO_REMOTE': '1', 01:21:52 INFO - 'NO_EM_RESTART': '1', 01:21:52 INFO - 'PAGER': '/bin/cat', 01:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:52 INFO - 'PWD': '/builds/slave/test', 01:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:52 INFO - 'SHELL': '/bin/bash', 01:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:52 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:52 INFO - 'USER': 'cltbld', 01:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:52 INFO - 'XPC_FLAGS': '0x0', 01:21:52 INFO - 'XPC_SERVICE_NAME': '0', 01:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 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)) 01:21:52 INFO - Cleaning up... 01:21:52 INFO - Return code: 0 01:21:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:21:52 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')]} 01:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:52 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')]} 01:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:52 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:52 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 01:21:52 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 01:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:52 INFO - 'HOME': '/Users/cltbld', 01:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:52 INFO - 'LOGNAME': 'cltbld', 01:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:52 INFO - 'MOZ_NO_REMOTE': '1', 01:21:52 INFO - 'NO_EM_RESTART': '1', 01:21:52 INFO - 'PAGER': '/bin/cat', 01:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:52 INFO - 'PWD': '/builds/slave/test', 01:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:52 INFO - 'SHELL': '/bin/bash', 01:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:52 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:52 INFO - 'USER': 'cltbld', 01:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:52 INFO - 'XPC_FLAGS': '0x0', 01:21:52 INFO - 'XPC_SERVICE_NAME': '0', 01:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:53 INFO - Downloading/unpacking jsonschema 01:21:53 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 01:21:53 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 01:21:53 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 01:21:53 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 01:21:53 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 01:21:53 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 01:21:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:21:55 INFO - Downloading/unpacking functools32 (from jsonschema) 01:21:55 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 01:21:55 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 01:21:55 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 01:21:55 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 01:21:55 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 01:21:55 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 01:21:55 INFO - Downloading functools32-3.2.3-2.tar.gz 01:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:21:55 INFO - warning: no files found matching '*.txt' 01:21:55 INFO - no previously-included directories found matching 'build' 01:21:55 INFO - no previously-included directories found matching 'dist' 01:21:55 INFO - no previously-included directories found matching '.git*' 01:21:55 INFO - Installing collected packages: jsonschema, functools32 01:21:55 INFO - Running setup.py install for functools32 01:21:56 INFO - warning: no files found matching '*.txt' 01:21:56 INFO - no previously-included directories found matching 'build' 01:21:56 INFO - no previously-included directories found matching 'dist' 01:21:56 INFO - no previously-included directories found matching '.git*' 01:21:56 INFO - Successfully installed jsonschema functools32 01:21:56 INFO - Cleaning up... 01:21:56 INFO - Return code: 0 01:21:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:56 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 0x109719a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed14aa460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, '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.5VdEWymbkh/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.toeJa18Bq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:21:56 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 01:21:56 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 01:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:56 INFO - 'HOME': '/Users/cltbld', 01:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:56 INFO - 'LOGNAME': 'cltbld', 01:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:56 INFO - 'MOZ_NO_REMOTE': '1', 01:21:56 INFO - 'NO_EM_RESTART': '1', 01:21:56 INFO - 'PAGER': '/bin/cat', 01:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:56 INFO - 'PWD': '/builds/slave/test', 01:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:56 INFO - 'SHELL': '/bin/bash', 01:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:21:56 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:56 INFO - 'USER': 'cltbld', 01:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:56 INFO - 'XPC_FLAGS': '0x0', 01:21:56 INFO - 'XPC_SERVICE_NAME': '0', 01:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:56 INFO - Downloading/unpacking flake8 01:21:56 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 01:21:56 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 01:21:56 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 01:21:56 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 01:21:56 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 01:21:56 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 01:21:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:21:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:21:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:21:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 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 01:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:21:59 INFO - no previously-included directories found matching 'docs/_build' 01:21:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:22:00 INFO - Running setup.py install for pep8 01:22:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:22:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:22:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:22:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:22:00 INFO - no previously-included directories found matching 'docs/_build' 01:22:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:22:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:22:00 INFO - Cleaning up... 01:22:00 INFO - Return code: 0 01:22:00 INFO - Running post-action listener: _resource_record_post_action 01:22:00 INFO - Running post-action listener: _start_resource_monitoring 01:22:00 INFO - Starting resource monitoring. 01:22:00 INFO - ##### 01:22:00 INFO - ##### Running install step. 01:22:00 INFO - ##### 01:22:00 INFO - Running pre-action listener: _resource_record_pre_action 01:22:00 INFO - Running main action method: install 01:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:22:00 INFO - Reading from file tmpfile_stdout 01:22:00 INFO - Detecting whether we're running mozinstall >=1.0... 01:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:22:00 INFO - Reading from file tmpfile_stdout 01:22:00 INFO - Output received: 01:22:00 INFO - Usage: mozinstall [options] installer 01:22:00 INFO - Options: 01:22:00 INFO - -h, --help show this help message and exit 01:22:00 INFO - -d DEST, --destination=DEST 01:22:00 INFO - Directory to install application into. [default: 01:22:00 INFO - "/builds/slave/test"] 01:22:00 INFO - --app=APP Application being installed. [default: firefox] 01:22:00 INFO - mkdir: /builds/slave/test/build/application 01:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:22:34 INFO - Reading from file tmpfile_stdout 01:22:34 INFO - Output received: 01:22:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:22:34 INFO - Running post-action listener: _resource_record_post_action 01:22:34 INFO - ##### 01:22:34 INFO - ##### Running run-tests step. 01:22:34 INFO - ##### 01:22:34 INFO - Running pre-action listener: _resource_record_pre_action 01:22:34 INFO - Running main action method: run_tests 01:22:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:22:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:22:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:22:34 INFO - 2016-02-25 01:22:34.414 screenresolution[2949:36504] starting screenresolution argv=screenresolution get 01:22:34 INFO - 2016-02-25 01:22:34.416 screenresolution[2949:36504] Display 0: 1600x1200x32@60 01:22:34 INFO - 2016-02-25 01:22:34.422 screenresolution[2950:36506] starting screenresolution argv=screenresolution list 01:22:34 INFO - Available Modes on Display 0 01:22:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:22:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:22:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:22:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:22:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:22:34 INFO - Intel Iris: 01:22:34 INFO - Chipset Model: Intel Iris 01:22:34 INFO - Type: GPU 01:22:34 INFO - Bus: Built-In 01:22:34 INFO - VRAM (Dynamic, Max): 1536 MB 01:22:34 INFO - Vendor: Intel (0x8086) 01:22:34 INFO - Device ID: 0x0a2e 01:22:34 INFO - Revision ID: 0x0009 01:22:34 INFO - Displays: 01:22:34 INFO - Display: 01:22:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:22:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:22:34 INFO - Display Serial Number: 1600x1200 60 01:22:34 INFO - Main Display: Yes 01:22:34 INFO - Mirror: Off 01:22:34 INFO - Online: Yes 01:22:34 INFO - Rotation: Supported 01:22:34 INFO - Return code: 0 01:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:22:34 INFO - Python 2.7.3 01:22:34 INFO - Return code: 0 01:22:34 INFO - grabbing minidump binary from tooltool 01:22:34 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')]} 01:22:34 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 0x1095bdd30>, '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 0x1093e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095b4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:22:34 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 01:22:34 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 01:22:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:22:34 INFO - Return code: 0 01:22:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:22:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:22:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:22:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:22:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:22:35 INFO - Return code: 0 01:22:35 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/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 01:22:35 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/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --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 01:22:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5VdEWymbkh/Render', 01:22:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:22:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:22:35 INFO - 'HOME': '/Users/cltbld', 01:22:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:22:35 INFO - 'LOGNAME': 'cltbld', 01:22:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:22:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:35 INFO - 'MOZ_NO_REMOTE': '1', 01:22:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:22:35 INFO - 'NO_EM_RESTART': '1', 01:22:35 INFO - 'PAGER': '/bin/cat', 01:22:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:35 INFO - 'PWD': '/builds/slave/test', 01:22:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:22:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:22:35 INFO - 'SHELL': '/bin/bash', 01:22:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.toeJa18Bq3/Listeners', 01:22:35 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:22:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:22:35 INFO - 'USER': 'cltbld', 01:22:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:22:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:35 INFO - 'XPC_FLAGS': '0x0', 01:22:35 INFO - 'XPC_SERVICE_NAME': '0', 01:22:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:22:35 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/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 01:22:36 INFO - mozversion application_buildid: 20160225001026 01:22:36 INFO - mozversion application_changeset: 5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2 01:22:36 INFO - mozversion application_display_name: Nightly 01:22:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:22:36 INFO - mozversion application_name: Firefox 01:22:36 INFO - mozversion application_remotingname: firefox 01:22:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:22:36 INFO - mozversion application_vendor: Mozilla 01:22:36 INFO - mozversion application_version: 47.0a1 01:22:36 INFO - mozversion platform_buildid: 20160225001026 01:22:36 INFO - mozversion platform_changeset: 5b53d1dcb00952e51a7f298c9b7cd77b7634e9d2 01:22:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:22:36 INFO - mozversion platform_version: 47.0a1 01:22:36 INFO - using testdate: 1456392156 01:22:36 INFO - actual date: 1456392156 01:22:36 INFO - starting webserver on 'localhost:59884' 01:22:36 INFO - SUITE-START | Running 2 tests 01:22:36 INFO - TEST-START | dromaeo_css 01:22:36 INFO - operating with platform_type : mac_ 01:22:36 INFO - Initialising browser for dromaeo_css test... 01:22:36 INFO - TEST-INFO | started process 2968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpxAY2Jq/profile http://localhost:59884/getInfo.html) 01:22:39 INFO - PROCESS | 2968 | __metrics Screen width/height:1600/1200 01:22:39 INFO - PROCESS | 2968 | colorDepth:24 01:22:39 INFO - PROCESS | 2968 | Browser inner width/height: 1024/689 01:22:39 INFO - PROCESS | 2968 | __metrics 01:22:39 ERROR - PROCESS | 2968 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:22:40 INFO - TEST-INFO | 2968: exit 0 01:22:40 INFO - Browser initialized. 01:22:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:22:40 INFO - TEST-INFO | started process 2972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpxAY2Jq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:52 INFO - PROCESS | 2972 | RSS: Main: 255954944 01:22:52 INFO - PROCESS | 2972 | 01:23:41 INFO - PROCESS | 2972 | 1456392221973 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] 01:25:52 INFO - PROCESS | 2972 | Cycle 1(1): loaded http://localhost:59884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59884/tests/dromaeo/cssquery-ext.html) 01:25:53 INFO - PROCESS | 2972 | RSS: Main: 268025856 01:25:53 INFO - PROCESS | 2972 | 01:28:55 INFO - PROCESS | 2972 | Cycle 1(1): loaded http://localhost:59884/tests/dromaeo/cssquery-ext.html (next: http://localhost:59884/tests/dromaeo/cssquery-jquery.html) 01:28:56 INFO - PROCESS | 2972 | RSS: Main: 279937024 01:28:56 INFO - PROCESS | 2972 | 01:31:58 INFO - PROCESS | 2972 | Cycle 1(1): loaded http://localhost:59884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59884/tests/dromaeo/cssquery-mootools.html) 01:31:58 INFO - PROCESS | 2972 | RSS: Main: 281989120 01:31:58 INFO - PROCESS | 2972 | 01:35:00 INFO - PROCESS | 2972 | Cycle 1(1): loaded http://localhost:59884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59884/tests/dromaeo/cssquery-prototype.html) 01:35:01 INFO - PROCESS | 2972 | RSS: Main: 283897856 01:35:01 INFO - PROCESS | 2972 | 01:38:03 INFO - PROCESS | 2972 | Cycle 1(1): loaded http://localhost:59884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59884/tests/dromaeo/cssquery-yui.html) 01:38:04 INFO - PROCESS | 2972 | RSS: Main: 286011392 01:38:04 INFO - PROCESS | 2972 | 01:41:06 INFO - PROCESS | 2972 | Cycle 1(1): loaded http://localhost:59884/tests/dromaeo/cssquery-yui.html (next: http://localhost:59884/tests/dromaeo/cssquery-dojo.html) 01:41:07 INFO - PROCESS | 2972 | RSS: Main: 287776768 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | __start_tp_report 01:41:07 INFO - PROCESS | 2972 | _x_x_mozilla_page_load 01:41:07 INFO - PROCESS | 2972 | _x_x_mozilla_page_load_details 01:41:07 INFO - PROCESS | 2972 | |i|pagename|runs| 01:41:07 INFO - PROCESS | 2972 | |0;dojo.html;2908.6800451950294;3463.238087620724;3496.930061398772;3540.079579309379;3541.822908854557;4273.871783846485;5660.60375773696;5675.063614503607;5686.175504551838;5693.829185124453;5430.212619170218;5695.77216911323;5753.597248192628;5784.884302313962;5786.884262314751;5141.511556402136;5205.479452054802;5225.320708307915;5238.685678859261;5283.260343551906;5228.816991405301;5305.575553955674;5312.946870531303;5352.2239275305055;5364.91952620711;5136.537711605936;5195.636305458619;5225.137852254374;5240.580753539746;5247.606429517801;4657.860513321324;4929.482404347564;5153.2270159476375;5199.402068762103;5205.063088644042;5140.485951404867;5178.197379406198;5197.142471492237;5198.714070726109;5227.686338819645;5444.891102177934;5514.3658479275;5560.332760068777;5563.471470210324;5580.553555715533;6009.879802403927;6143.78496752616;6185.783497577563;6218.160548326008;6263.903816832036;6138.480361557102;6143.726821076186;6155.92271352516;6170.259568851721;6242.469390101847;5593.468620481048;5776.942230577724;5779.624324418899;5790.363060063348;5795.623284486495;6264;6264.279607845065;6297.590656607306;6300.054991751274;6306.936930630727;5420.4850539198715;5968.641881487125;6089.817305480843;6107.816765497042;6137.723802428902;6233.34549872266;6234;6237.937620623736;6247.156633854463;6269;6001.279846418458;6114.692773002257;6164.938350616526;6198.163247961467;6225.097360882647;6157.692115394212;6161.507079433634;6183.319834818257;6200.56596038273;6221.875562488815;4842.104210721028;4853.790129467558;4870.09903167915;4882.145624515695;4887.120318342732;4287.206866729665;4331.112122014979;4364.279893817548;4387.341898715218;4436.44544431946;5697.800576979786;5753.942460575425;5762.423757624288;5777.595568310178;5812.128180772918;6109.236345456818;6225.439710426083;6253.093301471261;6256;6281.842953926189;5752.741126649311;5758.424157584208;5782.942170578241;5809.564282678816;5836.766529338779;5320.361556613231;5326.733663316896;5343.145096784496;5350.9732451337495;5371.301730775052;5214.348206474191;6249.375062493714;6252.906206406908;6279.686015699197;6295.811125666238;6106.794380079809;6198.2871969722255;6208.037754148114;6266.968665156645;6323.747050117944;4958.404991401055;5136.7945282189785;6253.593516421418;6288.905666415099;6332.366763323631;6061.575689701678;6115.483736156635;6161.537884658579;6178.258608966773;6225.066240064027;6127.969360153171;6219.689015549114;6229.408206220402;6287.402696743802;6323.241211054519;5179.741012949262;5935.821925342247;6102.420270074514;6118.479929206067;6146.6004709693725;4848.321235027029;6049.818505444844;6066.059760737093;6091.360407157362;6168.814935551761;5309.150535914235;5815.9709201453725;5892.086726557391;5912.438318359749;5921.5558833086825;6002.189704390026;6041.516678665784;6082.330943596289;6097.939020609737;6098.329183789869;5896.49879760208;5903.586748927534;5931.792387266425;5933.851653708519;5946.43508866657 01:41:07 INFO - PROCESS | 2972 | |1;ext.html;455.7721139430283;485.91253574356625;493.5360760884768;555.0480925213259;594.3610618585022;29897;37876.86369408915;38015;38196.23607527851;38210.426843597335;38998.805005975;39367.62213322534;39427.605723942754;39449.60550394495;39630;9404.952975235132;9573.473458959754;9580.904190958106;9584.568694408768;9608.951955240214;9434.716958491255;9713.61145554177;9719.416834989888;9720.90279097207;9733.853992190123;9665.855012174823;9747.025297470233;9766.072223138826;9785.853212201822;9792.755181120494;9706.320557560974;9740;9765;9770.071843174923;9774.5601447935;9607.183389411908;9729.124378805871;9745.02549745027;9753.658621948269;9770.218382529381;38531.807340963394;38714.03214919622;38844;38943;39000;2999.6250468691414;3019.607451031352;3195.7603179761377;3237.8219197944104;3649.799261040642;28679.85660071707;28947.85526072356;28966.13101606955;29084.854575726986;29420.411591768046;2750.614913912054;2850.985745071282;2886.480433521965;2891.2482754483776;2982.2991596974693;488050;491463;492371;493240;494130.52934735455;41856;42717;64484.71030579456;65289;65563.34436655667;37843.4323485148;45252;45565.77217113893;45642.77178614086;45864.3120353195;15623.3750649975;15702.9214853925;15711.607209819846;15817.260101388838;15868.682626347409;12362.505499779909;12551.497940082294;12615.053870959715;12707.2375657459;12721.809172862415;14565.854341456661;14633.560993170222;14708.970372073853;14752.114873107648;14754.336054877556;6158.753649853956;6275.466585340206;6311.936880631135;6319.8104056878365;6365.2998170201245;889.9332550058772;911.444019148319;1032.7779527401644;1128.1626708827305;1142.457332766929;25721.356966075622;30070.79716811347;31052.378952421277;31057.844710776302;31911.202219944687;967.690339091484;988.6440881282732;1017.6539976408056;1060.6287799270349;1213.787587172259;13657.039513344573;14051;14690.63273418173;14712.264386780618;15446.30491627857;379828;511921;513858.4307078441;519140;521974;56487.43512564904;57061.85876282451;57135.714321428124;57323;60073;1427.1793718611839;1429.3853642933639;1449.8187726534184;1465.8094447721728;1468.809054822845;23495.765042349358;29721.70278297276;30512.806488023518;31059.068227953197;31166.065018049496;52622.21066683926;53115;53798.96507761855;53984.73007634937;54304.72847635736;445884;493834;494282;494557;496404;36883.446748299335;43657.781711091244;44779.552204477535;44922.550774491836;45265.32102018406;46014;46377.072458551316;46953;47019.529804702885;47456.288155677;37330.813345934184;38262.42606360851;39243.80378098205;39299;39460.802695986335;37630.62369376271;38195;38198;38308.80845595754;38748.031299216615;34572.654273456945;34613.48079778856;36165.276694465436;36326.455103174005;36469.45295820512;24097.879510602335;32210.19474513156;32286.031419057465;33513;34264.657353427145;19767.209311627375;22488.550228995657;25503.248535414023;25573.3606659835;25615.615765763156 01:41:07 INFO - PROCESS | 2972 | |2;jquery.html;359.3657195050734;360.42152345485493;362.217609962481;363.9090227443139;367.5222211125536;15203.54389368318;15490.61273468161;19057.23771049158;19129.61740765184;20052.897090660026;14956.32696528656;16641.167941602933;18698.626027479444;18910.338138165167;19053.3331333403;4777.570018698317;5468.699221542814;5716.628419152763;5773.076307790754;5797.71011449428;4999.200127979524;5751.597388182829;5757.942420575782;5772.307323121231;5818.447247511501;5426.647267927572;5662.17898404731;5699;5754.913676294859;5776;4824.855254342376;5621.8594535136535;5671.234383358255;5673.574481913853;5819.6508209507565;5560.4161563035705;5627.887442251173;5639.802606908779;5640.464155905182;5652.293463317085;12143.664196938329;12410.751784964341;15658;24498.877505612538;24541.87729061361;1930.44982180078;1973.4967583266175;2095.528506086134;2111.915523379063;2752.7199852068684;9588.232941364675;9992;10613.991670791262;10882.61910833125;14516.854831451761;1701.6001239708658;1716.2963185094052;1779.3149637389697;1788.7853457585172;1796.5378701453249;95843.56234656485;99799;100877.45174015427;101043;101247.49376253145;9564.521773911276;10674.679759607225;10922.29005114665;10953.726156846142;11017.614383496539;11974.820377694341;12606.180598261268;12998.960083193322;13174.802377964339;13175.407106680223;8109.107998120202;8279;8361.289290410383;8424.15758424165;8447.873281900776;8379.497230166087;8502.404831661725;8558.272546833588;8574.185452382013;8624.266937310273;4329.1341731653165;4400.361947517592;4411.382406463098;4423.424954755861;4487.371767952489;1848.334599544163;1878.1923772777563;1897.1976622208956;1930.224193741761;1935.380678182996;902.2376092202079;986.8421052631544;988.5353883674661;1003.1623594298696;1036.512838965685;16832;18980.43058708241;19021;19451.708224376645;19666.90166549158;893.3166127912023;916.9679061232824;930.930180236485;942.4580866002076;974.4543055888724;9698.175655069257;10180.694579162637;10596.258261921746;11442.485088171052;11448.656540303804;438015;493348;629735;637405;650579;66153;84483.5775821117;97984.51007744916;106453.9354606444;107609.38585921217;1011.1556850030161;1052.9631462898762;1060.7030031591012;1061.0662616897234;1061.3048453263125;12163.635090947286;13608.387622557208;17589.329013743674;17662.735058974384;17998.01010944358;31856.840715796272;40612.59387406088;44690.3296450547;46593.06813863772;56644.43355566391;63502.68248658912;63620;63768.3623163781;63915.68042159759;64926.02610960934;6740.561863478858;7834.960825195838;8029.919700803151;8229.382796290183;8251.422400432153;11303.717407064889;13285.734285314433;13418.261995590336;13454.730905382034;13455.529056482976;10733.302335348177;11123.388213648326;11285.887141128813;11412.942935285271;11594.94202528982;9898.406095634286;10597.046265836112;10710.303830251009;11432.771344572895;11716.414179291172;10427.800802907763;11606.129540284344;11689.707757306136;11758.82361764557;11955.64133076009;7253.347198752138;7346.265373462611;8149.185081491803;8302.833943320979;8336.541490218096;10879.891201087888;11345.319280843176;11450.312981221154;11488.770224595628;11494.885051149382 01:41:07 INFO - PROCESS | 2972 | |3;mootools.html;1524.3750062474387;1540.7919930809342;1760.9119544022797;1887.471507977765;1888.5467487802914;7822.843543129148;8417.494950302986;8688.522131282776;8785.648574057039;8845.336599755012;8620.396572239946;8675.089115642846;8740.257078148365;8753.474791512497;8790.51652159131;2223.566404551113;2424.054618698709;2432.185217951979;2435.0138194031356;2461.052494789501;2413.734489206186;2430.9027638894513;2460.507898420314;2467.111839737693;2469.493753780471;1975.4764987278384;2151.3868547463976;2434.8417352872093;2440.170342083691;2450.3996520852415;2346.8709220992837;2383.5232953409386;2389.7968672662846;2394.6527753475734;2399.076355603088;2349.89425475854;2403.735589085199;2418.8669623170717;2418.8790560471907;2423.587990041697;8710.12898710124;8758.2993360531;8766.693165739232;8767.868481972775;8828.8675669865;4468.977655111737;5308.256844041837;5352.143657014859;5363.436839131913;5396.514313711785;3514.947275790865;3535.398982173011;3606.5131207286945;3615.566132064143;3618.6019537850816;1035.8808736995268;1046.597060131847;1054.562356622001;1057.5822550092748;1069.6202847989007;11801;11961.40192990347;11990.980766634759;12012.339321337324;12032.278063316317;3727.086863718352;4866.562009419098;4945.159322915113;4956.925646115311;4989.276554899519;8428.283595894418;10156.898431015596;10176.931422200561;10186.949065254774;10240.283180177465;4606.8157273708675;5382.30030096085;5424.728763561806;5472.98749731301;5510.669359838423;4910.238912968495;4965.776540055706;4975.502449754996;4984.4267909190185;4997.675151115166;3993.980030099831;4010.2781499329817;4039.818208180639;4048.736832105904;4050.210209009215;1318.604418674413;1319.7888337865895;1323.5499930023839;1340.7787715027107;1346.1451977994045;1019.7348689340677;1106.734383747911;1130.084631448513;1230.969225769363;1328.8338957630297;7878.212178782191;7916.920830791733;8009.799755006172;8014.19858014194;8015.679372825139;1175.0305997552055;1177.8409914661581;1178.6522975722182;1187.6377704800118;1190.833283340333;6168.290646575701;6202.503799696104;6228.937710622927;6231.065340199007;6247.187865577536;10388.48057597117;10560.788784224273;10585.259031867696;10682.62610808618;10754.569817207224;10143.7464063399;10509.789804203872;10534.157267418588;10546.05085542305;10574.788504229873;7803.414743894345;8050.476719013245;8153.062397824207;8244.54654993981;8292.212239837327;7836.686532538863;7920.603969801602;8002.799930001796;8051.879221811795;8053.154418785943;9333.953330233306;9522.571484283362;9586.233101352014;9612.855807162758;9630.807383852423;9468.479233642216;9751.756206094904;9775.706728798148;9927.702168934944;10007.54966026516;7416.4066874648815;7438.851222975619;7500.249975002675;7541;7556.58438785872;8014.637511622922;8087.555184464911;8111.269985701315;8124.878126828221;8152.103268640326;6718.596884186964;7174.2108368078425;7348.52234604749;7393.1497877742595;7487.401007919245;6638.20341559016;7152.678129484081;7208.56748595065;7242.529235599669;7258.927410725825;7549.471536992358;7586.810329741801;7600.885986710315;7621.695132194872;7663.808404789925;6909.412699920362;6944.201416836926;6944.965275173592;6960.199577048705;6961.408280296231;6968.0941477607585;7053.0478385419365;7059.647017648994;7061.1173603299585;7099.432045436456 01:41:07 INFO - PROCESS | 2972 | |4;prototype.html;323.8817831491506;329.60776675755847;330.4465021089674;335.6274535265855;337.9932401351975;6792.7773000859825;6954.826129346762;6982.476314276424;6997.440204783617;7005.929940700591;6965.756198533052;6969.1637003559645;7000.754973575926;7002.96498517508;7021.9648901755545;3947.368421052632;5112.463191364909;5124.6668966517245;5142.280080788692;5165.251038599401;5113.923291150636;5130.769115389798;5133.974330128362;5137.537621614054;5140.8714782130555;5049.318342023835;5066.240063990394;5066.746662666852;5069.087564238435;5092.439831618538;3734.7759134451885;5001;5026.145555255615;5078.238264260353;5081.441041485434;4177.415161877339;4195.91608167835;4201.7268877523165;4207.579242075799;4223.408722778782;6463;6608.107905432753;6628.602283862983;6635.43598794103;6661.63361015144;5859.501942334907;5876.353601103875;5893.5579831512805;5903.409659034105;5946.286445626509;5969.671668058255;7427.25727427253;7454.4409169311975;7455.589942553157;7514.286142816423;4668.883277918046;4675.602573781232;4686.367340409035;4699.201135806921;4711.670183087185;7868;7903.565303908283;7909.169537198569;7924.960375198087;7929.207079292082;4479.3057076153245;4567.680262381601;4626.236670949323;4737.0052289019;4737.099951009297;3828.8468461261796;4753.762311884392;4796.632959606495;4799.112164249625;4814.711117332971;4660.813567457331;4672.953270467252;5814.447627475383;5822.097574875901;5862.14998825168;7347.70609175627;7350.816229594303;7360.77917662471;7365.52124111931;7406.370458510979;1461.2547600723708;1661.1694152923537;1686.2833295849216;1689.2736123467027;1689.7549855270918;887.5163036145316;1035.3839465518004;1065.8401239813934;1078.8381742738652;1093.1145771924766;5670.432956704297;5736.713164341766;6965.860682786316;6992.405645520188;7017.2631873652535;7703.075630924212;7715.267049630276;7740.961295193488;7753.767386978399;7769.9409656441085;6971.6165610891885;6987.89518157228;6989.965050174716;6991.36449046493;7030.859382812418;3954.762714237155;4032.1330913853076;4089.8773036808943;4089.8977525561504;4119.9176016480105;8029.116797152308;8047.396445266629;8050.396220283502;8078.3133433658795;8169.305609023299;6538.248101468297;8033.357331413473;8060.314873235723;8075.717349892726;8115.147909469539;8093.312068474245;8104.797380065545;8107.797305067421;8127.1060183378595;8130.715424960098;7534.0481019993595;7719.768406947801;7819.257170568787;7829;7844.725434609762;7605.201453847488;7639.312461878458;7670.846583068419;7671.347935425551;7671.731489397845;8001.959990200245;8087;8104.27061564462;8118.2693557580105;8138.959305203436;4716.056788642217;4795.20879054966;4806.423229212517;4811.639127065554;4826.613870890391;7455;7485.219963918186;7616.771496855104;7747.2640099190485;7790.220977902164;7510.699572017058;7519.323260906544;7534.0582427196605;7534.623268836426;7571.734989275349;7505.324520793155;7508.0990281166605;7525.473216874985;7531.3598344141365;7535.246475352421;6290.77329920661;6450.032495125581;7115.324044215791;7313.414926805949;7336.633168341668;6047.879042419215;6766.594004359754;7500.662470188964;7531.698732050657;7549.698012079675;7258.165310989304;7275.417966562556;7311.086114235721;7326;7327.120745510573 01:41:07 INFO - PROCESS | 2972 | |5;yui.html;634.305435548075;660.933906609339;691.7233106757293;708.3766285668611;732.9450291228158;14779.556613301591;14955.327010284536;14956.626084347898;15052.247387630616;15088.622784430394;13464.596062118128;13564.914806815455;13584.592462226125;13599.252041137759;13599.38802753876;701.1270967645289;848.1306660672798;862.396322574199;879.1033146190881;883.4655033704613;863.2446609216935;863.5725315968605;870.6386849457499;872.9825403491926;873.9126087391273;905.597009330848;920.0845159066738;920.6593560382635;922.2437601167046;924.0113079005467;844.2907957315884;875.7826620996819;902.7111324376202;909.8316811389914;914.9359544831865;596.2814808156205;621.4127649371346;688.3563867783638;688.5834070387393;689.3210187964901;12753.10728249023;13584.932075339659;14427.278636068155;14435;14539.273036348246;12729.681757956032;12760.170588911784;12924.806127908088;13108.147970381895;13383.531576394877;10179.287449878511;10278.33190842593;10349.844752328721;10364.170866330676;10410.895891041144;2964.392299578581;3485.9477107843404;3563.233904710474;3606.729495287838;3720.6651401374006;62056.207470663925;68721.31278687199;76620.5476590706;85066.14933850644;86730;7711.614419279013;7860.66368717308;9440.29197810167;9567.138957493858;9632.662856800118;16598.834011659972;20880.582388352148;21015.474613134793;21057.578848422945;21091.8945405272;7447.776566703008;7452.366548843409;7501.887471687929;7689.807754806063;7943.364530837519;4081.2449696806184;4178.8537401190815;4185.246655602021;4195.139996300751;4358.738475691469;3455.775374600643;3485.3029394121277;3489.092835862694;3493.4235851084795;3517.3492903812366;628.9371062893674;637.8501052252717;638.9840253993688;662.6454846657111;663.1180529895228;513.599392473871;545.6262460214765;618.3877960818756;627.1658693937053;628.7830698409042;8100.149484304181;8472.74581762548;8542.231199192103;8642;8690.91309086901;523.9738013099329;538.5099559401004;551.3411473289461;618.8731310081422;621.7481919822479;3699.4080947048883;4001.15975645112;4010.979945100256;4036.5357983832237;4062.207869465485;85826.14173858182;86345;87301.5634921834;87441.5627921869;87864.5606771962;71539;74579.62710186523;75017;75229;77083.61458192785;67211.31971700648;68050;68703.65648171827;68986.65506672434;71879.56240875153;8737.956310218407;8738;8787.912120878966;8862.822743545223;9025.458472491671;51638.74180629073;52076.47923520868;52215.21677174921;52956;52991;66006;67572.662136689;69060.96408553976;69153.65423172852;69826;10728.249022568345;10914.508847102059;10927.125829933428;11023.724406889893;11043.944780276048;9478.289128315542;11876.465559049691;11937.582184623496;12110.576129835414;12592.370381480707;11154.55381784752;11224.214304998572;11511.30932144074;11757.412129393668;11799.17405781587;9303.302252331237;9648.903510965081;11648;11741.530338786353;11848.763024739284;10459.424731639832;10973.83539246896;11108.555657773599;11350.148738844784;11532.88467115318;9207.907920920972;9320.161185493338;9502.572384242587;9743.123118919331;9776.169025632616;9748.463834489172;9815.803683926139;9970.950145249228;10000.899990999997;10049.346792458467 01:41:07 INFO - PROCESS | 2972 | __end_tp_report 01:41:07 INFO - PROCESS | 2972 | __start_cc_report 01:41:07 INFO - PROCESS | 2972 | _x_x_mozilla_cycle_collect,347 01:41:07 INFO - PROCESS | 2972 | __end_cc_report 01:41:07 INFO - PROCESS | 2972 | __startTimestamp1456393267066__endTimestamp 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | ------- Summary: start ------- 01:41:07 INFO - PROCESS | 2972 | Number of tests: 6 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | [#0] dojo.html Cycles:165 Average:5671.37 Median:5836.77 stddev:651.78 (11.2%) stddev-sans-first:616.69 01:41:07 INFO - PROCESS | 2972 | Values: 2908.7 3463.2 3496.9 3540.1 3541.8 4273.9 5660.6 5675.1 5686.2 5693.8 5430.2 5695.8 5753.6 5784.9 5786.9 5141.5 5205.5 5225.3 5238.7 5283.3 5228.8 5305.6 5312.9 5352.2 5364.9 5136.5 5195.6 5225.1 5240.6 5247.6 4657.9 4929.5 5153.2 5199.4 5205.1 5140.5 5178.2 5197.1 5198.7 5227.7 5444.9 5514.4 5560.3 5563.5 5580.6 6009.9 6143.8 6185.8 6218.2 6263.9 6138.5 6143.7 6155.9 6170.3 6242.5 5593.5 5776.9 5779.6 5790.4 5795.6 6264.0 6264.3 6297.6 6300.1 6306.9 5420.5 5968.6 6089.8 6107.8 6137.7 6233.3 6234.0 6237.9 6247.2 6269.0 6001.3 6114.7 6164.9 6198.2 6225.1 6157.7 6161.5 6183.3 6200.6 6221.9 4842.1 4853.8 4870.1 4882.1 4887.1 4287.2 4331.1 4364.3 4387.3 4436.4 5697.8 5753.9 5762.4 5777.6 5812.1 6109.2 6225.4 6253.1 6256.0 6281.8 5752.7 5758.4 5782.9 5809.6 5836.8 5320.4 5326.7 5343.1 5351.0 5371.3 5214.3 6249.4 6252.9 6279.7 6295.8 6106.8 6198.3 6208.0 6267.0 6323.7 4958.4 5136.8 6253.6 6288.9 6332.4 6061.6 6115.5 6161.5 6178.3 6225.1 6128.0 6219.7 6229.4 6287.4 6323.2 5179.7 5935.8 6102.4 6118.5 6146.6 4848.3 6049.8 6066.1 6091.4 6168.8 5309.2 5816.0 5892.1 5912.4 5921.6 6002.2 6041.5 6082.3 6097.9 6098.3 5896.5 5903.6 5931.8 5933.9 5946.4 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | [#1] ext.html Cycles:180 Average:62779.37 Median:38999.40 stddev:130289.63 (334.1%) stddev-sans-first:130571.10 01:41:07 INFO - PROCESS | 2972 | Values: 455.8 485.9 493.5 555.0 594.4 29897.0 37876.9 38015.0 38196.2 38210.4 38998.8 39367.6 39427.6 39449.6 39630.0 9405.0 9573.5 9580.9 9584.6 9609.0 9434.7 9713.6 9719.4 9720.9 9733.9 9665.9 9747.0 9766.1 9785.9 9792.8 9706.3 9740.0 9765.0 9770.1 9774.6 9607.2 9729.1 9745.0 9753.7 9770.2 38531.8 38714.0 38844.0 38943.0 39000.0 2999.6 3019.6 3195.8 3237.8 3649.8 28679.9 28947.9 28966.1 29084.9 29420.4 2750.6 2851.0 2886.5 2891.2 2982.3 488050.0 491463.0 492371.0 493240.0 494130.5 41856.0 42717.0 64484.7 65289.0 65563.3 37843.4 45252.0 45565.8 45642.8 45864.3 15623.4 15702.9 15711.6 15817.3 15868.7 12362.5 12551.5 12615.1 12707.2 12721.8 14565.9 14633.6 14709.0 14752.1 14754.3 6158.8 6275.5 6311.9 6319.8 6365.3 889.9 911.4 1032.8 1128.2 1142.5 25721.4 30070.8 31052.4 31057.8 31911.2 967.7 988.6 1017.7 1060.6 1213.8 13657.0 14051.0 14690.6 14712.3 15446.3 379828.0 511921.0 513858.4 519140.0 521974.0 56487.4 57061.9 57135.7 57323.0 60073.0 1427.2 1429.4 1449.8 1465.8 1468.8 23495.8 29721.7 30512.8 31059.1 31166.1 52622.2 53115.0 53799.0 53984.7 54304.7 445884.0 493834.0 494282.0 494557.0 496404.0 36883.4 43657.8 44779.6 44922.6 45265.3 46014.0 46377.1 46953.0 47019.5 47456.3 37330.8 38262.4 39243.8 39299.0 39460.8 37630.6 38195.0 38198.0 38308.8 38748.0 34572.7 34613.5 36165.3 36326.5 36469.5 24097.9 32210.2 32286.0 33513.0 34264.7 19767.2 22488.6 25503.2 25573.4 25615.6 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | [#2] jquery.html Cycles:180 Average:31532.85 Median:13647.30 stddev:95217.79 (697.7%) stddev-sans-first:95456.13 01:41:07 INFO - PROCESS | 2972 | Values: 359.4 360.4 362.2 363.9 367.5 15203.5 15490.6 19057.2 19129.6 20052.9 14956.3 16641.2 18698.6 18910.3 19053.3 4777.6 5468.7 5716.6 5773.1 5797.7 4999.2 5751.6 5757.9 5772.3 5818.4 5426.6 5662.2 5699.0 5754.9 5776.0 4824.9 5621.9 5671.2 5673.6 5819.7 5560.4 5627.9 5639.8 5640.5 5652.3 12143.7 12410.8 15658.0 24498.9 24541.9 1930.4 1973.5 2095.5 2111.9 2752.7 9588.2 9992.0 10614.0 10882.6 14516.9 1701.6 1716.3 1779.3 1788.8 1796.5 95843.6 99799.0 100877.5 101043.0 101247.5 9564.5 10674.7 10922.3 10953.7 11017.6 11974.8 12606.2 12999.0 13174.8 13175.4 8109.1 8279.0 8361.3 8424.2 8447.9 8379.5 8502.4 8558.3 8574.2 8624.3 4329.1 4400.4 4411.4 4423.4 4487.4 1848.3 1878.2 1897.2 1930.2 1935.4 902.2 986.8 988.5 1003.2 1036.5 16832.0 18980.4 19021.0 19451.7 19666.9 893.3 917.0 930.9 942.5 974.5 9698.2 10180.7 10596.3 11442.5 11448.7 438015.0 493348.0 629735.0 637405.0 650579.0 66153.0 84483.6 97984.5 106453.9 107609.4 1011.2 1053.0 1060.7 1061.1 1061.3 12163.6 13608.4 17589.3 17662.7 17998.0 31856.8 40612.6 44690.3 46593.1 56644.4 63502.7 63620.0 63768.4 63915.7 64926.0 6740.6 7835.0 8029.9 8229.4 8251.4 11303.7 13285.7 13418.3 13454.7 13455.5 10733.3 11123.4 11285.9 11412.9 11594.9 9898.4 10597.0 10710.3 11432.8 11716.4 10427.8 11606.1 11689.7 11758.8 11955.6 7253.3 7346.3 8149.2 8302.8 8336.5 10879.9 11345.3 11450.3 11488.8 11494.9 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | [#3] mootools.html Cycles:180 Average:6001.16 Median:4993.48 stddev:3159.60 (63.3%) stddev-sans-first:3150.55 01:41:07 INFO - PROCESS | 2972 | Values: 1524.4 1540.8 1760.9 1887.5 1888.5 7822.8 8417.5 8688.5 8785.6 8845.3 8620.4 8675.1 8740.3 8753.5 8790.5 2223.6 2424.1 2432.2 2435.0 2461.1 2413.7 2430.9 2460.5 2467.1 2469.5 1975.5 2151.4 2434.8 2440.2 2450.4 2346.9 2383.5 2389.8 2394.7 2399.1 2349.9 2403.7 2418.9 2418.9 2423.6 8710.1 8758.3 8766.7 8767.9 8828.9 4469.0 5308.3 5352.1 5363.4 5396.5 3514.9 3535.4 3606.5 3615.6 3618.6 1035.9 1046.6 1054.6 1057.6 1069.6 11801.0 11961.4 11991.0 12012.3 12032.3 3727.1 4866.6 4945.2 4956.9 4989.3 8428.3 10156.9 10176.9 10186.9 10240.3 4606.8 5382.3 5424.7 5473.0 5510.7 4910.2 4965.8 4975.5 4984.4 4997.7 3994.0 4010.3 4039.8 4048.7 4050.2 1318.6 1319.8 1323.5 1340.8 1346.1 1019.7 1106.7 1130.1 1231.0 1328.8 7878.2 7916.9 8009.8 8014.2 8015.7 1175.0 1177.8 1178.7 1187.6 1190.8 6168.3 6202.5 6228.9 6231.1 6247.2 10388.5 10560.8 10585.3 10682.6 10754.6 10143.7 10509.8 10534.2 10546.1 10574.8 7803.4 8050.5 8153.1 8244.5 8292.2 7836.7 7920.6 8002.8 8051.9 8053.2 9334.0 9522.6 9586.2 9612.9 9630.8 9468.5 9751.8 9775.7 9927.7 10007.5 7416.4 7438.9 7500.2 7541.0 7556.6 8014.6 8087.6 8111.3 8124.9 8152.1 6718.6 7174.2 7348.5 7393.1 7487.4 6638.2 7152.7 7208.6 7242.5 7258.9 7549.5 7586.8 7600.9 7621.7 7663.8 6909.4 6944.2 6945.0 6960.2 6961.4 6968.1 7053.0 7059.6 7061.1 7099.4 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | [#4] prototype.html Cycles:180 Average:6019.26 Median:6967.51 stddev:2003.17 (28.8%) stddev-sans-first:1962.64 01:41:07 INFO - PROCESS | 2972 | Values: 323.9 329.6 330.4 335.6 338.0 6792.8 6954.8 6982.5 6997.4 7005.9 6965.8 6969.2 7000.8 7003.0 7022.0 3947.4 5112.5 5124.7 5142.3 5165.3 5113.9 5130.8 5134.0 5137.5 5140.9 5049.3 5066.2 5066.7 5069.1 5092.4 3734.8 5001.0 5026.1 5078.2 5081.4 4177.4 4195.9 4201.7 4207.6 4223.4 6463.0 6608.1 6628.6 6635.4 6661.6 5859.5 5876.4 5893.6 5903.4 5946.3 5969.7 7427.3 7454.4 7455.6 7514.3 4668.9 4675.6 4686.4 4699.2 4711.7 7868.0 7903.6 7909.2 7925.0 7929.2 4479.3 4567.7 4626.2 4737.0 4737.1 3828.8 4753.8 4796.6 4799.1 4814.7 4660.8 4673.0 5814.4 5822.1 5862.1 7347.7 7350.8 7360.8 7365.5 7406.4 1461.3 1661.2 1686.3 1689.3 1689.8 887.5 1035.4 1065.8 1078.8 1093.1 5670.4 5736.7 6965.9 6992.4 7017.3 7703.1 7715.3 7741.0 7753.8 7769.9 6971.6 6987.9 6990.0 6991.4 7030.9 3954.8 4032.1 4089.9 4089.9 4119.9 8029.1 8047.4 8050.4 8078.3 8169.3 6538.2 8033.4 8060.3 8075.7 8115.1 8093.3 8104.8 8107.8 8127.1 8130.7 7534.0 7719.8 7819.3 7829.0 7844.7 7605.2 7639.3 7670.8 7671.3 7671.7 8002.0 8087.0 8104.3 8118.3 8139.0 4716.1 4795.2 4806.4 4811.6 4826.6 7455.0 7485.2 7616.8 7747.3 7790.2 7510.7 7519.3 7534.1 7534.6 7571.7 7505.3 7508.1 7525.5 7531.4 7535.2 6290.8 6450.0 7115.3 7313.4 7336.6 6047.9 6766.6 7500.7 7531.7 7549.7 7258.2 7275.4 7311.1 7326.0 7327.1 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - PROCESS | 2972 | [#5] yui.html Cycles:180 Average:17887.93 Median:627.97 stddev:24840.85 (3955.7%) stddev-sans-first:24876.75 01:41:07 INFO - PROCESS | 2972 | Values: 634.3 660.9 691.7 708.4 732.9 14779.6 14955.3 14956.6 15052.2 15088.6 13464.6 13564.9 13584.6 13599.3 13599.4 701.1 848.1 862.4 879.1 883.5 863.2 863.6 870.6 873.0 873.9 905.6 920.1 920.7 922.2 924.0 844.3 875.8 902.7 909.8 914.9 596.3 621.4 688.4 688.6 689.3 12753.1 13584.9 14427.3 14435.0 14539.3 12729.7 12760.2 12924.8 13108.1 13383.5 10179.3 10278.3 10349.8 10364.2 10410.9 2964.4 3485.9 3563.2 3606.7 3720.7 62056.2 68721.3 76620.5 85066.1 86730.0 7711.6 7860.7 9440.3 9567.1 9632.7 16598.8 20880.6 21015.5 21057.6 21091.9 7447.8 7452.4 7501.9 7689.8 7943.4 4081.2 4178.9 4185.2 4195.1 4358.7 3455.8 3485.3 3489.1 3493.4 3517.3 628.9 637.9 639.0 662.6 663.1 513.6 545.6 618.4 627.2 628.8 8100.1 8472.7 8542.2 8642.0 8690.9 524.0 538.5 551.3 618.9 621.7 3699.4 4001.2 4011.0 4036.5 4062.2 85826.1 86345.0 87301.6 87441.6 87864.6 71539.0 74579.6 75017.0 75229.0 77083.6 67211.3 68050.0 68703.7 68986.7 71879.6 8738.0 8738.0 8787.9 8862.8 9025.5 51638.7 52076.5 52215.2 52956.0 52991.0 66006.0 67572.7 69061.0 69153.7 69826.0 10728.2 10914.5 10927.1 11023.7 11043.9 9478.3 11876.5 11937.6 12110.6 12592.4 11154.6 11224.2 11511.3 11757.4 11799.2 9303.3 9648.9 11648.0 11741.5 11848.8 10459.4 10973.8 11108.6 11350.1 11532.9 9207.9 9320.2 9502.6 9743.1 9776.2 9748.5 9815.8 9971.0 10000.9 10049.3 01:41:07 INFO - PROCESS | 2972 | -------- Summary: end -------- 01:41:07 INFO - PROCESS | 2972 | 01:41:07 INFO - TEST-INFO | 2972: exit 0 01:41:07 INFO - TEST-OK | dromaeo_css | took 1110887ms 01:41:07 INFO - TEST-START | kraken 01:41:07 INFO - operating with platform_type : mac_ 01:41:07 INFO - Initialising browser for kraken test... 01:41:07 INFO - TEST-INFO | started process 2980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpjCSeLd/profile http://localhost:59884/getInfo.html) 01:41:10 INFO - PROCESS | 2980 | __metrics Screen width/height:1600/1200 01:41:10 INFO - PROCESS | 2980 | colorDepth:24 01:41:10 INFO - PROCESS | 2980 | Browser inner width/height: 1024/689 01:41:10 INFO - PROCESS | 2980 | __metrics 01:41:10 ERROR - PROCESS | 2980 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:41:11 INFO - TEST-INFO | 2980: exit 0 01:41:11 INFO - Browser initialized. 01:41:11 INFO - Running cycle 1/1 for kraken test... 01:41:11 INFO - TEST-INFO | started process 2983 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpjCSeLd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:23 INFO - PROCESS | 2983 | RSS: Main: 255778816 01:41:23 INFO - PROCESS | 2983 | 01:41:25 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59884/tests/kraken/driver.html?testName=audio-beat-detection) 01:41:26 INFO - PROCESS | 2983 | RSS: Main: 269103104 01:41:26 INFO - PROCESS | 2983 | 01:41:29 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59884/tests/kraken/driver.html?testName=audio-dft) 01:41:29 INFO - PROCESS | 2983 | RSS: Main: 278605824 01:41:29 INFO - PROCESS | 2983 | 01:41:32 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59884/tests/kraken/driver.html?testName=audio-fft) 01:41:33 INFO - PROCESS | 2983 | RSS: Main: 281178112 01:41:33 INFO - PROCESS | 2983 | 01:41:35 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59884/tests/kraken/driver.html?testName=audio-oscillator) 01:41:36 INFO - PROCESS | 2983 | RSS: Main: 283410432 01:41:36 INFO - PROCESS | 2983 | 01:41:38 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:41:38 INFO - PROCESS | 2983 | RSS: Main: 283369472 01:41:38 INFO - PROCESS | 2983 | 01:41:41 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59884/tests/kraken/driver.html?testName=imaging-darkroom) 01:41:42 INFO - PROCESS | 2983 | RSS: Main: 283729920 01:41:42 INFO - PROCESS | 2983 | 01:41:45 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59884/tests/kraken/driver.html?testName=imaging-desaturate) 01:41:45 INFO - PROCESS | 2983 | RSS: Main: 283361280 01:41:45 INFO - PROCESS | 2983 | 01:41:48 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59884/tests/kraken/driver.html?testName=json-parse-financial) 01:41:49 INFO - PROCESS | 2983 | RSS: Main: 283758592 01:41:49 INFO - PROCESS | 2983 | 01:41:50 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:41:51 INFO - PROCESS | 2983 | RSS: Main: 283561984 01:41:51 INFO - PROCESS | 2983 | 01:41:53 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:41:53 INFO - PROCESS | 2983 | RSS: Main: 284422144 01:41:53 INFO - PROCESS | 2983 | 01:41:55 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:41:56 INFO - PROCESS | 2983 | RSS: Main: 284377088 01:41:56 INFO - PROCESS | 2983 | 01:41:59 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:41:59 INFO - PROCESS | 2983 | RSS: Main: 284225536 01:41:59 INFO - PROCESS | 2983 | 01:42:02 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:42:02 INFO - PROCESS | 2983 | RSS: Main: 284897280 01:42:02 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:59884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59884/tests/kraken/driver.html?testName=ai-astar) 01:42:04 INFO - PROCESS | 2983 | RSS: Main: 286502912 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | __start_tp_report 01:42:04 INFO - PROCESS | 2983 | _x_x_mozilla_page_load 01:42:04 INFO - PROCESS | 2983 | _x_x_mozilla_page_load_details 01:42:04 INFO - PROCESS | 2983 | |i|pagename|runs| 01:42:04 INFO - PROCESS | 2983 | |0;ai-astar;116;108;113;115;114;125;113;113;116;115 01:42:04 INFO - PROCESS | 2983 | |1;audio-beat-detection;171;120;143;152;119;150;174;132;156;152 01:42:04 INFO - PROCESS | 2983 | |2;audio-dft;195;250;211;216;210;200;199;198;203;195 01:42:04 INFO - PROCESS | 2983 | |3;audio-fft;57;71;70;73;125;56;57;64;58;95 01:42:04 INFO - PROCESS | 2983 | |4;audio-oscillator;79;86;132;82;81;82;117;78;83;110 01:42:04 INFO - PROCESS | 2983 | |5;imaging-gaussian-blur;89;92;78;141;77;101;130;141;112;93 01:42:04 INFO - PROCESS | 2983 | |6;imaging-darkroom;142;92;151;150;94;95;94;94;99;105 01:42:04 INFO - PROCESS | 2983 | |7;imaging-desaturate;147;151;91;90;92;99;92;91;92;90 01:42:04 INFO - PROCESS | 2983 | |8;json-parse-financial;57;56;54;55;55;56;58;64;56;54 01:42:04 INFO - PROCESS | 2983 | |9;json-stringify-tinderbox;65;68;68;70;78;75;68;66;65;70 01:42:04 INFO - PROCESS | 2983 | |10;stanford-crypto-aes;86;83;87;85;85;86;85;88;87;85 01:42:04 INFO - PROCESS | 2983 | |11;stanford-crypto-ccm;134;133;133;130;133;117;138;125;142;120 01:42:04 INFO - PROCESS | 2983 | |12;stanford-crypto-pbkdf2;144;145;144;142;142;146;143;146;144;134 01:42:04 INFO - PROCESS | 2983 | |13;stanford-crypto-sha256-iterative;72;83;90;92;93;84;66;77;88;98 01:42:04 INFO - PROCESS | 2983 | __end_tp_report 01:42:04 INFO - PROCESS | 2983 | __start_cc_report 01:42:04 INFO - PROCESS | 2983 | _x_x_mozilla_cycle_collect,883 01:42:04 INFO - PROCESS | 2983 | __end_cc_report 01:42:04 INFO - PROCESS | 2983 | __startTimestamp1456393324969__endTimestamp 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | ------- Summary: start ------- 01:42:04 INFO - PROCESS | 2983 | Number of tests: 14 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:4.26 (3.7%) stddev-sans-first:4.50 01:42:04 INFO - PROCESS | 2983 | Values: 116.0 108.0 113.0 115.0 114.0 125.0 113.0 113.0 116.0 115.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.00 stddev:18.85 (12.4%) stddev-sans-first:17.87 01:42:04 INFO - PROCESS | 2983 | Values: 171.0 120.0 143.0 152.0 119.0 150.0 174.0 132.0 156.0 152.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#2] audio-dft Cycles:10 Average:207.70 Median:206.50 stddev:16.49 (8.0%) stddev-sans-first:16.84 01:42:04 INFO - PROCESS | 2983 | Values: 195.0 250.0 211.0 216.0 210.0 200.0 199.0 198.0 203.0 195.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#3] audio-fft Cycles:10 Average:72.60 Median:67.00 stddev:21.87 (32.6%) stddev-sans-first:22.46 01:42:04 INFO - PROCESS | 2983 | Values: 57.0 71.0 70.0 73.0 125.0 56.0 57.0 64.0 58.0 95.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:81.50 stddev:19.27 (23.6%) stddev-sans-first:19.76 01:42:04 INFO - PROCESS | 2983 | Values: 79.0 86.0 132.0 82.0 81.0 82.0 117.0 78.0 83.0 110.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#5] imaging-gaussian-blur Cycles:10 Average:105.40 Median:77.50 stddev:24.41 (31.5%) stddev-sans-first:25.16 01:42:04 INFO - PROCESS | 2983 | Values: 89.0 92.0 78.0 141.0 77.0 101.0 130.0 141.0 112.0 93.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#6] imaging-darkroom Cycles:10 Average:111.60 Median:94.00 stddev:25.26 (26.9%) stddev-sans-first:24.28 01:42:04 INFO - PROCESS | 2983 | Values: 142.0 92.0 151.0 150.0 94.0 95.0 94.0 94.0 99.0 105.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#7] imaging-desaturate Cycles:10 Average:103.50 Median:91.50 stddev:24.14 (26.4%) stddev-sans-first:19.81 01:42:04 INFO - PROCESS | 2983 | Values: 147.0 151.0 91.0 90.0 92.0 99.0 92.0 91.0 92.0 90.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:2.92 (5.2%) stddev-sans-first:3.09 01:42:04 INFO - PROCESS | 2983 | Values: 57.0 56.0 54.0 55.0 55.0 56.0 58.0 64.0 56.0 54.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:4.24 (6.2%) stddev-sans-first:4.21 01:42:04 INFO - PROCESS | 2983 | Values: 65.0 68.0 68.0 70.0 78.0 75.0 68.0 66.0 65.0 70.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.42 (1.6%) stddev-sans-first:1.50 01:42:04 INFO - PROCESS | 2983 | Values: 86.0 83.0 87.0 85.0 85.0 86.0 85.0 88.0 87.0 85.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:133.00 stddev:7.76 (5.8%) stddev-sans-first:8.13 01:42:04 INFO - PROCESS | 2983 | Values: 134.0 133.0 133.0 130.0 133.0 117.0 138.0 125.0 142.0 120.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:144.00 stddev:3.46 (2.4%) stddev-sans-first:3.66 01:42:04 INFO - PROCESS | 2983 | Values: 144.0 145.0 144.0 142.0 142.0 146.0 143.0 146.0 144.0 134.0 01:42:04 INFO - PROCESS | 2983 | 01:42:04 INFO - PROCESS | 2983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.30 Median:89.00 stddev:10.06 (11.3%) stddev-sans-first:9.63 01:42:04 INFO - PROCESS | 2983 | Values: 72.0 83.0 90.0 92.0 93.0 84.0 66.0 77.0 88.0 98.0 01:42:04 INFO - PROCESS | 2983 | -------- Summary: end -------- 01:42:04 INFO - PROCESS | 2983 | 01:42:05 INFO - TEST-INFO | 2983: exit 0 01:42:05 INFO - TEST-OK | kraken | took 58135ms 01:42:05 INFO - SUITE-END | took 1169s 01:42:06 INFO - Completed test suite (00:19:29) 01:42:06 INFO - Working with test: dromaeo_css 01:42:06 INFO - Generating results file: dromaeo_css 01:42:06 INFO - Working with test: kraken 01:42:06 INFO - Generating results file: kraken 01:42:06 INFO - javascript benchmark 01:42:06 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:42:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 01:42:06 INFO - process_Request line: dromaeo_css 7465.31 graph.html#tests=[[72,64,61]] 01:42:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:42:06 INFO - process_Request line: kraken 1524.80 graph.html#tests=[[232,64,61]] 01:42:06 INFO - RETURN: dromaeo_css: 7465.31 01:42:06 INFO - RETURN: kraken: 1524.80 01:42:06 INFO - javascript benchmark 01:42:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2908.6800451950294, 3463.238087620724, 3496.930061398772, 3540.079579309379, 3541.822908854557, 4273.871783846485, 5660.60375773696, 5675.063614503607, 5686.175504551838, 5693.829185124453, 5430.212619170218, 5695.77216911323, 5753.597248192628, 5784.884302313962, 5786.884262314751, 5141.511556402136, 5205.479452054802, 5225.320708307915, 5238.685678859261, 5283.260343551906, 5228.816991405301, 5305.575553955674, 5312.946870531303, 5352.2239275305055, 5364.91952620711, 5136.537711605936, 5195.636305458619, 5225.137852254374, 5240.580753539746, 5247.606429517801, 4657.860513321324, 4929.482404347564, 5153.2270159476375, 5199.402068762103, 5205.063088644042, 5140.485951404867, 5178.197379406198, 5197.142471492237, 5198.714070726109, 5227.686338819645, 5444.891102177934, 5514.3658479275, 5560.332760068777, 5563.471470210324, 5580.553555715533, 6009.879802403927, 6143.78496752616, 6185.783497577563, 6218.160548326008, 6263.903816832036, 6138.480361557102, 6143.726821076186, 6155.92271352516, 6170.259568851721, 6242.469390101847, 5593.468620481048, 5776.942230577724, 5779.624324418899, 5790.363060063348, 5795.623284486495, 6264.0, 6264.279607845065, 6297.590656607306, 6300.054991751274, 6306.936930630727, 5420.4850539198715, 5968.641881487125, 6089.817305480843, 6107.816765497042, 6137.723802428902, 6233.34549872266, 6234.0, 6237.937620623736, 6247.156633854463, 6269.0, 6001.279846418458, 6114.692773002257, 6164.938350616526, 6198.163247961467, 6225.097360882647, 6157.692115394212, 6161.507079433634, 6183.319834818257, 6200.56596038273, 6221.875562488815, 4842.104210721028, 4853.790129467558, 4870.09903167915, 4882.145624515695, 4887.120318342732, 4287.206866729665, 4331.112122014979, 4364.279893817548, 4387.341898715218, 4436.44544431946, 5697.800576979786, 5753.942460575425, 5762.423757624288, 5777.595568310178, 5812.128180772918, 6109.236345456818, 6225.439710426083, 6253.093301471261, 6256.0, 6281.842953926189, 5752.741126649311, 5758.424157584208, 5782.942170578241, 5809.564282678816, 5836.766529338779, 5320.361556613231, 5326.733663316896, 5343.145096784496, 5350.9732451337495, 5371.301730775052, 5214.348206474191, 6249.375062493714, 6252.906206406908, 6279.686015699197, 6295.811125666238, 6106.794380079809, 6198.2871969722255, 6208.037754148114, 6266.968665156645, 6323.747050117944, 4958.404991401055, 5136.7945282189785, 6253.593516421418, 6288.905666415099, 6332.366763323631, 6061.575689701678, 6115.483736156635, 6161.537884658579, 6178.258608966773, 6225.066240064027, 6127.969360153171, 6219.689015549114, 6229.408206220402, 6287.402696743802, 6323.241211054519, 5179.741012949262, 5935.821925342247, 6102.420270074514, 6118.479929206067, 6146.6004709693725, 4848.321235027029, 6049.818505444844, 6066.059760737093, 6091.360407157362, 6168.814935551761, 5309.150535914235, 5815.9709201453725, 5892.086726557391, 5912.438318359749, 5921.5558833086825, 6002.189704390026, 6041.516678665784, 6082.330943596289, 6097.939020609737, 6098.329183789869, 5896.49879760208, 5903.586748927534, 5931.792387266425, 5933.851653708519, 5946.43508866657], "unit": "score", "name": "dojo.html", "value": 5632.280878876584}, {"lowerIsBetter": false, "replicates": [455.7721139430283, 485.91253574356625, 493.5360760884768, 555.0480925213259, 594.3610618585022, 29897.0, 37876.86369408915, 38015.0, 38196.23607527851, 38210.426843597335, 38998.805005975, 39367.62213322534, 39427.605723942754, 39449.60550394495, 39630.0, 9404.952975235132, 9573.473458959754, 9580.904190958106, 9584.568694408768, 9608.951955240214, 9434.716958491255, 9713.61145554177, 9719.416834989888, 9720.90279097207, 9733.853992190123, 9665.855012174823, 9747.025297470233, 9766.072223138826, 9785.853212201822, 9792.755181120494, 9706.320557560974, 9740.0, 9765.0, 9770.071843174923, 9774.5601447935, 9607.183389411908, 9729.124378805871, 9745.02549745027, 9753.658621948269, 9770.218382529381, 38531.807340963394, 38714.03214919622, 38844.0, 38943.0, 39000.0, 2999.6250468691414, 3019.607451031352, 3195.7603179761377, 3237.8219197944104, 3649.799261040642, 28679.85660071707, 28947.85526072356, 28966.13101606955, 29084.854575726986, 29420.411591768046, 2750.614913912054, 2850.985745071282, 2886.480433521965, 2891.2482754483776, 2982.2991596974693, 488050.0, 491463.0, 492371.0, 493240.0, 494130.52934735455, 41856.0, 42717.0, 64484.71030579456, 65289.0, 65563.34436655667, 37843.4323485148, 45252.0, 45565.77217113893, 45642.77178614086, 45864.3120353195, 15623.3750649975, 15702.9214853925, 15711.607209819846, 15817.260101388838, 15868.682626347409, 12362.505499779909, 12551.497940082294, 12615.053870959715, 12707.2375657459, 12721.809172862415, 14565.854341456661, 14633.560993170222, 14708.970372073853, 14752.114873107648, 14754.336054877556, 6158.753649853956, 6275.466585340206, 6311.936880631135, 6319.8104056878365, 6365.2998170201245, 889.9332550058772, 911.444019148319, 1032.7779527401644, 1128.1626708827305, 1142.457332766929, 25721.356966075622, 30070.79716811347, 31052.378952421277, 31057.844710776302, 31911.202219944687, 967.690339091484, 988.6440881282732, 1017.6539976408056, 1060.6287799270349, 1213.787587172259, 13657.039513344573, 14051.0, 14690.63273418173, 14712.264386780618, 15446.30491627857, 379828.0, 511921.0, 513858.4307078441, 519140.0, 521974.0, 56487.43512564904, 57061.85876282451, 57135.714321428124, 57323.0, 60073.0, 1427.1793718611839, 1429.3853642933639, 1449.8187726534184, 1465.8094447721728, 1468.809054822845, 23495.765042349358, 29721.70278297276, 30512.806488023518, 31059.068227953197, 31166.065018049496, 52622.21066683926, 53115.0, 53798.96507761855, 53984.73007634937, 54304.72847635736, 445884.0, 493834.0, 494282.0, 494557.0, 496404.0, 36883.446748299335, 43657.781711091244, 44779.552204477535, 44922.550774491836, 45265.32102018406, 46014.0, 46377.072458551316, 46953.0, 47019.529804702885, 47456.288155677, 37330.813345934184, 38262.42606360851, 39243.80378098205, 39299.0, 39460.802695986335, 37630.62369376271, 38195.0, 38198.0, 38308.80845595754, 38748.031299216615, 34572.654273456945, 34613.48079778856, 36165.276694465436, 36326.455103174005, 36469.45295820512, 24097.879510602335, 32210.19474513156, 32286.031419057465, 33513.0, 34264.657353427145, 19767.209311627375, 22488.550228995657, 25503.248535414023, 25573.3606659835, 25615.615765763156], "unit": "score", "name": "ext.html", "value": 19231.35732520607}, {"lowerIsBetter": false, "replicates": [359.3657195050734, 360.42152345485493, 362.217609962481, 363.9090227443139, 367.5222211125536, 15203.54389368318, 15490.61273468161, 19057.23771049158, 19129.61740765184, 20052.897090660026, 14956.32696528656, 16641.167941602933, 18698.626027479444, 18910.338138165167, 19053.3331333403, 4777.570018698317, 5468.699221542814, 5716.628419152763, 5773.076307790754, 5797.71011449428, 4999.200127979524, 5751.597388182829, 5757.942420575782, 5772.307323121231, 5818.447247511501, 5426.647267927572, 5662.17898404731, 5699.0, 5754.913676294859, 5776.0, 4824.855254342376, 5621.8594535136535, 5671.234383358255, 5673.574481913853, 5819.6508209507565, 5560.4161563035705, 5627.887442251173, 5639.802606908779, 5640.464155905182, 5652.293463317085, 12143.664196938329, 12410.751784964341, 15658.0, 24498.877505612538, 24541.87729061361, 1930.44982180078, 1973.4967583266175, 2095.528506086134, 2111.915523379063, 2752.7199852068684, 9588.232941364675, 9992.0, 10613.991670791262, 10882.61910833125, 14516.854831451761, 1701.6001239708658, 1716.2963185094052, 1779.3149637389697, 1788.7853457585172, 1796.5378701453249, 95843.56234656485, 99799.0, 100877.45174015427, 101043.0, 101247.49376253145, 9564.521773911276, 10674.679759607225, 10922.29005114665, 10953.726156846142, 11017.614383496539, 11974.820377694341, 12606.180598261268, 12998.960083193322, 13174.802377964339, 13175.407106680223, 8109.107998120202, 8279.0, 8361.289290410383, 8424.15758424165, 8447.873281900776, 8379.497230166087, 8502.404831661725, 8558.272546833588, 8574.185452382013, 8624.266937310273, 4329.1341731653165, 4400.361947517592, 4411.382406463098, 4423.424954755861, 4487.371767952489, 1848.334599544163, 1878.1923772777563, 1897.1976622208956, 1930.224193741761, 1935.380678182996, 902.2376092202079, 986.8421052631544, 988.5353883674661, 1003.1623594298696, 1036.512838965685, 16832.0, 18980.43058708241, 19021.0, 19451.708224376645, 19666.90166549158, 893.3166127912023, 916.9679061232824, 930.930180236485, 942.4580866002076, 974.4543055888724, 9698.175655069257, 10180.694579162637, 10596.258261921746, 11442.485088171052, 11448.656540303804, 438015.0, 493348.0, 629735.0, 637405.0, 650579.0, 66153.0, 84483.5775821117, 97984.51007744916, 106453.9354606444, 107609.38585921217, 1011.1556850030161, 1052.9631462898762, 1060.7030031591012, 1061.0662616897234, 1061.3048453263125, 12163.635090947286, 13608.387622557208, 17589.329013743674, 17662.735058974384, 17998.01010944358, 31856.840715796272, 40612.59387406088, 44690.3296450547, 46593.06813863772, 56644.43355566391, 63502.68248658912, 63620.0, 63768.3623163781, 63915.68042159759, 64926.02610960934, 6740.561863478858, 7834.960825195838, 8029.919700803151, 8229.382796290183, 8251.422400432153, 11303.717407064889, 13285.734285314433, 13418.261995590336, 13454.730905382034, 13455.529056482976, 10733.302335348177, 11123.388213648326, 11285.887141128813, 11412.942935285271, 11594.94202528982, 9898.406095634286, 10597.046265836112, 10710.303830251009, 11432.771344572895, 11716.414179291172, 10427.800802907763, 11606.129540284344, 11689.707757306136, 11758.82361764557, 11955.64133076009, 7253.347198752138, 7346.265373462611, 8149.185081491803, 8302.833943320979, 8336.541490218096, 10879.891201087888, 11345.319280843176, 11450.312981221154, 11488.770224595628, 11494.885051149382], "unit": "score", "name": "jquery.html", "value": 8992.940695028687}, {"lowerIsBetter": false, "replicates": [1524.3750062474387, 1540.7919930809342, 1760.9119544022797, 1887.471507977765, 1888.5467487802914, 7822.843543129148, 8417.494950302986, 8688.522131282776, 8785.648574057039, 8845.336599755012, 8620.396572239946, 8675.089115642846, 8740.257078148365, 8753.474791512497, 8790.51652159131, 2223.566404551113, 2424.054618698709, 2432.185217951979, 2435.0138194031356, 2461.052494789501, 2413.734489206186, 2430.9027638894513, 2460.507898420314, 2467.111839737693, 2469.493753780471, 1975.4764987278384, 2151.3868547463976, 2434.8417352872093, 2440.170342083691, 2450.3996520852415, 2346.8709220992837, 2383.5232953409386, 2389.7968672662846, 2394.6527753475734, 2399.076355603088, 2349.89425475854, 2403.735589085199, 2418.8669623170717, 2418.8790560471907, 2423.587990041697, 8710.12898710124, 8758.2993360531, 8766.693165739232, 8767.868481972775, 8828.8675669865, 4468.977655111737, 5308.256844041837, 5352.143657014859, 5363.436839131913, 5396.514313711785, 3514.947275790865, 3535.398982173011, 3606.5131207286945, 3615.566132064143, 3618.6019537850816, 1035.8808736995268, 1046.597060131847, 1054.562356622001, 1057.5822550092748, 1069.6202847989007, 11801.0, 11961.40192990347, 11990.980766634759, 12012.339321337324, 12032.278063316317, 3727.086863718352, 4866.562009419098, 4945.159322915113, 4956.925646115311, 4989.276554899519, 8428.283595894418, 10156.898431015596, 10176.931422200561, 10186.949065254774, 10240.283180177465, 4606.8157273708675, 5382.30030096085, 5424.728763561806, 5472.98749731301, 5510.669359838423, 4910.238912968495, 4965.776540055706, 4975.502449754996, 4984.4267909190185, 4997.675151115166, 3993.980030099831, 4010.2781499329817, 4039.818208180639, 4048.736832105904, 4050.210209009215, 1318.604418674413, 1319.7888337865895, 1323.5499930023839, 1340.7787715027107, 1346.1451977994045, 1019.7348689340677, 1106.734383747911, 1130.084631448513, 1230.969225769363, 1328.8338957630297, 7878.212178782191, 7916.920830791733, 8009.799755006172, 8014.19858014194, 8015.679372825139, 1175.0305997552055, 1177.8409914661581, 1178.6522975722182, 1187.6377704800118, 1190.833283340333, 6168.290646575701, 6202.503799696104, 6228.937710622927, 6231.065340199007, 6247.187865577536, 10388.48057597117, 10560.788784224273, 10585.259031867696, 10682.62610808618, 10754.569817207224, 10143.7464063399, 10509.789804203872, 10534.157267418588, 10546.05085542305, 10574.788504229873, 7803.414743894345, 8050.476719013245, 8153.062397824207, 8244.54654993981, 8292.212239837327, 7836.686532538863, 7920.603969801602, 8002.799930001796, 8051.879221811795, 8053.154418785943, 9333.953330233306, 9522.571484283362, 9586.233101352014, 9612.855807162758, 9630.807383852423, 9468.479233642216, 9751.756206094904, 9775.706728798148, 9927.702168934944, 10007.54966026516, 7416.4066874648815, 7438.851222975619, 7500.249975002675, 7541.0, 7556.58438785872, 8014.637511622922, 8087.555184464911, 8111.269985701315, 8124.878126828221, 8152.103268640326, 6718.596884186964, 7174.2108368078425, 7348.52234604749, 7393.1497877742595, 7487.401007919245, 6638.20341559016, 7152.678129484081, 7208.56748595065, 7242.529235599669, 7258.927410725825, 7549.471536992358, 7586.810329741801, 7600.885986710315, 7621.695132194872, 7663.808404789925, 6909.412699920362, 6944.201416836926, 6944.965275173592, 6960.199577048705, 6961.408280296231, 6968.0941477607585, 7053.0478385419365, 7059.647017648994, 7061.1173603299585, 7099.432045436456], "unit": "score", "name": "mootools.html", "value": 4897.213081449536}, {"lowerIsBetter": false, "replicates": [323.8817831491506, 329.60776675755847, 330.4465021089674, 335.6274535265855, 337.9932401351975, 6792.7773000859825, 6954.826129346762, 6982.476314276424, 6997.440204783617, 7005.929940700591, 6965.756198533052, 6969.1637003559645, 7000.754973575926, 7002.96498517508, 7021.9648901755545, 3947.368421052632, 5112.463191364909, 5124.6668966517245, 5142.280080788692, 5165.251038599401, 5113.923291150636, 5130.769115389798, 5133.974330128362, 5137.537621614054, 5140.8714782130555, 5049.318342023835, 5066.240063990394, 5066.746662666852, 5069.087564238435, 5092.439831618538, 3734.7759134451885, 5001.0, 5026.145555255615, 5078.238264260353, 5081.441041485434, 4177.415161877339, 4195.91608167835, 4201.7268877523165, 4207.579242075799, 4223.408722778782, 6463.0, 6608.107905432753, 6628.602283862983, 6635.43598794103, 6661.63361015144, 5859.501942334907, 5876.353601103875, 5893.5579831512805, 5903.409659034105, 5946.286445626509, 5969.671668058255, 7427.25727427253, 7454.4409169311975, 7455.589942553157, 7514.286142816423, 4668.883277918046, 4675.602573781232, 4686.367340409035, 4699.201135806921, 4711.670183087185, 7868.0, 7903.565303908283, 7909.169537198569, 7924.960375198087, 7929.207079292082, 4479.3057076153245, 4567.680262381601, 4626.236670949323, 4737.0052289019, 4737.099951009297, 3828.8468461261796, 4753.762311884392, 4796.632959606495, 4799.112164249625, 4814.711117332971, 4660.813567457331, 4672.953270467252, 5814.447627475383, 5822.097574875901, 5862.14998825168, 7347.70609175627, 7350.816229594303, 7360.77917662471, 7365.52124111931, 7406.370458510979, 1461.2547600723708, 1661.1694152923537, 1686.2833295849216, 1689.2736123467027, 1689.7549855270918, 887.5163036145316, 1035.3839465518004, 1065.8401239813934, 1078.8381742738652, 1093.1145771924766, 5670.432956704297, 5736.713164341766, 6965.860682786316, 6992.405645520188, 7017.2631873652535, 7703.075630924212, 7715.267049630276, 7740.961295193488, 7753.767386978399, 7769.9409656441085, 6971.6165610891885, 6987.89518157228, 6989.965050174716, 6991.36449046493, 7030.859382812418, 3954.762714237155, 4032.1330913853076, 4089.8773036808943, 4089.8977525561504, 4119.9176016480105, 8029.116797152308, 8047.396445266629, 8050.396220283502, 8078.3133433658795, 8169.305609023299, 6538.248101468297, 8033.357331413473, 8060.314873235723, 8075.717349892726, 8115.147909469539, 8093.312068474245, 8104.797380065545, 8107.797305067421, 8127.1060183378595, 8130.715424960098, 7534.0481019993595, 7719.768406947801, 7819.257170568787, 7829.0, 7844.725434609762, 7605.201453847488, 7639.312461878458, 7670.846583068419, 7671.347935425551, 7671.731489397845, 8001.959990200245, 8087.0, 8104.27061564462, 8118.2693557580105, 8138.959305203436, 4716.056788642217, 4795.20879054966, 4806.423229212517, 4811.639127065554, 4826.613870890391, 7455.0, 7485.219963918186, 7616.771496855104, 7747.2640099190485, 7790.220977902164, 7510.699572017058, 7519.323260906544, 7534.0582427196605, 7534.623268836426, 7571.734989275349, 7505.324520793155, 7508.0990281166605, 7525.473216874985, 7531.3598344141365, 7535.246475352421, 6290.77329920661, 6450.032495125581, 7115.324044215791, 7313.414926805949, 7336.633168341668, 6047.879042419215, 6766.594004359754, 7500.662470188964, 7531.698732050657, 7549.698012079675, 7258.165310989304, 7275.417966562556, 7311.086114235721, 7326.0, 7327.120745510573], "unit": "score", "name": "prototype.html", "value": 5340.201093428872}, {"lowerIsBetter": false, "replicates": [634.305435548075, 660.933906609339, 691.7233106757293, 708.3766285668611, 732.9450291228158, 14779.556613301591, 14955.327010284536, 14956.626084347898, 15052.247387630616, 15088.622784430394, 13464.596062118128, 13564.914806815455, 13584.592462226125, 13599.252041137759, 13599.38802753876, 701.1270967645289, 848.1306660672798, 862.396322574199, 879.1033146190881, 883.4655033704613, 863.2446609216935, 863.5725315968605, 870.6386849457499, 872.9825403491926, 873.9126087391273, 905.597009330848, 920.0845159066738, 920.6593560382635, 922.2437601167046, 924.0113079005467, 844.2907957315884, 875.7826620996819, 902.7111324376202, 909.8316811389914, 914.9359544831865, 596.2814808156205, 621.4127649371346, 688.3563867783638, 688.5834070387393, 689.3210187964901, 12753.10728249023, 13584.932075339659, 14427.278636068155, 14435.0, 14539.273036348246, 12729.681757956032, 12760.170588911784, 12924.806127908088, 13108.147970381895, 13383.531576394877, 10179.287449878511, 10278.33190842593, 10349.844752328721, 10364.170866330676, 10410.895891041144, 2964.392299578581, 3485.9477107843404, 3563.233904710474, 3606.729495287838, 3720.6651401374006, 62056.207470663925, 68721.31278687199, 76620.5476590706, 85066.14933850644, 86730.0, 7711.614419279013, 7860.66368717308, 9440.29197810167, 9567.138957493858, 9632.662856800118, 16598.834011659972, 20880.582388352148, 21015.474613134793, 21057.578848422945, 21091.8945405272, 7447.776566703008, 7452.366548843409, 7501.887471687929, 7689.807754806063, 7943.364530837519, 4081.2449696806184, 4178.8537401190815, 4185.246655602021, 4195.139996300751, 4358.738475691469, 3455.775374600643, 3485.3029394121277, 3489.092835862694, 3493.4235851084795, 3517.3492903812366, 628.9371062893674, 637.8501052252717, 638.9840253993688, 662.6454846657111, 663.1180529895228, 513.599392473871, 545.6262460214765, 618.3877960818756, 627.1658693937053, 628.7830698409042, 8100.149484304181, 8472.74581762548, 8542.231199192103, 8642.0, 8690.91309086901, 523.9738013099329, 538.5099559401004, 551.3411473289461, 618.8731310081422, 621.7481919822479, 3699.4080947048883, 4001.15975645112, 4010.979945100256, 4036.5357983832237, 4062.207869465485, 85826.14173858182, 86345.0, 87301.5634921834, 87441.5627921869, 87864.5606771962, 71539.0, 74579.62710186523, 75017.0, 75229.0, 77083.61458192785, 67211.31971700648, 68050.0, 68703.65648171827, 68986.65506672434, 71879.56240875153, 8737.956310218407, 8738.0, 8787.912120878966, 8862.822743545223, 9025.458472491671, 51638.74180629073, 52076.47923520868, 52215.21677174921, 52956.0, 52991.0, 66006.0, 67572.662136689, 69060.96408553976, 69153.65423172852, 69826.0, 10728.249022568345, 10914.508847102059, 10927.125829933428, 11023.724406889893, 11043.944780276048, 9478.289128315542, 11876.465559049691, 11937.582184623496, 12110.576129835414, 12592.370381480707, 11154.55381784752, 11224.214304998572, 11511.30932144074, 11757.412129393668, 11799.17405781587, 9303.302252331237, 9648.903510965081, 11648.0, 11741.530338786353, 11848.763024739284, 10459.424731639832, 10973.83539246896, 11108.555657773599, 11350.148738844784, 11532.88467115318, 9207.907920920972, 9320.161185493338, 9502.572384242587, 9743.123118919331, 9776.169025632616, 9748.463834489172, 9815.803683926139, 9970.950145249228, 10000.899990999997, 10049.346792458467], "unit": "score", "name": "yui.html", "value": 6794.429306150867}], "name": "dromaeo_css", "value": 7465.3138391933}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 113.0, 115.0, 114.0, 125.0, 113.0, 113.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [171.0, 120.0, 143.0, 152.0, 119.0, 150.0, 174.0, 132.0, 156.0, 152.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [195.0, 250.0, 211.0, 216.0, 210.0, 200.0, 199.0, 198.0, 203.0, 195.0], "unit": "score", "name": "audio-dft", "value": 207.7}, {"lowerIsBetter": true, "replicates": [57.0, 71.0, 70.0, 73.0, 125.0, 56.0, 57.0, 64.0, 58.0, 95.0], "unit": "score", "name": "audio-fft", "value": 72.6}, {"lowerIsBetter": true, "replicates": [79.0, 86.0, 132.0, 82.0, 81.0, 82.0, 117.0, 78.0, 83.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [89.0, 92.0, 78.0, 141.0, 77.0, 101.0, 130.0, 141.0, 112.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 105.4}, {"lowerIsBetter": true, "replicates": [142.0, 92.0, 151.0, 150.0, 94.0, 95.0, 94.0, 94.0, 99.0, 105.0], "unit": "score", "name": "imaging-darkroom", "value": 111.6}, {"lowerIsBetter": true, "replicates": [147.0, 151.0, 91.0, 90.0, 92.0, 99.0, 92.0, 91.0, 92.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 103.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 54.0, 55.0, 55.0, 56.0, 58.0, 64.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 68.0, 70.0, 78.0, 75.0, 68.0, 66.0, 65.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 85.0, 85.0, 86.0, 85.0, 88.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [134.0, 133.0, 133.0, 130.0, 133.0, 117.0, 138.0, 125.0, 142.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.5}, {"lowerIsBetter": true, "replicates": [144.0, 145.0, 144.0, 142.0, 142.0, 146.0, 143.0, 146.0, 144.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [72.0, 83.0, 90.0, 92.0, 93.0, 84.0, 66.0, 77.0, 88.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 84.3}], "name": "kraken", "value": 1524.8}]} 01:42:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1524.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7465.31"}}} 01:42:06 INFO - Return code: 0 01:42:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:42:06 ERROR - # TBPL SUCCESS # 01:42:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:42:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:42:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:42:06 INFO - 2016-02-25 01:42:06.762 screenresolution[2988:39385] starting screenresolution argv=screenresolution get 01:42:06 INFO - 2016-02-25 01:42:06.765 screenresolution[2988:39385] Display 0: 1600x1200x32@60 01:42:06 INFO - 2016-02-25 01:42:06.771 screenresolution[2989:39388] starting screenresolution argv=screenresolution list 01:42:06 INFO - Available Modes on Display 0 01:42:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:42:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:42:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:42:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:42:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:42:07 INFO - Intel Iris: 01:42:07 INFO - Chipset Model: Intel Iris 01:42:07 INFO - Type: GPU 01:42:07 INFO - Bus: Built-In 01:42:07 INFO - VRAM (Dynamic, Max): 1536 MB 01:42:07 INFO - Vendor: Intel (0x8086) 01:42:07 INFO - Device ID: 0x0a2e 01:42:07 INFO - Revision ID: 0x0009 01:42:07 INFO - Displays: 01:42:07 INFO - Display: 01:42:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:42:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:42:07 INFO - Display Serial Number: 1600x1200 60 01:42:07 INFO - Main Display: Yes 01:42:07 INFO - Mirror: Off 01:42:07 INFO - Online: Yes 01:42:07 INFO - Rotation: Supported 01:42:07 INFO - Return code: 0 01:42:07 INFO - Running post-action listener: _resource_record_post_action 01:42:07 INFO - Running post-run listener: _resource_record_post_run 01:42:08 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 794624; Write bytes: 713585152; Read time: 12; Write time: 2205 01:42:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404761088; Write bytes: 407062016; Read time: 30258; Write time: 759 01:42:08 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 794624; Write bytes: 305675264; Read time: 12; Write time: 1443 01:42:08 INFO - Running post-run listener: _upload_blobber_files 01:42:08 INFO - Blob upload gear active. 01:42:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:42:08 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 01:42:08 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'] 01:42:08 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 01:42:08 INFO - (blobuploader) - INFO - Open directory for files ... 01:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:09 INFO - (blobuploader) - INFO - Done attempting. 01:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:10 INFO - (blobuploader) - INFO - Done attempting. 01:42:10 INFO - (blobuploader) - INFO - Iteration through files over. 01:42:10 INFO - Return code: 0 01:42:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:42:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:42:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d309528557202279ccb94683ec2f5a5e98af8796a8908379e1f33e26cadfe141a03565ca084757413787472d4e6c52941a3b24b4dd261c5072af6bbc92c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aafd4a0ce3a6dc7edca4186ed813fe444470aab626785e0bfb97bb191af1eb3d2c415a7d137cac3c01db9c953f21fca9e9003e682d24cc927016b323216edf0e"} 01:42:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:42:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:42:10 INFO - Contents: 01:42:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d309528557202279ccb94683ec2f5a5e98af8796a8908379e1f33e26cadfe141a03565ca084757413787472d4e6c52941a3b24b4dd261c5072af6bbc92c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aafd4a0ce3a6dc7edca4186ed813fe444470aab626785e0bfb97bb191af1eb3d2c415a7d137cac3c01db9c953f21fca9e9003e682d24cc927016b323216edf0e"} 01:42:10 INFO - Running post-run listener: copy_logs_to_upload_dir 01:42:10 INFO - Copying logs to upload dir... 01:42:10 INFO - mkdir: /builds/slave/test/build/upload/logs 01:42:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.183056 ========= master_lag: 0.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-25 01:42:11.454106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 01:42:11.457284) ========= 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.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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/d309528557202279ccb94683ec2f5a5e98af8796a8908379e1f33e26cadfe141a03565ca084757413787472d4e6c52941a3b24b4dd261c5072af6bbc92c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aafd4a0ce3a6dc7edca4186ed813fe444470aab626785e0bfb97bb191af1eb3d2c415a7d137cac3c01db9c953f21fca9e9003e682d24cc927016b323216edf0e"} build_url:https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/cDZjAlP-TWK2Si0JXzVUJg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d309528557202279ccb94683ec2f5a5e98af8796a8908379e1f33e26cadfe141a03565ca084757413787472d4e6c52941a3b24b4dd261c5072af6bbc92c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aafd4a0ce3a6dc7edca4186ed813fe444470aab626785e0bfb97bb191af1eb3d2c415a7d137cac3c01db9c953f21fca9e9003e682d24cc927016b323216edf0e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 01:42:11.497857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:42:11.498172) ========= 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.5VdEWymbkh/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.toeJa18Bq3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005248 ========= master_lag: 0.19 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:42:11.688743) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:42:11.689059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:42:11.691520) ========= ========= Total master_lag: 1.74 =========