builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0139 starttime: 1454978162.32 results: success (0) buildid: 20160208154124 builduid: 670bc943487b4b6787ad21d8136ede95 revision: 1a417f2084e103614da87ca4f25bc0d2eb106bcf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.320688) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.321165) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.321487) ========= 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.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005603 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.378830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.379293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.433442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.433716) ========= 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.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005354 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.531562) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.532189) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.533229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.533835) ========= 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.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-08 16:36:02-- 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% 43.7M=0s 2016-02-08 16:36:02 (43.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130955 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.690144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.690445) ========= 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.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.026002 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:02.757816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-08 16:36:02.758116) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a417f2084e103614da87ca4f25bc0d2eb106bcf --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 1a417f2084e103614da87ca4f25bc0d2eb106bcf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-08 16:36:02,838 truncating revision to first 12 chars 2016-02-08 16:36:02,838 Setting DEBUG logging. 2016-02-08 16:36:02,838 attempt 1/10 2016-02-08 16:36:02,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a417f2084e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 16:36:03,839 unpacking tar archive at: fx-team-1a417f2084e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-08 16:36:04.027355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:04.030803) ========= echo 1a417f2084e103614da87ca4f25bc0d2eb106bcf in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1a417f2084e103614da87ca4f25bc0d2eb106bcf'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 1a417f2084e103614da87ca4f25bc0d2eb106bcf program finished with exit code 0 elapsedTime=0.005394 script_repo_revision: '1a417f2084e103614da87ca4f25bc0d2eb106bcf' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:04.080220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:04.080580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 16:36:04.093812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-08 16:36:04.094203) ========= /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.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:04 INFO - MultiFileLogger online at 20160208 16:36:04 in /builds/slave/test 16:36:04 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 16:36:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:04 INFO - {'append_to_log': False, 16:36:04 INFO - 'base_work_dir': '/builds/slave/test', 16:36:04 INFO - 'blob_upload_branch': 'Fx-Team', 16:36:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:04 INFO - 'branch': 'Fx-Team', 16:36:04 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:04 INFO - 'config_files': ('talos/mac_config.py',), 16:36:04 INFO - 'default_actions': ('clobber', 16:36:04 INFO - 'read-buildbot-config', 16:36:04 INFO - 'download-and-extract', 16:36:04 INFO - 'populate-webroot', 16:36:04 INFO - 'create-virtualenv', 16:36:04 INFO - 'install', 16:36:04 INFO - 'run-tests'), 16:36:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:04 INFO - 'download_minidump_stackwalk': True, 16:36:04 INFO - 'download_symbols': 'ondemand', 16:36:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:04 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:04 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:04 INFO - 'installer_path': 'installer.exe', 16:36:04 INFO - 'log_level': 'info', 16:36:04 INFO - 'log_name': 'talos', 16:36:04 INFO - 'log_to_console': True, 16:36:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:36:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:36:04 INFO - 'opt_config_files': (), 16:36:04 INFO - 'pip_index': False, 16:36:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:04 INFO - 'cmd': ('bash', 16:36:04 INFO - '-c', 16:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:04 INFO - 'enabled': True, 16:36:04 INFO - 'halt_on_failure': False, 16:36:04 INFO - 'name': 'check_screen_resolution'},), 16:36:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:04 INFO - 'cmd': ('bash', 16:36:04 INFO - '-c', 16:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:04 INFO - 'enabled': True, 16:36:04 INFO - 'halt_on_failure': False, 16:36:04 INFO - 'name': 'check_screen_resolution'},), 16:36:04 INFO - 'run_cmd_checks_enabled': True, 16:36:04 INFO - 'sps_profile': False, 16:36:04 INFO - 'sps_profile_interval': 0, 16:36:04 INFO - 'suite': 'dromaeojs-e10s', 16:36:04 INFO - 'system_bits': '32', 16:36:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:04 INFO - 'title': 't-yosemite-r7-0139', 16:36:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:04 INFO - 'use_talos_json': True, 16:36:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:04 INFO - 'work_dir': 'build'} 16:36:04 INFO - ##### 16:36:04 INFO - ##### Running clobber step. 16:36:04 INFO - ##### 16:36:04 INFO - Running pre-action listener: _resource_record_pre_action 16:36:04 INFO - Running main action method: clobber 16:36:04 INFO - rmtree: /builds/slave/test/build 16:36:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:05 INFO - Running post-action listener: _resource_record_post_action 16:36:05 INFO - ##### 16:36:05 INFO - ##### Running read-buildbot-config step. 16:36:05 INFO - ##### 16:36:05 INFO - Running pre-action listener: _resource_record_pre_action 16:36:05 INFO - Running main action method: read_buildbot_config 16:36:05 INFO - Using buildbot properties: 16:36:05 INFO - { 16:36:05 INFO - "project": "", 16:36:05 INFO - "product": "firefox", 16:36:05 INFO - "script_repo_revision": "production", 16:36:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:36:05 INFO - "repository": "", 16:36:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:36:05 INFO - "buildid": "20160208154124", 16:36:05 INFO - "pgo_build": "False", 16:36:05 INFO - "basedir": "/builds/slave/test", 16:36:05 INFO - "buildnumber": 330, 16:36:05 INFO - "slavename": "t-yosemite-r7-0139", 16:36:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:36:05 INFO - "platform": "yosemite_r7", 16:36:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:36:05 INFO - "branch": "fx-team", 16:36:05 INFO - "repo_path": "integration/fx-team", 16:36:05 INFO - "revision": "1a417f2084e103614da87ca4f25bc0d2eb106bcf", 16:36:05 INFO - "stage_platform": "macosx64", 16:36:05 INFO - "builduid": "670bc943487b4b6787ad21d8136ede95", 16:36:05 INFO - "slavebuilddir": "test" 16:36:05 INFO - } 16:36:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:36:05 INFO - Running post-action listener: _resource_record_post_action 16:36:05 INFO - ##### 16:36:05 INFO - ##### Running download-and-extract step. 16:36:05 INFO - ##### 16:36:05 INFO - Running pre-action listener: _resource_record_pre_action 16:36:05 INFO - Running main action method: download_and_extract 16:36:05 INFO - mkdir: /builds/slave/test/build/tests 16:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:05 INFO - https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/test_packages.json 16:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/test_packages.json 16:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:36:07 INFO - Downloaded 1277 bytes. 16:36:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:36:07 INFO - Using the following test package requirements: 16:36:07 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:07 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:36:07 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:36:07 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'jsshell-mac.zip'], 16:36:07 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:36:07 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:07 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:36:07 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:36:07 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:36:07 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:07 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:07 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:36:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:36:07 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')]} 16:36:07 INFO - https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/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 16:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/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 16:36:09 INFO - Downloaded 17753825 bytes. 16:36:09 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'] 16:36:09 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 16:36:12 INFO - Return code: 0 16:36:12 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 16:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:36:12 INFO - https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/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 16:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/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 16:36:19 INFO - Downloaded 17753825 bytes. 16:36:19 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'] 16:36:19 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 16:36:23 INFO - Return code: 0 16:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:23 INFO - https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:36:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:36:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:36:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/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 16:36:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/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 16:36:24 INFO - Downloaded 10706547 bytes. 16:36:24 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'] 16:36:24 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 16:36:24 INFO - Return code: 0 16:36:24 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')]} 16:36:24 INFO - https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:36:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QP-RQcENTjabns3Qv59Z1g/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 16:36:29 INFO - Downloaded 111833373 bytes. 16:36:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:29 INFO - mkdir: /builds/slave/test/properties 16:36:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:29 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:29 INFO - Contents: 16:36:29 INFO - build_url:https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:31 INFO - Running post-action listener: _resource_record_post_action 16:36:31 INFO - Running post-action listener: set_extra_try_arguments 16:36:31 INFO - ##### 16:36:31 INFO - ##### Running populate-webroot step. 16:36:31 INFO - ##### 16:36:31 INFO - Running pre-action listener: _resource_record_pre_action 16:36:31 INFO - Running main action method: populate_webroot 16:36:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:31 INFO - '--tppagecycles', 16:36:31 INFO - '7'], 16:36:31 INFO - 'tests': ['tsvgm']}}, 16:36:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:36:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:36:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:36:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'tests': ['damp', 'tps']}, 16:36:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['damp', 'tps']}, 16:36:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:36:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:31 INFO - 'other': {'tests': ['a11yr', 16:36:31 INFO - 'ts_paint', 16:36:31 INFO - 'tpaint', 16:36:31 INFO - 'sessionrestore', 16:36:31 INFO - 'sessionrestore_no_auto_restore']}, 16:36:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['a11yr', 16:36:31 INFO - 'ts_paint', 16:36:31 INFO - 'tpaint', 16:36:31 INFO - 'sessionrestore', 16:36:31 INFO - 'sessionrestore_no_auto_restore']}, 16:36:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['a11yr', 16:36:31 INFO - 'ts_paint', 16:36:31 INFO - 'tpaint', 16:36:31 INFO - 'sessionrestore', 16:36:31 INFO - 'sessionrestore_no_auto_restore']}, 16:36:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['a11yr', 16:36:31 INFO - 'ts_paint', 16:36:31 INFO - 'tpaint', 16:36:31 INFO - 'sessionrestore', 16:36:31 INFO - 'sessionrestore_no_auto_restore']}, 16:36:31 INFO - 'other_l64': {'tests': ['a11yr', 16:36:31 INFO - 'ts_paint', 16:36:31 INFO - 'tpaint', 16:36:31 INFO - 'sessionrestore', 16:36:31 INFO - 'sessionrestore_no_auto_restore']}, 16:36:31 INFO - 'other_nol64': {'tests': ['a11yr', 16:36:31 INFO - 'ts_paint', 16:36:31 INFO - 'tpaint', 16:36:31 INFO - 'sessionrestore', 16:36:31 INFO - 'sessionrestore_no_auto_restore']}, 16:36:31 INFO - 'svgr': {'tests': ['tsvgx', 16:36:31 INFO - 'tsvgr_opacity', 16:36:31 INFO - 'tart', 16:36:31 INFO - 'tscrollx', 16:36:31 INFO - 'cart']}, 16:36:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['tsvgx', 16:36:31 INFO - 'tsvgr_opacity', 16:36:31 INFO - 'tart', 16:36:31 INFO - 'tscrollx', 16:36:31 INFO - 'cart']}, 16:36:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'tests': ['tp5o']}, 16:36:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'talos_options': ['--e10s'], 16:36:31 INFO - 'tests': ['tp5o']}, 16:36:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'talos_options': ['--xperf_path', 16:36:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:31 INFO - 'tests': ['tp5n']}, 16:36:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:31 INFO - 'talos_options': ['--e10s', 16:36:31 INFO - '--xperf_path', 16:36:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:31 INFO - 'tests': ['tp5n']}}, 16:36:31 INFO - 'talos.zip': {'path': '', 16:36:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:31 INFO - Running post-action listener: _resource_record_post_action 16:36:31 INFO - ##### 16:36:31 INFO - ##### Running create-virtualenv step. 16:36:31 INFO - ##### 16:36:31 INFO - Running pre-action listener: _resource_record_pre_action 16:36:31 INFO - Running main action method: create_virtualenv 16:36:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:31 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 16:36:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:31 INFO - Using real prefix '/tools/python27' 16:36:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:31 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:34 INFO - Installing pip.................done. 16:36:34 INFO - Return code: 0 16:36:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:34 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:34 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 16:36:34 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 16:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:34 INFO - 'HOME': '/Users/cltbld', 16:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:34 INFO - 'LOGNAME': 'cltbld', 16:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:34 INFO - 'MOZ_NO_REMOTE': '1', 16:36:34 INFO - 'NO_EM_RESTART': '1', 16:36:34 INFO - 'PAGER': '/bin/cat', 16:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:34 INFO - 'PWD': '/builds/slave/test', 16:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:34 INFO - 'SHELL': '/bin/bash', 16:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:34 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:34 INFO - 'USER': 'cltbld', 16:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:34 INFO - 'XPC_FLAGS': '0x0', 16:36:34 INFO - 'XPC_SERVICE_NAME': '0', 16:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:35 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 16:36:35 INFO - Cleaning up... 16:36:35 INFO - Return code: 0 16:36:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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', '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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:36: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 psutil>=0.7.1 16:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:35 INFO - 'HOME': '/Users/cltbld', 16:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:35 INFO - 'LOGNAME': 'cltbld', 16:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:35 INFO - 'MOZ_NO_REMOTE': '1', 16:36:35 INFO - 'NO_EM_RESTART': '1', 16:36:35 INFO - 'PAGER': '/bin/cat', 16:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:35 INFO - 'PWD': '/builds/slave/test', 16:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:35 INFO - 'SHELL': '/bin/bash', 16:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:35 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:35 INFO - 'USER': 'cltbld', 16:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:35 INFO - 'XPC_FLAGS': '0x0', 16:36:35 INFO - 'XPC_SERVICE_NAME': '0', 16:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:35 INFO - Downloading/unpacking psutil>=0.7.1 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:38 INFO - Installing collected packages: psutil 16:36:38 INFO - Running setup.py install for psutil 16:36:38 INFO - building 'psutil._psutil_osx' extension 16:36:38 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 16:36:39 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 16:36:39 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 16:36:39 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 16:36:39 INFO - building 'psutil._psutil_posix' extension 16:36:39 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 16:36:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:36:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:36:39 INFO - ^ 16:36:39 INFO - 1 warning generated. 16:36:39 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 16:36:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:39 INFO - Successfully installed psutil 16:36:39 INFO - Cleaning up... 16:36:39 INFO - Return code: 0 16:36:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:36:39 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')]} 16:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:39 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')]} 16:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:39 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:39 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 16:36:39 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 16:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:39 INFO - 'HOME': '/Users/cltbld', 16:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:39 INFO - 'LOGNAME': 'cltbld', 16:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:39 INFO - 'MOZ_NO_REMOTE': '1', 16:36:39 INFO - 'NO_EM_RESTART': '1', 16:36:39 INFO - 'PAGER': '/bin/cat', 16:36:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:39 INFO - 'PWD': '/builds/slave/test', 16:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:39 INFO - 'SHELL': '/bin/bash', 16:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:39 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:39 INFO - 'USER': 'cltbld', 16:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:39 INFO - 'XPC_FLAGS': '0x0', 16:36:39 INFO - 'XPC_SERVICE_NAME': '0', 16:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:36:42 INFO - Installing collected packages: mozsystemmonitor 16:36:42 INFO - Running setup.py install for mozsystemmonitor 16:36:42 INFO - Successfully installed mozsystemmonitor 16:36:42 INFO - Cleaning up... 16:36:42 INFO - Return code: 0 16:36:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:42 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:42 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 16:36:42 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 16:36:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:42 INFO - 'HOME': '/Users/cltbld', 16:36:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:42 INFO - 'LOGNAME': 'cltbld', 16:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:42 INFO - 'MOZ_NO_REMOTE': '1', 16:36:42 INFO - 'NO_EM_RESTART': '1', 16:36:42 INFO - 'PAGER': '/bin/cat', 16:36:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:42 INFO - 'PWD': '/builds/slave/test', 16:36:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:42 INFO - 'SHELL': '/bin/bash', 16:36:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:42 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:42 INFO - 'USER': 'cltbld', 16:36:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:42 INFO - 'XPC_FLAGS': '0x0', 16:36:42 INFO - 'XPC_SERVICE_NAME': '0', 16:36:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:42 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 16:36:42 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 16:36:42 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 16:36:42 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 16:36:42 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 16:36:42 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 16:36:45 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:45 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 16:36:45 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 16:36:45 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 16:36:45 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 16:36:45 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 16:36:45 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 16:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:45 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 16:36:45 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 16:36:45 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 16:36:45 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 16:36:45 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 16:36:45 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 16:36:46 INFO - Downloading docopt-0.6.1.tar.gz 16:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:46 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:46 INFO - Running setup.py install for blobuploader 16:36:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:46 INFO - Running setup.py install for requests 16:36:47 INFO - Running setup.py install for docopt 16:36:47 INFO - Successfully installed blobuploader requests docopt 16:36:47 INFO - Cleaning up... 16:36:47 INFO - Return code: 0 16:36:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:47 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:47 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 16:36:47 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 16:36:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:47 INFO - 'HOME': '/Users/cltbld', 16:36:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:47 INFO - 'LOGNAME': 'cltbld', 16:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:47 INFO - 'MOZ_NO_REMOTE': '1', 16:36:47 INFO - 'NO_EM_RESTART': '1', 16:36:47 INFO - 'PAGER': '/bin/cat', 16:36:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:47 INFO - 'PWD': '/builds/slave/test', 16:36:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:47 INFO - 'SHELL': '/bin/bash', 16:36:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:47 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:47 INFO - 'USER': 'cltbld', 16:36:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:47 INFO - 'XPC_FLAGS': '0x0', 16:36:47 INFO - 'XPC_SERVICE_NAME': '0', 16:36:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:47 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9YnyAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:47 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ShQUF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:47 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-IJoJbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:47 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-G2Li9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-QHPmLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-xC7c_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-QBx1KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-BffP_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-99xfjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-_mm25K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-oNhG9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-6QG8M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-rDYhZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-MUhUrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-86Hhp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9adyfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-HBcVpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:49 INFO - Running setup.py install for manifestparser 16:36:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:49 INFO - Running setup.py install for mozcrash 16:36:49 INFO - Running setup.py install for mozdebug 16:36:49 INFO - Running setup.py install for mozdevice 16:36:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:36:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:49 INFO - Running setup.py install for mozfile 16:36:50 INFO - Running setup.py install for mozhttpd 16:36:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Running setup.py install for mozinfo 16:36:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Running setup.py install for mozInstall 16:36:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Running setup.py install for mozleak 16:36:50 INFO - Running setup.py install for mozlog 16:36:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Running setup.py install for moznetwork 16:36:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:50 INFO - Running setup.py install for mozprocess 16:36:51 INFO - Running setup.py install for mozprofile 16:36:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:51 INFO - Running setup.py install for mozrunner 16:36:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:51 INFO - Running setup.py install for mozscreenshot 16:36:51 INFO - Running setup.py install for moztest 16:36:51 INFO - Running setup.py install for mozversion 16:36:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:51 INFO - Cleaning up... 16:36:51 INFO - Return code: 0 16:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:51 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')]} 16:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:51 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')]} 16:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:51 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:51 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 16:36:51 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 16:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:51 INFO - 'HOME': '/Users/cltbld', 16:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:51 INFO - 'LOGNAME': 'cltbld', 16:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:51 INFO - 'MOZ_NO_REMOTE': '1', 16:36:51 INFO - 'NO_EM_RESTART': '1', 16:36:51 INFO - 'PAGER': '/bin/cat', 16:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:51 INFO - 'PWD': '/builds/slave/test', 16:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:51 INFO - 'SHELL': '/bin/bash', 16:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:51 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:51 INFO - 'USER': 'cltbld', 16:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:51 INFO - 'XPC_FLAGS': '0x0', 16:36:51 INFO - 'XPC_SERVICE_NAME': '0', 16:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-0X7tl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-pzh5aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-VEOHk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gSFZPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-cYFdm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-aYlzcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-h1sThW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-CzZJE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-dTv0Zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-bwtZqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-jSWFw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-6PH6du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-LmWu1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-IvY0jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-6Z6T4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-v1lCJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:53 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)) 16:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:53 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-JN3s95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:53 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)) 16:36:53 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)) 16:36:53 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)) 16:36:53 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)) 16:36:53 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)) 16:36:53 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)) 16:36:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:54 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 16:36:54 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 16:36:54 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 16:36:54 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 16:36:54 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 16:36:54 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 16:36:56 INFO - Downloading blessings-1.6.tar.gz 16:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:56 INFO - Installing collected packages: blessings 16:36:56 INFO - Running setup.py install for blessings 16:36:56 INFO - Successfully installed blessings 16:36:56 INFO - Cleaning up... 16:36:56 INFO - Return code: 0 16:36:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:56 INFO - Reading from file tmpfile_stdout 16:36:56 INFO - Current package versions: 16:36:56 INFO - blessings == 1.6 16:36:56 INFO - blobuploader == 1.2.4 16:36:56 INFO - docopt == 0.6.1 16:36:56 INFO - manifestparser == 1.1 16:36:56 INFO - mozInstall == 1.12 16:36:56 INFO - mozcrash == 0.16 16:36:56 INFO - mozdebug == 0.1 16:36:56 INFO - mozdevice == 0.48 16:36:56 INFO - mozfile == 1.2 16:36:56 INFO - mozhttpd == 0.7 16:36:56 INFO - mozinfo == 0.9 16:36:56 INFO - mozleak == 0.1 16:36:56 INFO - mozlog == 3.1 16:36:56 INFO - moznetwork == 0.27 16:36:56 INFO - mozprocess == 0.22 16:36:56 INFO - mozprofile == 0.28 16:36:56 INFO - mozrunner == 6.11 16:36:56 INFO - mozscreenshot == 0.1 16:36:56 INFO - mozsystemmonitor == 0.0 16:36:56 INFO - moztest == 0.7 16:36:56 INFO - mozversion == 1.4 16:36:56 INFO - psutil == 3.1.1 16:36:56 INFO - requests == 1.2.3 16:36:56 INFO - wsgiref == 0.1.2 16:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:56 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:56 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 16:36:56 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 16:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:56 INFO - 'HOME': '/Users/cltbld', 16:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:56 INFO - 'LOGNAME': 'cltbld', 16:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:56 INFO - 'MOZ_NO_REMOTE': '1', 16:36:56 INFO - 'NO_EM_RESTART': '1', 16:36:56 INFO - 'PAGER': '/bin/cat', 16:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:56 INFO - 'PWD': '/builds/slave/test', 16:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:56 INFO - 'SHELL': '/bin/bash', 16:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:56 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:56 INFO - 'USER': 'cltbld', 16:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:56 INFO - 'XPC_FLAGS': '0x0', 16:36:56 INFO - 'XPC_SERVICE_NAME': '0', 16:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 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)) 16:36:57 INFO - Cleaning up... 16:36:57 INFO - Return code: 0 16:36:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:57 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:36:57 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 16:36:57 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 16:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:57 INFO - 'HOME': '/Users/cltbld', 16:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:57 INFO - 'LOGNAME': 'cltbld', 16:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:57 INFO - 'MOZ_NO_REMOTE': '1', 16:36:57 INFO - 'NO_EM_RESTART': '1', 16:36:57 INFO - 'PAGER': '/bin/cat', 16:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:57 INFO - 'PWD': '/builds/slave/test', 16:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:57 INFO - 'SHELL': '/bin/bash', 16:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:36:57 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:57 INFO - 'USER': 'cltbld', 16:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:57 INFO - 'XPC_FLAGS': '0x0', 16:36:57 INFO - 'XPC_SERVICE_NAME': '0', 16:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:57 INFO - Downloading/unpacking jsonschema 16:36:57 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 16:36:57 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 16:36:57 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 16:36:57 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 16:36:57 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 16:36:57 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 16:36:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:36:59 INFO - Downloading/unpacking functools32 (from jsonschema) 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:37:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:00 INFO - warning: no files found matching '*.txt' 16:37:00 INFO - no previously-included directories found matching 'build' 16:37:00 INFO - no previously-included directories found matching 'dist' 16:37:00 INFO - no previously-included directories found matching '.git*' 16:37:00 INFO - Installing collected packages: jsonschema, functools32 16:37:00 INFO - Running setup.py install for functools32 16:37:00 INFO - warning: no files found matching '*.txt' 16:37:00 INFO - no previously-included directories found matching 'build' 16:37:00 INFO - no previously-included directories found matching 'dist' 16:37:00 INFO - no previously-included directories found matching '.git*' 16:37:00 INFO - Successfully installed jsonschema functools32 16:37:00 INFO - Cleaning up... 16:37:00 INFO - Return code: 0 16:37:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37:00 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')]} 16:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:00 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')]} 16:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:00 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 0x103b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9f95768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, '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.VO5SMPaZQY/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.DcRej5K8r3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 16:37:00 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 16:37:00 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 16:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:00 INFO - 'HOME': '/Users/cltbld', 16:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:00 INFO - 'LOGNAME': 'cltbld', 16:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:00 INFO - 'MOZ_NO_REMOTE': '1', 16:37:00 INFO - 'NO_EM_RESTART': '1', 16:37:00 INFO - 'PAGER': '/bin/cat', 16:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:00 INFO - 'PWD': '/builds/slave/test', 16:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:00 INFO - 'SHELL': '/bin/bash', 16:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:37:00 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:00 INFO - 'USER': 'cltbld', 16:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:00 INFO - 'XPC_FLAGS': '0x0', 16:37:00 INFO - 'XPC_SERVICE_NAME': '0', 16:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:00 INFO - Downloading/unpacking flake8 16:37:00 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 16:37:00 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 16:37:00 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 16:37:00 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 16:37:00 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 16:37:00 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 16:37:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:03 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 16:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:04 INFO - no previously-included directories found matching 'docs/_build' 16:37:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:04 INFO - Running setup.py install for pep8 16:37:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:04 INFO - no previously-included directories found matching 'docs/_build' 16:37:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:04 INFO - Cleaning up... 16:37:04 INFO - Return code: 0 16:37:04 INFO - Running post-action listener: _resource_record_post_action 16:37:04 INFO - Running post-action listener: _start_resource_monitoring 16:37:04 INFO - Starting resource monitoring. 16:37:04 INFO - ##### 16:37:04 INFO - ##### Running install step. 16:37:04 INFO - ##### 16:37:04 INFO - Running pre-action listener: _resource_record_pre_action 16:37:04 INFO - Running main action method: install 16:37:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:05 INFO - Reading from file tmpfile_stdout 16:37:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:05 INFO - Reading from file tmpfile_stdout 16:37:05 INFO - Output received: 16:37:05 INFO - Usage: mozinstall [options] installer 16:37:05 INFO - Options: 16:37:05 INFO - -h, --help show this help message and exit 16:37:05 INFO - -d DEST, --destination=DEST 16:37:05 INFO - Directory to install application into. [default: 16:37:05 INFO - "/builds/slave/test"] 16:37:05 INFO - --app=APP Application being installed. [default: firefox] 16:37:05 INFO - mkdir: /builds/slave/test/build/application 16:37:05 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'] 16:37:05 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 16:37:39 INFO - Reading from file tmpfile_stdout 16:37:39 INFO - Output received: 16:37:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:37:39 INFO - Running post-action listener: _resource_record_post_action 16:37:39 INFO - ##### 16:37:39 INFO - ##### Running run-tests step. 16:37:39 INFO - ##### 16:37:39 INFO - Running pre-action listener: _resource_record_pre_action 16:37:39 INFO - Running main action method: run_tests 16:37:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:37:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:37:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:37:39 INFO - 2016-02-08 16:37:39.757 screenresolution[1655:7531] starting screenresolution argv=screenresolution get 16:37:39 INFO - 2016-02-08 16:37:39.760 screenresolution[1655:7531] Display 0: 1600x1200x32@60 16:37:39 INFO - 2016-02-08 16:37:39.766 screenresolution[1656:7533] starting screenresolution argv=screenresolution list 16:37:39 INFO - Available Modes on Display 0 16:37:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:37:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:37:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:37:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:37:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:37:39 INFO - Intel Iris: 16:37:39 INFO - Chipset Model: Intel Iris 16:37:39 INFO - Type: GPU 16:37:39 INFO - Bus: Built-In 16:37:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:37:39 INFO - Vendor: Intel (0x8086) 16:37:39 INFO - Device ID: 0x0a2e 16:37:39 INFO - Revision ID: 0x0009 16:37:39 INFO - Displays: 16:37:39 INFO - Display: 16:37:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:37:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:37:39 INFO - Display Serial Number: 1600x1200 60 16:37:39 INFO - Main Display: Yes 16:37:39 INFO - Mirror: Off 16:37:39 INFO - Online: Yes 16:37:39 INFO - Rotation: Supported 16:37:39 INFO - Return code: 0 16:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:37:40 INFO - Python 2.7.3 16:37:40 INFO - Return code: 0 16:37:40 INFO - grabbing minidump binary from tooltool 16:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:40 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 0x1039a7d30>, '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 0x1037cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10399eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:37:40 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 16:37:40 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 16:37:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:37:40 INFO - Return code: 0 16:37:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:37:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:37:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:37:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:37:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:37:41 INFO - Return code: 0 16:37:41 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/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 16:37:41 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/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --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 16:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VO5SMPaZQY/Render', 16:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:41 INFO - 'HOME': '/Users/cltbld', 16:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:41 INFO - 'LOGNAME': 'cltbld', 16:37:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:37:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:41 INFO - 'MOZ_NO_REMOTE': '1', 16:37:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:37:41 INFO - 'NO_EM_RESTART': '1', 16:37:41 INFO - 'PAGER': '/bin/cat', 16:37:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:41 INFO - 'PWD': '/builds/slave/test', 16:37:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:41 INFO - 'SHELL': '/bin/bash', 16:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcRej5K8r3/Listeners', 16:37:41 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 16:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:41 INFO - 'USER': 'cltbld', 16:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:41 INFO - 'XPC_FLAGS': '0x0', 16:37:41 INFO - 'XPC_SERVICE_NAME': '0', 16:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:41 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/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 16:37:41 INFO - mozversion application_buildid: 20160208154124 16:37:41 INFO - mozversion application_changeset: 1a417f2084e103614da87ca4f25bc0d2eb106bcf 16:37:41 INFO - mozversion application_display_name: Nightly 16:37:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:37:41 INFO - mozversion application_name: Firefox 16:37:41 INFO - mozversion application_remotingname: firefox 16:37:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:37:41 INFO - mozversion application_vendor: Mozilla 16:37:41 INFO - mozversion application_version: 47.0a1 16:37:41 INFO - mozversion platform_buildid: 20160208154124 16:37:41 INFO - mozversion platform_changeset: 1a417f2084e103614da87ca4f25bc0d2eb106bcf 16:37:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:37:41 INFO - mozversion platform_version: 47.0a1 16:37:41 INFO - using testdate: 1454978261 16:37:41 INFO - actual date: 1454978261 16:37:41 INFO - starting webserver on 'localhost:49274' 16:37:41 INFO - SUITE-START | Running 2 tests 16:37:41 INFO - TEST-START | dromaeo_css 16:37:41 INFO - operating with platform_type : mac_ 16:37:41 INFO - Initialising browser for dromaeo_css test... 16:37:41 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmp6BxFJx/profile http://localhost:49274/getInfo.html) 16:37:44 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 16:37:44 INFO - PROCESS | 1674 | colorDepth:24 16:37:44 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 16:37:44 INFO - PROCESS | 1674 | __metrics 16:37:45 INFO - TEST-INFO | 1674: exit 0 16:37:45 INFO - Browser initialized. 16:37:45 INFO - Running cycle 1/1 for dromaeo_css test... 16:37:45 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmp6BxFJx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:57 INFO - PROCESS | 1678 | RSS: Main: 259186688 16:37:57 INFO - PROCESS | 1678 | 16:38:46 INFO - PROCESS | 1678 | 1454978326892 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] 16:40:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 16:40:58 INFO - PROCESS | 1678 | RSS: Main: 271081472 16:40:58 INFO - PROCESS | 1678 | 16:44:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 16:44:01 INFO - PROCESS | 1678 | RSS: Main: 283697152 16:44:01 INFO - PROCESS | 1678 | 16:47:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 16:47:03 INFO - PROCESS | 1678 | RSS: Main: 284905472 16:47:03 INFO - PROCESS | 1678 | 16:50:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 16:50:05 INFO - PROCESS | 1678 | RSS: Main: 287031296 16:50:05 INFO - PROCESS | 1678 | 16:53:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 16:53:09 INFO - PROCESS | 1678 | RSS: Main: 288542720 16:53:09 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 16:56:11 INFO - PROCESS | 1678 | RSS: Main: 292020224 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | __start_tp_report 16:56:11 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 16:56:11 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 16:56:11 INFO - PROCESS | 1678 | |i|pagename|runs| 16:56:11 INFO - PROCESS | 1678 | |0;dojo.html;2996.220982544538;3539.6814286714193;3562.44782058781;3627.3833448313785;3629.473726309685;5716.657000579958;5716.885662286762;5785.797497087598;5844.298684157901;5848.239728835246;5667.206591077253;5803.6227645203035;5844.707764611774;5864.648121112737;5934.347221805598;5177.741112944356;5204.557612602934;5205.479452054802;5282.867928301804;5291.629585928987;5146.228065790124;5264.341957255343;5265.157574788034;5295.020421222086;5333.986542556921;5180.4042535108565;5240.978009288209;5275.815346462856;5279.260903473517;5283.524482796528;5224.164133738622;5237.869053273661;5263.26314315996;5281.551068159211;5300.284461597674;5096.974515127437;5171.4052883918075;5248.685078895279;5270.39390470097;5295.020421222048;5591;5707.429257074301;5732.971335143339;5750.884982300372;5762.510186634141;6262.624242545417;6320.178376811031;6322.051692246154;6335.239771227436;6362.204724409449;6180.412860778219;6192.690365481753;6242.219722534684;6255.906161407583;6278.843028924313;5935.6438613682885;5971.156948891728;5986.281646202397;5986.610870293417;6009.6394216346725;6119.228375855631;6274.749010039639;6293.465055470245;6309.968450157719;6360.936390636127;6210.658413787195;6233.3143354231;6233.906491402633;6245.718942647592;6246.031865060922;5370.791571896292;6141.539384546177;6263.248410190807;6284.811455656338;6317.936820631735;5399.622026458189;6101.822802906922;6206.162168107338;6272.059191121369;6282.874342513124;6208.21299007605;6237.625742455467;6254.562180647402;6263.624182548971;6298.779542715983;3937.7637341759587;4428.025834316445;4865.245886887538;4965.801367945314;4995.25071239317;4393.51671316155;4449.443819522559;4459.0858873930765;4471.195184866755;4484.977575112103;5418.91871621926;5772.855678608068;5853.5317174625925;5879.470847623649;5904.852378690567;6188.8762224755255;6236.064590311489;6238.781642642486;6305.243370795534;6308.810735677937;5845.240118784531;5922.3485416604135;5930.733117009745;5937.821865344046;5945.554083443759;5366.2755528004;5397.379301380313;5399.70301633414;5407.594430417735;5411.972940135274;5475.370332411823;6275.121482992385;6361.777337793155;6399.712012959428;6407.295197528269;6219.117142132099;6263.029230469285;6287.056941458818;6296.433321001132;6297.8663840507315;6393;6407.455366293917;6448.871022579616;6452.774152904626;6479.060536222127;5032.597392208541;6182.690865456799;6282.2147231596055;6287.654179020198;6318.147050148171;6115.694215289129;6220.253569571681;6237.126802247598;6257.624542527463;6262.968685156545;6106.511479081574;6145.446909778141;6221.5333849960525;6224.782132625517;6244.406781355764;6190.164327815687;6239.844003899939;6259.7496100157305;6260.373962603885;6272.153259309935;5222.634415590872;6096.9390306096375;6106.084087386927;6108.51131909455;6138.048602466625;6076.726547305293;6105.550726437353;6191.504679625709;6204.255489341308;6217;6057.990853991232;6099.573029887865;6112.6640074008;6128.32588415265;6139.29398119222 16:56:11 INFO - PROCESS | 1678 | |1;ext.html;459.48996613758743;462.7269910752655;463.2287241742497;473.7915317260405;567.8637127089498;37335;37690.246195076084;37725.24549509015;37774.24451510971;37839.810800945954;30604;39560.80219598898;39590.60409395905;39610.40584391229;39688.20623587527;9360.344775865693;9464.526773661324;9540.80918381632;9549.952250238739;9624.422534647909;9454.669086581936;9668.371555848882;9703.611855525805;9709.75725606862;9712.757181070494;9654.758631034245;9660.275479339043;9695.660651877186;9731.95134024329;9755.560999755027;9615.855762163574;9655.565499552536;9685.564149613214;9704.66033688821;9717.56270967801;9573.329866909318;9699.078587534173;9704.175145112675;9705.466199359033;9731.075547822946;38173.61826381728;38270.80864595659;38351.84944451671;38372.616273837186;38743.031424214336;2306.8385213035094;3199.2961548459302;3210.7752457327997;3215;3427.9143021424416;27320.863395683093;27371.863140684367;27456.725432745618;27592;27628;2690.045034012917;2696.703362630109;2702.216357256393;2800.9019684311156;2876.2377969838008;330211;331329;332159.33920330484;332365;333573;49138;54769;57269;62402.68798656068;66849;63830.68084659547;64536.677316614056;64826;65120;65202;13795.586132416043;14670.706585868224;15627.921860390625;16341.673166536602;16553.834461655228;9902.950485247527;12077.818832717516;12436.37818109091;12555.623331300076;12824.487020519075;17010.489685309214;20356.491087722927;21068.15727370888;21257.78742212589;21293.36119916405;7782.610869456617;8972.730818075468;9164.404313719588;9229.353945223904;9260.536973151315;926.342296969146;973.8295798235281;1006.8238058339762;1052.2476429353048;1078.9190810689229;23309.883450582638;26282.211533654023;27762.583561246596;28245.29386765306;28323;1063.8563793887727;1104.7072525780675;1106.3846783695733;1107.7175320293275;1205.9939700301618;14327.426902923766;14370.425182992563;14392.640183995483;14451.349689264009;14665.706685866437;542639;549353;550616;552942;553863;55115.622109447584;56579.43420565824;57397;57398.13902791378;58178;1409.661681196526;1446.0528353928194;1459.649684075814;1464.6777708904237;1468.7649976003788;23783.643245350988;28555.337928422403;28939.276518087216;28997;29165.562516561844;49857.25214121864;49905;50253.497465024884;50353.992920142126;50571;513163.8683613116;515859;516647;517996.87010954437;519427;30396.5440518388;30850.537241941838;31052.844735776176;31363;31459;44196.33705494356;44662.10675786531;44803;44842.115699202164;45245;36771.63228367682;38041.61958380381;38362;40783.38824917688;41758.791206043774;37751.86744397673;38396.94428099769;39047.41428878626;39881.401778973915;40120;39123.217535649695;39726.006849828984;40077.398839018024;40288.59711402848;40412.59587404088;37403.06492337604;37589.872303830925;38744.41883371808;39389.409158862065;40279.3958090623;25901.740982589934;26248.475030499663;26323.341916452242;26756.732432675424;26901.865490672422 16:56:11 INFO - PROCESS | 1678 | |2;jquery.html;361.0630414075475;367.2618037744134;368.4399712437095;371.09452934838976;371.4947671167212;15200.771988420183;15352;18559.699366851408;19602.803971960275;19921.701174482394;16000.159981602119;18824.623507529843;19153.425397238105;19204.711929321038;19429.417117486464;4166.64583510402;5141.897162056766;5752.568557358194;5764.193012978187;5773.191753154561;6088.208532890718;6362.427381535661;6433.485321174295;6443.226812782473;6445.452136568398;6109.083637454395;6327.651979141146;6421.036844473343;6421.523049698549;6450.967745161268;6114.327423983358;6318.842028949267;6349.8412539686415;6357.93642063578;6362.936370636327;4657.5575320344515;5507.394186639466;5537.556995440395;5537.667739935577;5547.55619550435;24160.637590436156;24341.87829060861;24809;24980.750192498024;25053.248402547953;2151.268568686654;2172.196287373682;2284.063667902501;2474.34429876083;2539.4540173862524;11982;14302.78426333763;14381.928090359586;14663;14775.113493190443;1574.559123445437;1751.9824801751947;1779.0748810618536;1804.6751584714746;1834.5046837353839;92858.5357073217;94537.58193627102;94934.52532737292;96076.9999999993;97584;10318.638847640297;10675.199360048027;10698.197635177392;10741.248112632196;10773.353598784099;12525.248485090924;12564.560240391542;12628.484581850236;12657.746845063048;12734.108612397044;8495.872561911576;8501.277391421798;8523.701670441505;8551.572421378905;8606.87089693655;8596.441231319945;8712.21590056898;8728.996165440929;8767.780805479786;8808.339374546806;5591.664500130005;5908.3205431375945;6055.182550355734;6084.330723620398;6122.173506576555;1810.5021119192327;1850.0194896704768;1865.3471285050123;1871.9251229950921;1888.3202047262973;903.1149473515991;927.8051609162017;956.9856452153223;974.9519266788232;1013.6198925402974;14569.344379502947;15165.772513412308;18834.905825470785;18885.15016824246;19110.426687199408;844.7085755414372;925.2829057480371;930.065284389198;984.675057231112;1013.0477351289765;10130.594776208869;10293.33093348945;10349;10497.055265026032;10585.682429527127;735709;740257;745757;746794;748774;117581;120245.39877300558;121724;121732;124085;1140.201858698914;1171.1275100050516;1173.859136903577;1190.934498602585;1193.516625766566;17285.962842229506;17328.220230089424;17347;17352.39266625662;17419.8677085989;48618;49660.75848103826;50246.995060099325;50573.74713126558;51427.74286128546;73152.63423682848;75698;76012.47975040358;76228;76617;7361.153467351109;7414.184439711519;7539.73610923637;7762.3790096793255;7857.371410287277;11347.37589432589;11893.643190704293;12081;12128.414986741995;12153.513859445524;10392.272540922062;10436.217283703905;10443.477826108816;10541.998510141524;10609.840852387066;8937.195652391316;9893.109620134222;10354.948225258826;10472.947635261775;10475.476226188812;9989.350692204984;10245.897541024495;10746.408947507962;10783.19126065564;11036.724081898017;7670.463067585216;7682.539047657158;7684.500507466997;7687.423443241667;7752.302292793675;8959.014508404201;9699.6120155193;10794.838077428687;10823.404712740874;10900.400477973788 16:56:11 INFO - PROCESS | 1678 | |3;mootools.html;1510.493984515187;1512.6747749233916;1750.5798608334003;1898.4020033689396;1915.528967631755;7538.396928245741;7579.20418356073;8075.919240807605;8837.293016558677;8993.415427997184;8729.607167677454;8830.646774129027;8830.91169088309;8873.600687969041;8902.154295341948;2116.343933380657;2506.7493250674925;2524.3815265260037;2543.567593509108;2551.2728872271405;2491.6636254105647;2524.1039431002005;2527.911523096692;2539.085929065535;2546;2094.8114669679726;2199.230269405703;2471.270975062361;2493.551160791057;2576.8325058871114;2478.6901637295337;2482.391814005571;2519.924402267935;2522.5963845784586;2552.489502099578;2495.2264797912526;2513.082724805433;2518.4711210645787;2520.6471094046847;2528.3679080229945;8540.530270835101;8600.913990860074;8628.396012279143;8709.303255739589;8723.432976856548;4767.951050768826;5137.152369858969;5412.891742165174;5454.3454785426;5600.5519558435635;3629.872954446582;3662.322470342995;3727.627237276278;3745.325841348556;3749.8312575934146;1056.6037735849056;1062.659948816379;1089.1776708585046;1094.4254266510065;1098;8621.741347759576;12251.509939602405;12285.324307163102;12416.875831241752;12417.565385211474;4087.9386809197886;4925.482824303468;5071.619628527801;5127.2052831811125;5135.435102138762;10496.580136794442;10545.47272636365;10547.525361358605;10553.155747540332;10555;5553.500184983371;5626.662400255997;5637.548996080303;5660.150977353348;5660.632058916157;5040.243963405445;5045.167547354718;5062.924056139161;5086.880886205029;5127.41034781005;3312.6190488093694;3889.552701439314;3917.059905622687;3927.9607203928167;3974.7615143091507;1301.2907965158822;1310.8361454818148;1315.033450413945;1326.356716992258;1327.87385198406;997.6657819630506;1084.1760262200626;1111.6720567432626;1223.7797196504714;1351.4796803230827;7935.682572697143;7954.363650907913;8073.798155046054;8100.392470564731;8199.71301004462;641.1760887259849;654.456800855289;656.9704363303567;657.6185812228991;797.9561124138228;6113.724882380304;6180.289266734293;6230.968845155745;6257.499400047986;6272.435480806749;10660.786784264272;10910.5090270938;11033.503492342863;11147.052500537546;11170.609028683957;10872.836907446395;10992.560297588007;10993.175511836644;11040.447977601088;11052;8145.837083258301;8407.117252688502;8424.957875210584;8501.914980850235;8546.572671366532;7916.920830791619;7991.680332786624;8031.518108913484;8078.9192108080515;8111.310538604284;9601.711948641552;9734.951325243328;9891.950540247253;9926.503674816375;9989.350692204984;8469.644856822879;8861.468311901048;9997.500124993867;10089.293749437762;10259.538320775433;7406.370458511087;7535.6985720570565;7539.283768042246;7576.204498527575;7644;8277.337812974827;8327.958360208402;8400.915990840012;8429.03066147401;8430.018945547668;7241.45689073311;7849.882251766342;7891.368690504861;8003.83992320162;8135.30849877767;7609.201033891583;7687.2697093776005;7782.533048017137;7831.647575858986;7863.606819659109;5916.733746981482;6625.834354141185;6999.160100787938;7856.371490280878;7984.560849153352;5508.834734957958;6414.422701956846;6541.8691626168165;7177.3899218567;7188.388986936169;7182.96408517954;7201.855962880818;7238.131424229126;7243.7464688735645;7303.379212766974 16:56:11 INFO - PROCESS | 1678 | |4;prototype.html;292.9209113539343;307.31775458482167;335.17212485161656;340.5283682100291;343.1301650316448;6850.314968503159;6982;6985.9171828366625;7001.089858318412;7015.368616824485;7013.579185248888;7024.683889224997;7052.541584796997;7065.540739851906;7077.7522786702475;5161.167785436163;5172.353455818023;5181.6113791465605;5191.831837836495;5198.2982297389935;5039.420466646327;5177.119889618755;5180.3265575475325;5185.144451165553;5196.818111366103;5110.437851836295;5120.667156634825;5122.334096567441;5142.922856157161;5145.25393817898;5135.281060651511;5140.357455318085;5149.81975630853;5150.201718733602;5155.664881782691;4413.845515406977;4414.227510185705;4422.933655995131;4424.513303536608;4424.668149888739;6477.578957367756;6686.364795344483;6734.629595372253;6810.216825065131;6820.795376138723;4859.514048595148;5986.431289027535;5993.340732519419;5996.010658241385;5999.9800033994325;5732.570057245682;7511.6244187790935;7519.962400187964;7533.434992375539;7543.547387156788;4628.912205631674;4704.200285951362;4721.929171062437;4740.19416699162;4759.214729569617;7131.393831524327;7240.167380751228;7856.882146767803;7991.200879911962;7995.160508146619;4823.252395878644;4835.8065677373215;4847.3698419205275;4858.149823780825;4868.78090485929;4803.687760295569;4937.654364194544;4938.111139994836;4951.851444456672;4955.033768415196;5893;5911.231539899872;5937.732802023919;5959.880802384015;5976.581639285208;6165.167702360124;7297.855012216375;7553.055868016498;7586.81032974169;7594.658240379196;1667.3247334829414;1684.6859449629308;1708.052031122714;1709.7178965470557;1719.0287487569483;1075.5805235957982;1082.6156714366443;1093.8906109388997;1095.5562996986234;1096.786126705285;5729.914051289151;6088.238970128734;6800.965995169992;6947.687354069079;6956.165260168711;6499.902501462482;7775.766726998199;7776.261255180749;7776.766696999099;7786.844263114706;6638.933610663831;6933.306669333027;6949.235584085746;6968.198657154492;6986.895196572055;4123.907164601383;4134.91730165395;4140.668746500272;4144.150449157915;4144.254034273859;7552.584607846621;8139.877901831477;8169.30560902318;8182.386321025947;8217.95891020541;7777.183395743478;7984.481008734414;8081.15147909461;8099.433039687166;8104.878426823484;6962.651867406609;8090.595470226465;8091.109977902426;8103.756887293391;8109.635066422025;7489.775306740807;7646.847063058819;7753.883691744742;7888.566128862968;7891.171427000082;7719.421043421654;7750.186230445947;7776.844463110593;7787.532748035136;7862.842743144991;7979.122296547491;8180.100188979327;8351.373646976623;8481.57592120404;8499;4850.151223535938;4896.1921282987905;4903.975480122576;4903.994681090297;4917.065757506062;6641.535092543476;7642.273983971514;7858.921410785819;7896.368290536858;7902.841943161219;6154.292256390572;7313.634318283958;7478.588677622565;7502.249775022454;7561.9243807563425;7513.661885215288;7567.697292108254;7567.978322926335;7578.242175782378;7582.848343033219;7133.464990125657;7371.963140184264;7404.592747398945;7408.925910740823;7422.777316680508;7540.811479713051;7552.886706699294;7556.924430755622;7558.206388329147;7579.924200757921;7333.633318333956;7377.372923301579;7384.150822655249;7391.223921488381;7396.371308438843 16:56:11 INFO - PROCESS | 1678 | |5;yui.html;658.9308122647121;671.5601281160838;681.3527149208251;715.4276578737009;749.4079677055126;11883.405829708523;15055.365311070573;15148.924255378735;15160;15163.241837908101;12068.51725930964;13407.597772066854;13888.305584720774;13912.304384780771;13941.163530188196;672.445232683036;820.1142765812908;829.2163905109674;842.2083241752733;850.8766228896807;828.9005319361685;836.5440834745048;836.7866194120521;844.6536919862857;847.3179090831878;885.5041176940933;891.3804905590617;899.0739538275554;903.4308385716989;906.2704522859095;886.3441053620306;900.842352588301;901;902.5577467041168;902.6795487601872;662.7713438863633;667.3826710293008;670.4770279182246;671.3286713286714;676.8459776081769;14477.71044579113;14663.046901951446;14691.045082069739;14693.26533673312;14754.188519631416;12849.100562960597;12915.354232288442;12961.740765184737;13196.802047969288;13319.533816316383;10007.949960250226;10216.591336346537;10262.692119236435;10622.893771062269;10951.014408703255;3514.5431093957623;3536.752427330088;3546.113471632092;3547.290541891606;3567.6253993330847;78665.82001269986;80407.5979620104;80677.59661201715;81107.5944620279;81463.37073258561;9556.808863822685;9597.616095356247;9650.565724542412;9845.360051596623;9854.260930430246;17559.73660395095;18808.52978675544;21507.67738483924;21558.706477611395;21568.382371322212;7463.477556571096;7561;7655.311022008046;7798.8050298741855;7948.364130869517;4102.323116685773;4146.253674338648;4152.8338866445;4157.563455837094;4170.666346692257;3249.8862539810993;3263.885763998249;3517.8416971235843;3595.0832537702718;3598.136447252693;625.0312016374601;642.5149012495536;645.0678769178492;645.3481983197005;679.9252082270946;535.2399592578548;567.7530274330679;621.940915613016;622.3123448589334;629.5750368501243;8000.439969202216;8310.54292013945;8535.359848011423;8593.484390936565;8725.127487251351;502.8969061342416;609.2597494044757;621.7979156774066;651.4234902111665;675.5440077947366;3799.544054713452;3945.881623551298;4064.878053658395;4088.621438786952;4194.937075943863;87352;88452.5577372109;89319;90754;91204.08795912088;71171;72462;72499.63750181215;72773.636131819;74143.62928185433;49273.753631231615;65727.34272657213;66201.66899165473;66208.33791662214;67200;6973.442124630119;8237.093919668952;8328.958355208428;8363.372747044117;8411.62147703367;44420.111597767216;49588.50411495839;49746;50592.74703626605;52124.47875521348;65050;68299.3170068293;69276.6536167316;70053.2486687837;70360;10333;10366.326188797704;10432.947835260775;10444.477776111316;10691.679249622524;11226.494807733508;11229.66311010671;11823.172377933462;12050.578229761917;12487.625371238877;11435.313881167156;11715.648530544097;11822.704432389259;11925.05952588082;12214.75570488603;11254.549818007188;11882.28706277626;11966.341851198267;12271.815922760987;12321.876781232073;11009.669709908716;11534.077273817906;11674;11685.298882067103;11889.881101188877;9531.951485336469;9677.951610241904;9852.014798520091;10163.94918025405;10218.489075546342;7871.685132594632;9064.048274931301;9935.701928942144;9976.451295178544;10103.54534045955 16:56:11 INFO - PROCESS | 1678 | __end_tp_report 16:56:11 INFO - PROCESS | 1678 | __start_cc_report 16:56:11 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,373 16:56:11 INFO - PROCESS | 1678 | __end_cc_report 16:56:11 INFO - PROCESS | 1678 | __startTimestamp1454979371640__endTimestamp 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | ------- Summary: start ------- 16:56:11 INFO - PROCESS | 1678 | Number of tests: 6 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | [#0] dojo.html Cycles:165 Average:5776.18 Median:6096.94 stddev:662.41 (10.9%) stddev-sans-first:627.52 16:56:11 INFO - PROCESS | 1678 | Values: 2996.2 3539.7 3562.4 3627.4 3629.5 5716.7 5716.9 5785.8 5844.3 5848.2 5667.2 5803.6 5844.7 5864.6 5934.3 5177.7 5204.6 5205.5 5282.9 5291.6 5146.2 5264.3 5265.2 5295.0 5334.0 5180.4 5241.0 5275.8 5279.3 5283.5 5224.2 5237.9 5263.3 5281.6 5300.3 5097.0 5171.4 5248.7 5270.4 5295.0 5591.0 5707.4 5733.0 5750.9 5762.5 6262.6 6320.2 6322.1 6335.2 6362.2 6180.4 6192.7 6242.2 6255.9 6278.8 5935.6 5971.2 5986.3 5986.6 6009.6 6119.2 6274.7 6293.5 6310.0 6360.9 6210.7 6233.3 6233.9 6245.7 6246.0 5370.8 6141.5 6263.2 6284.8 6317.9 5399.6 6101.8 6206.2 6272.1 6282.9 6208.2 6237.6 6254.6 6263.6 6298.8 3937.8 4428.0 4865.2 4965.8 4995.3 4393.5 4449.4 4459.1 4471.2 4485.0 5418.9 5772.9 5853.5 5879.5 5904.9 6188.9 6236.1 6238.8 6305.2 6308.8 5845.2 5922.3 5930.7 5937.8 5945.6 5366.3 5397.4 5399.7 5407.6 5412.0 5475.4 6275.1 6361.8 6399.7 6407.3 6219.1 6263.0 6287.1 6296.4 6297.9 6393.0 6407.5 6448.9 6452.8 6479.1 5032.6 6182.7 6282.2 6287.7 6318.1 6115.7 6220.3 6237.1 6257.6 6263.0 6106.5 6145.4 6221.5 6224.8 6244.4 6190.2 6239.8 6259.7 6260.4 6272.2 5222.6 6096.9 6106.1 6108.5 6138.0 6076.7 6105.6 6191.5 6204.3 6217.0 6058.0 6099.6 6112.7 6128.3 6139.3 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | [#1] ext.html Cycles:180 Average:61453.39 Median:38895.92 stddev:126716.63 (325.8%) stddev-sans-first:126989.35 16:56:11 INFO - PROCESS | 1678 | Values: 459.5 462.7 463.2 473.8 567.9 37335.0 37690.2 37725.2 37774.2 37839.8 30604.0 39560.8 39590.6 39610.4 39688.2 9360.3 9464.5 9540.8 9550.0 9624.4 9454.7 9668.4 9703.6 9709.8 9712.8 9654.8 9660.3 9695.7 9732.0 9755.6 9615.9 9655.6 9685.6 9704.7 9717.6 9573.3 9699.1 9704.2 9705.5 9731.1 38173.6 38270.8 38351.8 38372.6 38743.0 2306.8 3199.3 3210.8 3215.0 3427.9 27320.9 27371.9 27456.7 27592.0 27628.0 2690.0 2696.7 2702.2 2800.9 2876.2 330211.0 331329.0 332159.3 332365.0 333573.0 49138.0 54769.0 57269.0 62402.7 66849.0 63830.7 64536.7 64826.0 65120.0 65202.0 13795.6 14670.7 15627.9 16341.7 16553.8 9903.0 12077.8 12436.4 12555.6 12824.5 17010.5 20356.5 21068.2 21257.8 21293.4 7782.6 8972.7 9164.4 9229.4 9260.5 926.3 973.8 1006.8 1052.2 1078.9 23309.9 26282.2 27762.6 28245.3 28323.0 1063.9 1104.7 1106.4 1107.7 1206.0 14327.4 14370.4 14392.6 14451.3 14665.7 542639.0 549353.0 550616.0 552942.0 553863.0 55115.6 56579.4 57397.0 57398.1 58178.0 1409.7 1446.1 1459.6 1464.7 1468.8 23783.6 28555.3 28939.3 28997.0 29165.6 49857.3 49905.0 50253.5 50354.0 50571.0 513163.9 515859.0 516647.0 517996.9 519427.0 30396.5 30850.5 31052.8 31363.0 31459.0 44196.3 44662.1 44803.0 44842.1 45245.0 36771.6 38041.6 38362.0 40783.4 41758.8 37751.9 38396.9 39047.4 39881.4 40120.0 39123.2 39726.0 40077.4 40288.6 40412.6 37403.1 37589.9 38744.4 39389.4 40279.4 25901.7 26248.5 26323.3 26756.7 26901.9 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | [#2] jquery.html Cycles:180 Average:37760.51 Median:13796.35 stddev:122461.85 (887.6%) stddev-sans-first:122773.18 16:56:11 INFO - PROCESS | 1678 | Values: 361.1 367.3 368.4 371.1 371.5 15200.8 15352.0 18559.7 19602.8 19921.7 16000.2 18824.6 19153.4 19204.7 19429.4 4166.6 5141.9 5752.6 5764.2 5773.2 6088.2 6362.4 6433.5 6443.2 6445.5 6109.1 6327.7 6421.0 6421.5 6451.0 6114.3 6318.8 6349.8 6357.9 6362.9 4657.6 5507.4 5537.6 5537.7 5547.6 24160.6 24341.9 24809.0 24980.8 25053.2 2151.3 2172.2 2284.1 2474.3 2539.5 11982.0 14302.8 14381.9 14663.0 14775.1 1574.6 1752.0 1779.1 1804.7 1834.5 92858.5 94537.6 94934.5 96077.0 97584.0 10318.6 10675.2 10698.2 10741.2 10773.4 12525.2 12564.6 12628.5 12657.7 12734.1 8495.9 8501.3 8523.7 8551.6 8606.9 8596.4 8712.2 8729.0 8767.8 8808.3 5591.7 5908.3 6055.2 6084.3 6122.2 1810.5 1850.0 1865.3 1871.9 1888.3 903.1 927.8 957.0 975.0 1013.6 14569.3 15165.8 18834.9 18885.2 19110.4 844.7 925.3 930.1 984.7 1013.0 10130.6 10293.3 10349.0 10497.1 10585.7 735709.0 740257.0 745757.0 746794.0 748774.0 117581.0 120245.4 121724.0 121732.0 124085.0 1140.2 1171.1 1173.9 1190.9 1193.5 17286.0 17328.2 17347.0 17352.4 17419.9 48618.0 49660.8 50247.0 50573.7 51427.7 73152.6 75698.0 76012.5 76228.0 76617.0 7361.2 7414.2 7539.7 7762.4 7857.4 11347.4 11893.6 12081.0 12128.4 12153.5 10392.3 10436.2 10443.5 10542.0 10609.8 8937.2 9893.1 10354.9 10472.9 10475.5 9989.4 10245.9 10746.4 10783.2 11036.7 7670.5 7682.5 7684.5 7687.4 7752.3 8959.0 9699.6 10794.8 10823.4 10900.4 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | [#3] mootools.html Cycles:180 Average:6080.26 Median:5577.03 stddev:3241.43 (58.1%) stddev-sans-first:3232.32 16:56:11 INFO - PROCESS | 1678 | Values: 1510.5 1512.7 1750.6 1898.4 1915.5 7538.4 7579.2 8075.9 8837.3 8993.4 8729.6 8830.6 8830.9 8873.6 8902.2 2116.3 2506.7 2524.4 2543.6 2551.3 2491.7 2524.1 2527.9 2539.1 2546.0 2094.8 2199.2 2471.3 2493.6 2576.8 2478.7 2482.4 2519.9 2522.6 2552.5 2495.2 2513.1 2518.5 2520.6 2528.4 8540.5 8600.9 8628.4 8709.3 8723.4 4768.0 5137.2 5412.9 5454.3 5600.6 3629.9 3662.3 3727.6 3745.3 3749.8 1056.6 1062.7 1089.2 1094.4 1098.0 8621.7 12251.5 12285.3 12416.9 12417.6 4087.9 4925.5 5071.6 5127.2 5135.4 10496.6 10545.5 10547.5 10553.2 10555.0 5553.5 5626.7 5637.5 5660.2 5660.6 5040.2 5045.2 5062.9 5086.9 5127.4 3312.6 3889.6 3917.1 3928.0 3974.8 1301.3 1310.8 1315.0 1326.4 1327.9 997.7 1084.2 1111.7 1223.8 1351.5 7935.7 7954.4 8073.8 8100.4 8199.7 641.2 654.5 657.0 657.6 798.0 6113.7 6180.3 6231.0 6257.5 6272.4 10660.8 10910.5 11033.5 11147.1 11170.6 10872.8 10992.6 10993.2 11040.4 11052.0 8145.8 8407.1 8425.0 8501.9 8546.6 7916.9 7991.7 8031.5 8078.9 8111.3 9601.7 9735.0 9892.0 9926.5 9989.4 8469.6 8861.5 9997.5 10089.3 10259.5 7406.4 7535.7 7539.3 7576.2 7644.0 8277.3 8328.0 8400.9 8429.0 8430.0 7241.5 7849.9 7891.4 8003.8 8135.3 7609.2 7687.3 7782.5 7831.6 7863.6 5916.7 6625.8 6999.2 7856.4 7984.6 5508.8 6414.4 6541.9 7177.4 7188.4 7183.0 7201.9 7238.1 7243.7 7303.4 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | [#4] prototype.html Cycles:180 Average:6095.14 Median:6940.50 stddev:1968.10 (28.4%) stddev-sans-first:1924.84 16:56:11 INFO - PROCESS | 1678 | Values: 292.9 307.3 335.2 340.5 343.1 6850.3 6982.0 6985.9 7001.1 7015.4 7013.6 7024.7 7052.5 7065.5 7077.8 5161.2 5172.4 5181.6 5191.8 5198.3 5039.4 5177.1 5180.3 5185.1 5196.8 5110.4 5120.7 5122.3 5142.9 5145.3 5135.3 5140.4 5149.8 5150.2 5155.7 4413.8 4414.2 4422.9 4424.5 4424.7 6477.6 6686.4 6734.6 6810.2 6820.8 4859.5 5986.4 5993.3 5996.0 6000.0 5732.6 7511.6 7520.0 7533.4 7543.5 4628.9 4704.2 4721.9 4740.2 4759.2 7131.4 7240.2 7856.9 7991.2 7995.2 4823.3 4835.8 4847.4 4858.1 4868.8 4803.7 4937.7 4938.1 4951.9 4955.0 5893.0 5911.2 5937.7 5959.9 5976.6 6165.2 7297.9 7553.1 7586.8 7594.7 1667.3 1684.7 1708.1 1709.7 1719.0 1075.6 1082.6 1093.9 1095.6 1096.8 5729.9 6088.2 6801.0 6947.7 6956.2 6499.9 7775.8 7776.3 7776.8 7786.8 6638.9 6933.3 6949.2 6968.2 6986.9 4123.9 4134.9 4140.7 4144.2 4144.3 7552.6 8139.9 8169.3 8182.4 8218.0 7777.2 7984.5 8081.2 8099.4 8104.9 6962.7 8090.6 8091.1 8103.8 8109.6 7489.8 7646.8 7753.9 7888.6 7891.2 7719.4 7750.2 7776.8 7787.5 7862.8 7979.1 8180.1 8351.4 8481.6 8499.0 4850.2 4896.2 4904.0 4904.0 4917.1 6641.5 7642.3 7858.9 7896.4 7902.8 6154.3 7313.6 7478.6 7502.2 7561.9 7513.7 7567.7 7568.0 7578.2 7582.8 7133.5 7372.0 7404.6 7408.9 7422.8 7540.8 7552.9 7556.9 7558.2 7579.9 7333.6 7377.4 7384.2 7391.2 7396.4 16:56:11 INFO - PROCESS | 1678 | 16:56:11 INFO - PROCESS | 1678 | [#5] yui.html Cycles:180 Average:17835.20 Median:623.67 stddev:24760.61 (3970.1%) stddev-sans-first:24796.48 16:56:11 INFO - PROCESS | 1678 | Values: 658.9 671.6 681.4 715.4 749.4 11883.4 15055.4 15148.9 15160.0 15163.2 12068.5 13407.6 13888.3 13912.3 13941.2 672.4 820.1 829.2 842.2 850.9 828.9 836.5 836.8 844.7 847.3 885.5 891.4 899.1 903.4 906.3 886.3 900.8 901.0 902.6 902.7 662.8 667.4 670.5 671.3 676.8 14477.7 14663.0 14691.0 14693.3 14754.2 12849.1 12915.4 12961.7 13196.8 13319.5 10007.9 10216.6 10262.7 10622.9 10951.0 3514.5 3536.8 3546.1 3547.3 3567.6 78665.8 80407.6 80677.6 81107.6 81463.4 9556.8 9597.6 9650.6 9845.4 9854.3 17559.7 18808.5 21507.7 21558.7 21568.4 7463.5 7561.0 7655.3 7798.8 7948.4 4102.3 4146.3 4152.8 4157.6 4170.7 3249.9 3263.9 3517.8 3595.1 3598.1 625.0 642.5 645.1 645.3 679.9 535.2 567.8 621.9 622.3 629.6 8000.4 8310.5 8535.4 8593.5 8725.1 502.9 609.3 621.8 651.4 675.5 3799.5 3945.9 4064.9 4088.6 4194.9 87352.0 88452.6 89319.0 90754.0 91204.1 71171.0 72462.0 72499.6 72773.6 74143.6 49273.8 65727.3 66201.7 66208.3 67200.0 6973.4 8237.1 8329.0 8363.4 8411.6 44420.1 49588.5 49746.0 50592.7 52124.5 65050.0 68299.3 69276.7 70053.2 70360.0 10333.0 10366.3 10432.9 10444.5 10691.7 11226.5 11229.7 11823.2 12050.6 12487.6 11435.3 11715.6 11822.7 11925.1 12214.8 11254.5 11882.3 11966.3 12271.8 12321.9 11009.7 11534.1 11674.0 11685.3 11889.9 9532.0 9678.0 9852.0 10163.9 10218.5 7871.7 9064.0 9935.7 9976.5 10103.5 16:56:11 INFO - PROCESS | 1678 | -------- Summary: end -------- 16:56:11 INFO - PROCESS | 1678 | 16:56:12 INFO - TEST-INFO | 1678: exit 0 16:56:12 INFO - TEST-OK | dromaeo_css | took 1110602ms 16:56:12 INFO - TEST-START | kraken 16:56:12 INFO - operating with platform_type : mac_ 16:56:12 INFO - Initialising browser for kraken test... 16:56:12 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpYWirOg/profile http://localhost:49274/getInfo.html) 16:56:14 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 16:56:14 INFO - PROCESS | 1688 | colorDepth:24 16:56:14 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 16:56:14 INFO - PROCESS | 1688 | __metrics 16:56:15 INFO - PROCESS | 1688 | 16:56:15 INFO - PROCESS | 1688 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 16:56:15 INFO - PROCESS | 1688 | 16:56:15 INFO - TEST-INFO | 1688: exit 0 16:56:15 INFO - Browser initialized. 16:56:15 INFO - Running cycle 1/1 for kraken test... 16:56:15 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpYWirOg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:27 INFO - PROCESS | 1691 | RSS: Main: 257417216 16:56:27 INFO - PROCESS | 1691 | 16:56:30 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 16:56:30 INFO - PROCESS | 1691 | RSS: Main: 270704640 16:56:30 INFO - PROCESS | 1691 | 16:56:33 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 16:56:33 INFO - PROCESS | 1691 | RSS: Main: 279576576 16:56:33 INFO - PROCESS | 1691 | 16:56:37 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 16:56:37 INFO - PROCESS | 1691 | RSS: Main: 282210304 16:56:37 INFO - PROCESS | 1691 | 16:56:39 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 16:56:40 INFO - PROCESS | 1691 | RSS: Main: 283824128 16:56:40 INFO - PROCESS | 1691 | 16:56:42 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:56:43 INFO - PROCESS | 1691 | RSS: Main: 284332032 16:56:43 INFO - PROCESS | 1691 | 16:56:46 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 16:56:46 INFO - PROCESS | 1691 | RSS: Main: 286019584 16:56:46 INFO - PROCESS | 1691 | 16:56:49 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 16:56:50 INFO - PROCESS | 1691 | RSS: Main: 286056448 16:56:50 INFO - PROCESS | 1691 | 16:56:53 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 16:56:53 INFO - PROCESS | 1691 | RSS: Main: 286535680 16:56:53 INFO - PROCESS | 1691 | 16:56:55 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:56:56 INFO - PROCESS | 1691 | RSS: Main: 286896128 16:56:56 INFO - PROCESS | 1691 | 16:56:58 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:56:58 INFO - PROCESS | 1691 | RSS: Main: 285069312 16:56:58 INFO - PROCESS | 1691 | 16:57:00 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:01 INFO - PROCESS | 1691 | RSS: Main: 285224960 16:57:01 INFO - PROCESS | 1691 | 16:57:04 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:04 INFO - PROCESS | 1691 | RSS: Main: 284692480 16:57:04 INFO - PROCESS | 1691 | 16:57:07 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:07 INFO - PROCESS | 1691 | RSS: Main: 286883840 16:57:07 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 16:57:09 INFO - PROCESS | 1691 | RSS: Main: 287318016 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | __start_tp_report 16:57:09 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 16:57:09 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 16:57:09 INFO - PROCESS | 1691 | |i|pagename|runs| 16:57:09 INFO - PROCESS | 1691 | |0;ai-astar;114;106;115;114;117;125;115;115;115;115 16:57:09 INFO - PROCESS | 1691 | |1;audio-beat-detection;149;123;144;150;119;141;137;154;141;107 16:57:09 INFO - PROCESS | 1691 | |2;audio-dft;195;249;234;267;197;269;280;224;198;221 16:57:09 INFO - PROCESS | 1691 | |3;audio-fft;62;72;67;112;57;58;58;63;131;47 16:57:09 INFO - PROCESS | 1691 | |4;audio-oscillator;81;83;163;118;86;82;112;119;69;135 16:57:09 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;94;141;130;93;132;133;86;91;86;102 16:57:09 INFO - PROCESS | 1691 | |6;imaging-darkroom;96;96;97;94;94;95;96;95;96;105 16:57:09 INFO - PROCESS | 1691 | |7;imaging-desaturate;90;93;92;91;117;148;114;150;144;106 16:57:09 INFO - PROCESS | 1691 | |8;json-parse-financial;59;58;58;56;59;65;73;94;87;84 16:57:09 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;66;66;75;71;76;75;95;60;73;96 16:57:09 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;87;84;87;86;87;96;83;86;86;85 16:57:09 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;134;134;134;139;133;135;121;124;128;126 16:57:09 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;129;141;141;145;163;183;192;157;139;129 16:57:09 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;66;66;69;75;96;97;99;55;69;101 16:57:09 INFO - PROCESS | 1691 | __end_tp_report 16:57:09 INFO - PROCESS | 1691 | __start_cc_report 16:57:09 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,942 16:57:09 INFO - PROCESS | 1691 | __end_cc_report 16:57:09 INFO - PROCESS | 1691 | __startTimestamp1454979429937__endTimestamp 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | ------- Summary: start ------- 16:57:09 INFO - PROCESS | 1691 | Number of tests: 14 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:4.56 (4.0%) stddev-sans-first:4.82 16:57:09 INFO - PROCESS | 1691 | Values: 114.0 106.0 115.0 114.0 117.0 125.0 115.0 115.0 115.0 115.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:142.50 stddev:15.28 (10.7%) stddev-sans-first:15.52 16:57:09 INFO - PROCESS | 1691 | Values: 149.0 123.0 144.0 150.0 119.0 141.0 137.0 154.0 141.0 107.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:233.40 Median:241.50 stddev:31.81 (13.2%) stddev-sans-first:30.55 16:57:09 INFO - PROCESS | 1691 | Values: 195.0 249.0 234.0 267.0 197.0 269.0 280.0 224.0 198.0 221.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:72.70 Median:60.00 stddev:26.92 (44.9%) stddev-sans-first:28.28 16:57:09 INFO - PROCESS | 1691 | Values: 62.0 72.0 67.0 112.0 57.0 58.0 58.0 63.0 131.0 47.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:75.00 stddev:29.67 (39.6%) stddev-sans-first:30.20 16:57:09 INFO - PROCESS | 1691 | Values: 81.0 83.0 163.0 118.0 86.0 82.0 112.0 119.0 69.0 135.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:86.00 stddev:22.31 (25.9%) stddev-sans-first:23.02 16:57:09 INFO - PROCESS | 1691 | Values: 94.0 141.0 130.0 93.0 132.0 133.0 86.0 91.0 86.0 102.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:3.17 (3.3%) stddev-sans-first:3.36 16:57:09 INFO - PROCESS | 1691 | Values: 96.0 96.0 97.0 94.0 94.0 95.0 96.0 95.0 96.0 105.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:114.50 Median:120.00 stddev:24.61 (20.5%) stddev-sans-first:24.46 16:57:09 INFO - PROCESS | 1691 | Values: 90.0 93.0 92.0 91.0 117.0 148.0 114.0 150.0 144.0 106.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:69.00 stddev:14.21 (20.6%) stddev-sans-first:14.57 16:57:09 INFO - PROCESS | 1691 | Values: 59.0 58.0 58.0 56.0 59.0 65.0 73.0 94.0 87.0 84.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:75.30 Median:75.00 stddev:11.78 (15.7%) stddev-sans-first:12.00 16:57:09 INFO - PROCESS | 1691 | Values: 66.0 66.0 75.0 71.0 76.0 75.0 95.0 60.0 73.0 96.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.50 stddev:3.53 (4.1%) stddev-sans-first:3.74 16:57:09 INFO - PROCESS | 1691 | Values: 87.0 84.0 87.0 86.0 87.0 96.0 83.0 86.0 86.0 85.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:134.00 stddev:5.71 (4.3%) stddev-sans-first:5.94 16:57:09 INFO - PROCESS | 1691 | Values: 134.0 134.0 134.0 139.0 133.0 135.0 121.0 124.0 128.0 126.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:151.00 stddev:21.67 (14.3%) stddev-sans-first:21.34 16:57:09 INFO - PROCESS | 1691 | Values: 129.0 141.0 141.0 145.0 163.0 183.0 192.0 157.0 139.0 129.0 16:57:09 INFO - PROCESS | 1691 | 16:57:09 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.30 Median:72.00 stddev:17.08 (23.7%) stddev-sans-first:17.43 16:57:09 INFO - PROCESS | 1691 | Values: 66.0 66.0 69.0 75.0 96.0 97.0 99.0 55.0 69.0 101.0 16:57:09 INFO - PROCESS | 1691 | -------- Summary: end -------- 16:57:09 INFO - PROCESS | 1691 | 16:57:10 INFO - TEST-INFO | 1691: exit 0 16:57:10 INFO - TEST-OK | kraken | took 58537ms 16:57:10 INFO - SUITE-END | took 1169s 16:57:11 INFO - Completed test suite (00:19:29) 16:57:11 INFO - Working with test: dromaeo_css 16:57:11 INFO - Generating results file: dromaeo_css 16:57:11 INFO - Working with test: kraken 16:57:11 INFO - Generating results file: kraken 16:57:11 INFO - javascript benchmark 16:57:11 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 16:57:11 INFO - process_Request line: dromaeo_css 7585.27 graph.html#tests=[[72,64,61]] 16:57:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:11 INFO - process_Request line: kraken 1575.50 graph.html#tests=[[232,64,61]] 16:57:11 INFO - RETURN: dromaeo_css: 7585.27 16:57:11 INFO - RETURN: kraken: 1575.50 16:57:11 INFO - javascript benchmark 16:57:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2996.220982544538, 3539.6814286714193, 3562.44782058781, 3627.3833448313785, 3629.473726309685, 5716.657000579958, 5716.885662286762, 5785.797497087598, 5844.298684157901, 5848.239728835246, 5667.206591077253, 5803.6227645203035, 5844.707764611774, 5864.648121112737, 5934.347221805598, 5177.741112944356, 5204.557612602934, 5205.479452054802, 5282.867928301804, 5291.629585928987, 5146.228065790124, 5264.341957255343, 5265.157574788034, 5295.020421222086, 5333.986542556921, 5180.4042535108565, 5240.978009288209, 5275.815346462856, 5279.260903473517, 5283.524482796528, 5224.164133738622, 5237.869053273661, 5263.26314315996, 5281.551068159211, 5300.284461597674, 5096.974515127437, 5171.4052883918075, 5248.685078895279, 5270.39390470097, 5295.020421222048, 5591.0, 5707.429257074301, 5732.971335143339, 5750.884982300372, 5762.510186634141, 6262.624242545417, 6320.178376811031, 6322.051692246154, 6335.239771227436, 6362.204724409449, 6180.412860778219, 6192.690365481753, 6242.219722534684, 6255.906161407583, 6278.843028924313, 5935.6438613682885, 5971.156948891728, 5986.281646202397, 5986.610870293417, 6009.6394216346725, 6119.228375855631, 6274.749010039639, 6293.465055470245, 6309.968450157719, 6360.936390636127, 6210.658413787195, 6233.3143354231, 6233.906491402633, 6245.718942647592, 6246.031865060922, 5370.791571896292, 6141.539384546177, 6263.248410190807, 6284.811455656338, 6317.936820631735, 5399.622026458189, 6101.822802906922, 6206.162168107338, 6272.059191121369, 6282.874342513124, 6208.21299007605, 6237.625742455467, 6254.562180647402, 6263.624182548971, 6298.779542715983, 3937.7637341759587, 4428.025834316445, 4865.245886887538, 4965.801367945314, 4995.25071239317, 4393.51671316155, 4449.443819522559, 4459.0858873930765, 4471.195184866755, 4484.977575112103, 5418.91871621926, 5772.855678608068, 5853.5317174625925, 5879.470847623649, 5904.852378690567, 6188.8762224755255, 6236.064590311489, 6238.781642642486, 6305.243370795534, 6308.810735677937, 5845.240118784531, 5922.3485416604135, 5930.733117009745, 5937.821865344046, 5945.554083443759, 5366.2755528004, 5397.379301380313, 5399.70301633414, 5407.594430417735, 5411.972940135274, 5475.370332411823, 6275.121482992385, 6361.777337793155, 6399.712012959428, 6407.295197528269, 6219.117142132099, 6263.029230469285, 6287.056941458818, 6296.433321001132, 6297.8663840507315, 6393.0, 6407.455366293917, 6448.871022579616, 6452.774152904626, 6479.060536222127, 5032.597392208541, 6182.690865456799, 6282.2147231596055, 6287.654179020198, 6318.147050148171, 6115.694215289129, 6220.253569571681, 6237.126802247598, 6257.624542527463, 6262.968685156545, 6106.511479081574, 6145.446909778141, 6221.5333849960525, 6224.782132625517, 6244.406781355764, 6190.164327815687, 6239.844003899939, 6259.7496100157305, 6260.373962603885, 6272.153259309935, 5222.634415590872, 6096.9390306096375, 6106.084087386927, 6108.51131909455, 6138.048602466625, 6076.726547305293, 6105.550726437353, 6191.504679625709, 6204.255489341308, 6217.0, 6057.990853991232, 6099.573029887865, 6112.6640074008, 6128.32588415265, 6139.29398119222], "unit": "score", "name": "dojo.html", "value": 5734.801759616576}, {"lowerIsBetter": false, "replicates": [459.48996613758743, 462.7269910752655, 463.2287241742497, 473.7915317260405, 567.8637127089498, 37335.0, 37690.246195076084, 37725.24549509015, 37774.24451510971, 37839.810800945954, 30604.0, 39560.80219598898, 39590.60409395905, 39610.40584391229, 39688.20623587527, 9360.344775865693, 9464.526773661324, 9540.80918381632, 9549.952250238739, 9624.422534647909, 9454.669086581936, 9668.371555848882, 9703.611855525805, 9709.75725606862, 9712.757181070494, 9654.758631034245, 9660.275479339043, 9695.660651877186, 9731.95134024329, 9755.560999755027, 9615.855762163574, 9655.565499552536, 9685.564149613214, 9704.66033688821, 9717.56270967801, 9573.329866909318, 9699.078587534173, 9704.175145112675, 9705.466199359033, 9731.075547822946, 38173.61826381728, 38270.80864595659, 38351.84944451671, 38372.616273837186, 38743.031424214336, 2306.8385213035094, 3199.2961548459302, 3210.7752457327997, 3215.0, 3427.9143021424416, 27320.863395683093, 27371.863140684367, 27456.725432745618, 27592.0, 27628.0, 2690.045034012917, 2696.703362630109, 2702.216357256393, 2800.9019684311156, 2876.2377969838008, 330211.0, 331329.0, 332159.33920330484, 332365.0, 333573.0, 49138.0, 54769.0, 57269.0, 62402.68798656068, 66849.0, 63830.68084659547, 64536.677316614056, 64826.0, 65120.0, 65202.0, 13795.586132416043, 14670.706585868224, 15627.921860390625, 16341.673166536602, 16553.834461655228, 9902.950485247527, 12077.818832717516, 12436.37818109091, 12555.623331300076, 12824.487020519075, 17010.489685309214, 20356.491087722927, 21068.15727370888, 21257.78742212589, 21293.36119916405, 7782.610869456617, 8972.730818075468, 9164.404313719588, 9229.353945223904, 9260.536973151315, 926.342296969146, 973.8295798235281, 1006.8238058339762, 1052.2476429353048, 1078.9190810689229, 23309.883450582638, 26282.211533654023, 27762.583561246596, 28245.29386765306, 28323.0, 1063.8563793887727, 1104.7072525780675, 1106.3846783695733, 1107.7175320293275, 1205.9939700301618, 14327.426902923766, 14370.425182992563, 14392.640183995483, 14451.349689264009, 14665.706685866437, 542639.0, 549353.0, 550616.0, 552942.0, 553863.0, 55115.622109447584, 56579.43420565824, 57397.0, 57398.13902791378, 58178.0, 1409.661681196526, 1446.0528353928194, 1459.649684075814, 1464.6777708904237, 1468.7649976003788, 23783.643245350988, 28555.337928422403, 28939.276518087216, 28997.0, 29165.562516561844, 49857.25214121864, 49905.0, 50253.497465024884, 50353.992920142126, 50571.0, 513163.8683613116, 515859.0, 516647.0, 517996.87010954437, 519427.0, 30396.5440518388, 30850.537241941838, 31052.844735776176, 31363.0, 31459.0, 44196.33705494356, 44662.10675786531, 44803.0, 44842.115699202164, 45245.0, 36771.63228367682, 38041.61958380381, 38362.0, 40783.38824917688, 41758.791206043774, 37751.86744397673, 38396.94428099769, 39047.41428878626, 39881.401778973915, 40120.0, 39123.217535649695, 39726.006849828984, 40077.398839018024, 40288.59711402848, 40412.59587404088, 37403.06492337604, 37589.872303830925, 38744.41883371808, 39389.409158862065, 40279.3958090623, 25901.740982589934, 26248.475030499663, 26323.341916452242, 26756.732432675424, 26901.865490672422], "unit": "score", "name": "ext.html", "value": 19474.689166866287}, {"lowerIsBetter": false, "replicates": [361.0630414075475, 367.2618037744134, 368.4399712437095, 371.09452934838976, 371.4947671167212, 15200.771988420183, 15352.0, 18559.699366851408, 19602.803971960275, 19921.701174482394, 16000.159981602119, 18824.623507529843, 19153.425397238105, 19204.711929321038, 19429.417117486464, 4166.64583510402, 5141.897162056766, 5752.568557358194, 5764.193012978187, 5773.191753154561, 6088.208532890718, 6362.427381535661, 6433.485321174295, 6443.226812782473, 6445.452136568398, 6109.083637454395, 6327.651979141146, 6421.036844473343, 6421.523049698549, 6450.967745161268, 6114.327423983358, 6318.842028949267, 6349.8412539686415, 6357.93642063578, 6362.936370636327, 4657.5575320344515, 5507.394186639466, 5537.556995440395, 5537.667739935577, 5547.55619550435, 24160.637590436156, 24341.87829060861, 24809.0, 24980.750192498024, 25053.248402547953, 2151.268568686654, 2172.196287373682, 2284.063667902501, 2474.34429876083, 2539.4540173862524, 11982.0, 14302.78426333763, 14381.928090359586, 14663.0, 14775.113493190443, 1574.559123445437, 1751.9824801751947, 1779.0748810618536, 1804.6751584714746, 1834.5046837353839, 92858.5357073217, 94537.58193627102, 94934.52532737292, 96076.9999999993, 97584.0, 10318.638847640297, 10675.199360048027, 10698.197635177392, 10741.248112632196, 10773.353598784099, 12525.248485090924, 12564.560240391542, 12628.484581850236, 12657.746845063048, 12734.108612397044, 8495.872561911576, 8501.277391421798, 8523.701670441505, 8551.572421378905, 8606.87089693655, 8596.441231319945, 8712.21590056898, 8728.996165440929, 8767.780805479786, 8808.339374546806, 5591.664500130005, 5908.3205431375945, 6055.182550355734, 6084.330723620398, 6122.173506576555, 1810.5021119192327, 1850.0194896704768, 1865.3471285050123, 1871.9251229950921, 1888.3202047262973, 903.1149473515991, 927.8051609162017, 956.9856452153223, 974.9519266788232, 1013.6198925402974, 14569.344379502947, 15165.772513412308, 18834.905825470785, 18885.15016824246, 19110.426687199408, 844.7085755414372, 925.2829057480371, 930.065284389198, 984.675057231112, 1013.0477351289765, 10130.594776208869, 10293.33093348945, 10349.0, 10497.055265026032, 10585.682429527127, 735709.0, 740257.0, 745757.0, 746794.0, 748774.0, 117581.0, 120245.39877300558, 121724.0, 121732.0, 124085.0, 1140.201858698914, 1171.1275100050516, 1173.859136903577, 1190.934498602585, 1193.516625766566, 17285.962842229506, 17328.220230089424, 17347.0, 17352.39266625662, 17419.8677085989, 48618.0, 49660.75848103826, 50246.995060099325, 50573.74713126558, 51427.74286128546, 73152.63423682848, 75698.0, 76012.47975040358, 76228.0, 76617.0, 7361.153467351109, 7414.184439711519, 7539.73610923637, 7762.3790096793255, 7857.371410287277, 11347.37589432589, 11893.643190704293, 12081.0, 12128.414986741995, 12153.513859445524, 10392.272540922062, 10436.217283703905, 10443.477826108816, 10541.998510141524, 10609.840852387066, 8937.195652391316, 9893.109620134222, 10354.948225258826, 10472.947635261775, 10475.476226188812, 9989.350692204984, 10245.897541024495, 10746.408947507962, 10783.19126065564, 11036.724081898017, 7670.463067585216, 7682.539047657158, 7684.500507466997, 7687.423443241667, 7752.302292793675, 8959.014508404201, 9699.6120155193, 10794.838077428687, 10823.404712740874, 10900.400477973788], "unit": "score", "name": "jquery.html", "value": 9417.272785426629}, {"lowerIsBetter": false, "replicates": [1510.493984515187, 1512.6747749233916, 1750.5798608334003, 1898.4020033689396, 1915.528967631755, 7538.396928245741, 7579.20418356073, 8075.919240807605, 8837.293016558677, 8993.415427997184, 8729.607167677454, 8830.646774129027, 8830.91169088309, 8873.600687969041, 8902.154295341948, 2116.343933380657, 2506.7493250674925, 2524.3815265260037, 2543.567593509108, 2551.2728872271405, 2491.6636254105647, 2524.1039431002005, 2527.911523096692, 2539.085929065535, 2546.0, 2094.8114669679726, 2199.230269405703, 2471.270975062361, 2493.551160791057, 2576.8325058871114, 2478.6901637295337, 2482.391814005571, 2519.924402267935, 2522.5963845784586, 2552.489502099578, 2495.2264797912526, 2513.082724805433, 2518.4711210645787, 2520.6471094046847, 2528.3679080229945, 8540.530270835101, 8600.913990860074, 8628.396012279143, 8709.303255739589, 8723.432976856548, 4767.951050768826, 5137.152369858969, 5412.891742165174, 5454.3454785426, 5600.5519558435635, 3629.872954446582, 3662.322470342995, 3727.627237276278, 3745.325841348556, 3749.8312575934146, 1056.6037735849056, 1062.659948816379, 1089.1776708585046, 1094.4254266510065, 1098.0, 8621.741347759576, 12251.509939602405, 12285.324307163102, 12416.875831241752, 12417.565385211474, 4087.9386809197886, 4925.482824303468, 5071.619628527801, 5127.2052831811125, 5135.435102138762, 10496.580136794442, 10545.47272636365, 10547.525361358605, 10553.155747540332, 10555.0, 5553.500184983371, 5626.662400255997, 5637.548996080303, 5660.150977353348, 5660.632058916157, 5040.243963405445, 5045.167547354718, 5062.924056139161, 5086.880886205029, 5127.41034781005, 3312.6190488093694, 3889.552701439314, 3917.059905622687, 3927.9607203928167, 3974.7615143091507, 1301.2907965158822, 1310.8361454818148, 1315.033450413945, 1326.356716992258, 1327.87385198406, 997.6657819630506, 1084.1760262200626, 1111.6720567432626, 1223.7797196504714, 1351.4796803230827, 7935.682572697143, 7954.363650907913, 8073.798155046054, 8100.392470564731, 8199.71301004462, 641.1760887259849, 654.456800855289, 656.9704363303567, 657.6185812228991, 797.9561124138228, 6113.724882380304, 6180.289266734293, 6230.968845155745, 6257.499400047986, 6272.435480806749, 10660.786784264272, 10910.5090270938, 11033.503492342863, 11147.052500537546, 11170.609028683957, 10872.836907446395, 10992.560297588007, 10993.175511836644, 11040.447977601088, 11052.0, 8145.837083258301, 8407.117252688502, 8424.957875210584, 8501.914980850235, 8546.572671366532, 7916.920830791619, 7991.680332786624, 8031.518108913484, 8078.9192108080515, 8111.310538604284, 9601.711948641552, 9734.951325243328, 9891.950540247253, 9926.503674816375, 9989.350692204984, 8469.644856822879, 8861.468311901048, 9997.500124993867, 10089.293749437762, 10259.538320775433, 7406.370458511087, 7535.6985720570565, 7539.283768042246, 7576.204498527575, 7644.0, 8277.337812974827, 8327.958360208402, 8400.915990840012, 8429.03066147401, 8430.018945547668, 7241.45689073311, 7849.882251766342, 7891.368690504861, 8003.83992320162, 8135.30849877767, 7609.201033891583, 7687.2697093776005, 7782.533048017137, 7831.647575858986, 7863.606819659109, 5916.733746981482, 6625.834354141185, 6999.160100787938, 7856.371490280878, 7984.560849153352, 5508.834734957958, 6414.422701956846, 6541.8691626168165, 7177.3899218567, 7188.388986936169, 7182.96408517954, 7201.855962880818, 7238.131424229126, 7243.7464688735645, 7303.379212766974], "unit": "score", "name": "mootools.html", "value": 4897.880907890726}, {"lowerIsBetter": false, "replicates": [292.9209113539343, 307.31775458482167, 335.17212485161656, 340.5283682100291, 343.1301650316448, 6850.314968503159, 6982.0, 6985.9171828366625, 7001.089858318412, 7015.368616824485, 7013.579185248888, 7024.683889224997, 7052.541584796997, 7065.540739851906, 7077.7522786702475, 5161.167785436163, 5172.353455818023, 5181.6113791465605, 5191.831837836495, 5198.2982297389935, 5039.420466646327, 5177.119889618755, 5180.3265575475325, 5185.144451165553, 5196.818111366103, 5110.437851836295, 5120.667156634825, 5122.334096567441, 5142.922856157161, 5145.25393817898, 5135.281060651511, 5140.357455318085, 5149.81975630853, 5150.201718733602, 5155.664881782691, 4413.845515406977, 4414.227510185705, 4422.933655995131, 4424.513303536608, 4424.668149888739, 6477.578957367756, 6686.364795344483, 6734.629595372253, 6810.216825065131, 6820.795376138723, 4859.514048595148, 5986.431289027535, 5993.340732519419, 5996.010658241385, 5999.9800033994325, 5732.570057245682, 7511.6244187790935, 7519.962400187964, 7533.434992375539, 7543.547387156788, 4628.912205631674, 4704.200285951362, 4721.929171062437, 4740.19416699162, 4759.214729569617, 7131.393831524327, 7240.167380751228, 7856.882146767803, 7991.200879911962, 7995.160508146619, 4823.252395878644, 4835.8065677373215, 4847.3698419205275, 4858.149823780825, 4868.78090485929, 4803.687760295569, 4937.654364194544, 4938.111139994836, 4951.851444456672, 4955.033768415196, 5893.0, 5911.231539899872, 5937.732802023919, 5959.880802384015, 5976.581639285208, 6165.167702360124, 7297.855012216375, 7553.055868016498, 7586.81032974169, 7594.658240379196, 1667.3247334829414, 1684.6859449629308, 1708.052031122714, 1709.7178965470557, 1719.0287487569483, 1075.5805235957982, 1082.6156714366443, 1093.8906109388997, 1095.5562996986234, 1096.786126705285, 5729.914051289151, 6088.238970128734, 6800.965995169992, 6947.687354069079, 6956.165260168711, 6499.902501462482, 7775.766726998199, 7776.261255180749, 7776.766696999099, 7786.844263114706, 6638.933610663831, 6933.306669333027, 6949.235584085746, 6968.198657154492, 6986.895196572055, 4123.907164601383, 4134.91730165395, 4140.668746500272, 4144.150449157915, 4144.254034273859, 7552.584607846621, 8139.877901831477, 8169.30560902318, 8182.386321025947, 8217.95891020541, 7777.183395743478, 7984.481008734414, 8081.15147909461, 8099.433039687166, 8104.878426823484, 6962.651867406609, 8090.595470226465, 8091.109977902426, 8103.756887293391, 8109.635066422025, 7489.775306740807, 7646.847063058819, 7753.883691744742, 7888.566128862968, 7891.171427000082, 7719.421043421654, 7750.186230445947, 7776.844463110593, 7787.532748035136, 7862.842743144991, 7979.122296547491, 8180.100188979327, 8351.373646976623, 8481.57592120404, 8499.0, 4850.151223535938, 4896.1921282987905, 4903.975480122576, 4903.994681090297, 4917.065757506062, 6641.535092543476, 7642.273983971514, 7858.921410785819, 7896.368290536858, 7902.841943161219, 6154.292256390572, 7313.634318283958, 7478.588677622565, 7502.249775022454, 7561.9243807563425, 7513.661885215288, 7567.697292108254, 7567.978322926335, 7578.242175782378, 7582.848343033219, 7133.464990125657, 7371.963140184264, 7404.592747398945, 7408.925910740823, 7422.777316680508, 7540.811479713051, 7552.886706699294, 7556.924430755622, 7558.206388329147, 7579.924200757921, 7333.633318333956, 7377.372923301579, 7384.150822655249, 7391.223921488381, 7396.371308438843], "unit": "score", "name": "prototype.html", "value": 5425.53797990307}, {"lowerIsBetter": false, "replicates": [658.9308122647121, 671.5601281160838, 681.3527149208251, 715.4276578737009, 749.4079677055126, 11883.405829708523, 15055.365311070573, 15148.924255378735, 15160.0, 15163.241837908101, 12068.51725930964, 13407.597772066854, 13888.305584720774, 13912.304384780771, 13941.163530188196, 672.445232683036, 820.1142765812908, 829.2163905109674, 842.2083241752733, 850.8766228896807, 828.9005319361685, 836.5440834745048, 836.7866194120521, 844.6536919862857, 847.3179090831878, 885.5041176940933, 891.3804905590617, 899.0739538275554, 903.4308385716989, 906.2704522859095, 886.3441053620306, 900.842352588301, 901.0, 902.5577467041168, 902.6795487601872, 662.7713438863633, 667.3826710293008, 670.4770279182246, 671.3286713286714, 676.8459776081769, 14477.71044579113, 14663.046901951446, 14691.045082069739, 14693.26533673312, 14754.188519631416, 12849.100562960597, 12915.354232288442, 12961.740765184737, 13196.802047969288, 13319.533816316383, 10007.949960250226, 10216.591336346537, 10262.692119236435, 10622.893771062269, 10951.014408703255, 3514.5431093957623, 3536.752427330088, 3546.113471632092, 3547.290541891606, 3567.6253993330847, 78665.82001269986, 80407.5979620104, 80677.59661201715, 81107.5944620279, 81463.37073258561, 9556.808863822685, 9597.616095356247, 9650.565724542412, 9845.360051596623, 9854.260930430246, 17559.73660395095, 18808.52978675544, 21507.67738483924, 21558.706477611395, 21568.382371322212, 7463.477556571096, 7561.0, 7655.311022008046, 7798.8050298741855, 7948.364130869517, 4102.323116685773, 4146.253674338648, 4152.8338866445, 4157.563455837094, 4170.666346692257, 3249.8862539810993, 3263.885763998249, 3517.8416971235843, 3595.0832537702718, 3598.136447252693, 625.0312016374601, 642.5149012495536, 645.0678769178492, 645.3481983197005, 679.9252082270946, 535.2399592578548, 567.7530274330679, 621.940915613016, 622.3123448589334, 629.5750368501243, 8000.439969202216, 8310.54292013945, 8535.359848011423, 8593.484390936565, 8725.127487251351, 502.8969061342416, 609.2597494044757, 621.7979156774066, 651.4234902111665, 675.5440077947366, 3799.544054713452, 3945.881623551298, 4064.878053658395, 4088.621438786952, 4194.937075943863, 87352.0, 88452.5577372109, 89319.0, 90754.0, 91204.08795912088, 71171.0, 72462.0, 72499.63750181215, 72773.636131819, 74143.62928185433, 49273.753631231615, 65727.34272657213, 66201.66899165473, 66208.33791662214, 67200.0, 6973.442124630119, 8237.093919668952, 8328.958355208428, 8363.372747044117, 8411.62147703367, 44420.111597767216, 49588.50411495839, 49746.0, 50592.74703626605, 52124.47875521348, 65050.0, 68299.3170068293, 69276.6536167316, 70053.2486687837, 70360.0, 10333.0, 10366.326188797704, 10432.947835260775, 10444.477776111316, 10691.679249622524, 11226.494807733508, 11229.66311010671, 11823.172377933462, 12050.578229761917, 12487.625371238877, 11435.313881167156, 11715.648530544097, 11822.704432389259, 11925.05952588082, 12214.75570488603, 11254.549818007188, 11882.28706277626, 11966.341851198267, 12271.815922760987, 12321.876781232073, 11009.669709908716, 11534.077273817906, 11674.0, 11685.298882067103, 11889.881101188877, 9531.951485336469, 9677.951610241904, 9852.014798520091, 10163.94918025405, 10218.489075546342, 7871.685132594632, 9064.048274931301, 9935.701928942144, 9976.451295178544, 10103.54534045955], "unit": "score", "name": "yui.html", "value": 6814.407953398716}], "name": "dromaeo_css", "value": 7585.270131662675}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 115.0, 114.0, 117.0, 125.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [149.0, 123.0, 144.0, 150.0, 119.0, 141.0, 137.0, 154.0, 141.0, 107.0], "unit": "score", "name": "audio-beat-detection", "value": 136.5}, {"lowerIsBetter": true, "replicates": [195.0, 249.0, 234.0, 267.0, 197.0, 269.0, 280.0, 224.0, 198.0, 221.0], "unit": "score", "name": "audio-dft", "value": 233.4}, {"lowerIsBetter": true, "replicates": [62.0, 72.0, 67.0, 112.0, 57.0, 58.0, 58.0, 63.0, 131.0, 47.0], "unit": "score", "name": "audio-fft", "value": 72.7}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 163.0, 118.0, 86.0, 82.0, 112.0, 119.0, 69.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [94.0, 141.0, 130.0, 93.0, 132.0, 133.0, 86.0, 91.0, 86.0, 102.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 94.0, 94.0, 95.0, 96.0, 95.0, 96.0, 105.0], "unit": "score", "name": "imaging-darkroom", "value": 96.4}, {"lowerIsBetter": true, "replicates": [90.0, 93.0, 92.0, 91.0, 117.0, 148.0, 114.0, 150.0, 144.0, 106.0], "unit": "score", "name": "imaging-desaturate", "value": 114.5}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 56.0, 59.0, 65.0, 73.0, 94.0, 87.0, 84.0], "unit": "score", "name": "json-parse-financial", "value": 69.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 75.0, 71.0, 76.0, 75.0, 95.0, 60.0, 73.0, 96.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.3}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 86.0, 87.0, 96.0, 83.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [134.0, 134.0, 134.0, 139.0, 133.0, 135.0, 121.0, 124.0, 128.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.8}, {"lowerIsBetter": true, "replicates": [129.0, 141.0, 141.0, 145.0, 163.0, 183.0, 192.0, 157.0, 139.0, 129.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 69.0, 75.0, 96.0, 97.0, 99.0, 55.0, 69.0, 101.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.3}], "name": "kraken", "value": 1575.5}]} 16:57:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1575.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7585.27"}}} 16:57:11 INFO - Return code: 0 16:57:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:11 INFO - # TBPL SUCCESS # 16:57:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:57:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:57:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:57:11 INFO - 2016-02-08 16:57:11.619 screenresolution[1696:10301] starting screenresolution argv=screenresolution get 16:57:11 INFO - 2016-02-08 16:57:11.622 screenresolution[1696:10301] Display 0: 1600x1200x32@60 16:57:11 INFO - 2016-02-08 16:57:11.628 screenresolution[1697:10304] starting screenresolution argv=screenresolution list 16:57:11 INFO - Available Modes on Display 0 16:57:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:57:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:57:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:57:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:57:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:57:11 INFO - Intel Iris: 16:57:11 INFO - Chipset Model: Intel Iris 16:57:11 INFO - Type: GPU 16:57:11 INFO - Bus: Built-In 16:57:11 INFO - VRAM (Dynamic, Max): 1536 MB 16:57:11 INFO - Vendor: Intel (0x8086) 16:57:11 INFO - Device ID: 0x0a2e 16:57:11 INFO - Revision ID: 0x0009 16:57:11 INFO - Displays: 16:57:11 INFO - Display: 16:57:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:57:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:57:11 INFO - Display Serial Number: 1600x1200 60 16:57:11 INFO - Main Display: Yes 16:57:11 INFO - Mirror: Off 16:57:11 INFO - Online: Yes 16:57:11 INFO - Rotation: Supported 16:57:11 INFO - Return code: 0 16:57:11 INFO - Running post-action listener: _resource_record_post_action 16:57:11 INFO - Running post-run listener: _resource_record_post_run 16:57:12 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39187968; Write bytes: 711755776; Read time: 422; Write time: 2186 16:57:12 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392288768; Write bytes: 382127104; Read time: 29529; Write time: 719 16:57:12 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 32947712; Write bytes: 302197760; Read time: 340; Write time: 1412 16:57:12 INFO - Running post-run listener: _upload_blobber_files 16:57:12 INFO - Blob upload gear active. 16:57:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:12 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 16:57:12 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'] 16:57:12 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 16:57:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:57:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:14 INFO - (blobuploader) - INFO - Done attempting. 16:57:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:15 INFO - (blobuploader) - INFO - Done attempting. 16:57:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:15 INFO - Return code: 0 16:57:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a8d85043c0041221d6420632cdaa60201b87c266d99d479f465eb5acac0b495260af8ff5b251b2c41dab49234e1f91ed3c8b37944264933c1819af383caf31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee3b93c1d5d7afca4570792180d58e7d376f655d73aaadd3508ca8d2e0523b5a33d04039cfba52b2aead38681fadb68f1dd9ccaadc0d64f8b6ebd2f3b9f3f6d"} 16:57:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:15 INFO - Contents: 16:57:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a8d85043c0041221d6420632cdaa60201b87c266d99d479f465eb5acac0b495260af8ff5b251b2c41dab49234e1f91ed3c8b37944264933c1819af383caf31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee3b93c1d5d7afca4570792180d58e7d376f655d73aaadd3508ca8d2e0523b5a33d04039cfba52b2aead38681fadb68f1dd9ccaadc0d64f8b6ebd2f3b9f3f6d"} 16:57:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:15 INFO - Copying logs to upload dir... 16:57:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.250836 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-08 16:57:15.400478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 16:57:15.404870) ========= 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.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/f3a8d85043c0041221d6420632cdaa60201b87c266d99d479f465eb5acac0b495260af8ff5b251b2c41dab49234e1f91ed3c8b37944264933c1819af383caf31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee3b93c1d5d7afca4570792180d58e7d376f655d73aaadd3508ca8d2e0523b5a33d04039cfba52b2aead38681fadb68f1dd9ccaadc0d64f8b6ebd2f3b9f3f6d"} build_url:https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/QP-RQcENTjabns3Qv59Z1g/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/f3a8d85043c0041221d6420632cdaa60201b87c266d99d479f465eb5acac0b495260af8ff5b251b2c41dab49234e1f91ed3c8b37944264933c1819af383caf31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee3b93c1d5d7afca4570792180d58e7d376f655d73aaadd3508ca8d2e0523b5a33d04039cfba52b2aead38681fadb68f1dd9ccaadc0d64f8b6ebd2f3b9f3f6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 16:57:15.436800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:57:15.437145) ========= 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.VO5SMPaZQY/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.DcRej5K8r3/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005154 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 16:57:15.489456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 16:57:15.489818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 16:57:15.490261) ========= ========= Total master_lag: 0.40 =========