builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1458230367.01 results: success (0) buildid: 20160317064223 builduid: 4409d237126a4110b9d71b67d6e834a9 revision: 5b3f81a3277026268277c0ba4fe4815de7751228 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 08:59:27.012316) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 08:59:27.013357) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-17 08:59:27.013644) ========= 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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005871 basedir: '/builds/slave/test' ========= master_lag: 1.58 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-17 08:59:28.597445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 30 secs) (at 2016-03-17 08:59:28.597765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 30 secs) (at 2016-03-17 08:59:59.060247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-03-17 08:59:59.060576) ========= 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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.006274 ========= master_lag: 10.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-03-17 09:00:09.192529) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 09:00:09.192828) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 09:00:09.193171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-17 09:00:09.193443) ========= 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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-17 09:00:10-- 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% 7.52M=0.002s 2016-03-17 09:00:11 (7.52 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.585159 ========= master_lag: 3.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-17 09:00:12.784768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 09:00:12.785060) ========= 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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.020289 ========= master_lag: 1.87 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 09:00:14.673824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-17 09:00:14.674154) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b3f81a3277026268277c0ba4fe4815de7751228 --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 5b3f81a3277026268277c0ba4fe4815de7751228 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-17 09:00:14,791 truncating revision to first 12 chars 2016-03-17 09:00:14,791 Setting DEBUG logging. 2016-03-17 09:00:14,791 attempt 1/10 2016-03-17 09:00:14,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b3f81a32770?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 09:00:15,411 unpacking tar archive at: fx-team-5b3f81a32770/testing/mozharness/ program finished with exit code 0 elapsedTime=0.856803 ========= master_lag: 8.69 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-17 09:00:24.217196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 09:00:24.217496) ========= echo 5b3f81a3277026268277c0ba4fe4815de7751228 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5b3f81a3277026268277c0ba4fe4815de7751228'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 5b3f81a3277026268277c0ba4fe4815de7751228 program finished with exit code 0 elapsedTime=0.005236 script_repo_revision: '5b3f81a3277026268277c0ba4fe4815de7751228' ========= master_lag: 0.63 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 09:00:24.853828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-03-17 09:00:24.854101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-03-17 09:00:26.596159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-17 09:00:26.596596) ========= /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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:00:26 INFO - MultiFileLogger online at 20160317 09:00:26 in /builds/slave/test 09:00:26 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 09:00:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:00:26 INFO - {'append_to_log': False, 09:00:26 INFO - 'base_work_dir': '/builds/slave/test', 09:00:26 INFO - 'blob_upload_branch': 'Fx-Team', 09:00:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:00:26 INFO - 'branch': 'Fx-Team', 09:00:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:00:26 INFO - 'config_files': ('talos/mac_config.py',), 09:00:26 INFO - 'default_actions': ('clobber', 09:00:26 INFO - 'read-buildbot-config', 09:00:26 INFO - 'download-and-extract', 09:00:26 INFO - 'populate-webroot', 09:00:26 INFO - 'create-virtualenv', 09:00:26 INFO - 'install', 09:00:26 INFO - 'run-tests'), 09:00:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:00:26 INFO - 'download_minidump_stackwalk': True, 09:00:26 INFO - 'download_symbols': 'ondemand', 09:00:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:00:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:00:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:00:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:00:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:00:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:00:26 INFO - 'installer_path': 'installer.exe', 09:00:26 INFO - 'log_level': 'info', 09:00:26 INFO - 'log_name': 'talos', 09:00:26 INFO - 'log_to_console': True, 09:00:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:00:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:00:26 INFO - 'opt_config_files': (), 09:00:26 INFO - 'pip_index': False, 09:00:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:00:26 INFO - 'cmd': ('bash', 09:00:26 INFO - '-c', 09:00:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:00:26 INFO - 'enabled': True, 09:00:26 INFO - 'halt_on_failure': False, 09:00:26 INFO - 'name': 'check_screen_resolution'},), 09:00:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:00:26 INFO - 'cmd': ('bash', 09:00:26 INFO - '-c', 09:00:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:00:26 INFO - 'enabled': True, 09:00:26 INFO - 'halt_on_failure': False, 09:00:26 INFO - 'name': 'check_screen_resolution'},), 09:00:26 INFO - 'run_cmd_checks_enabled': True, 09:00:26 INFO - 'sps_profile': False, 09:00:26 INFO - 'sps_profile_interval': 0, 09:00:26 INFO - 'suite': 'dromaeojs-e10s', 09:00:26 INFO - 'system_bits': '32', 09:00:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:00:26 INFO - 'title': 't-yosemite-r7-0083', 09:00:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:00:26 INFO - 'use_talos_json': True, 09:00:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:00:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:00:26 INFO - 'work_dir': 'build'} 09:00:26 INFO - ##### 09:00:26 INFO - ##### Running clobber step. 09:00:26 INFO - ##### 09:00:26 INFO - Running pre-action listener: _resource_record_pre_action 09:00:26 INFO - Running main action method: clobber 09:00:26 INFO - rmtree: /builds/slave/test/build 09:00:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:00:28 INFO - Running post-action listener: _resource_record_post_action 09:00:28 INFO - ##### 09:00:28 INFO - ##### Running read-buildbot-config step. 09:00:28 INFO - ##### 09:00:28 INFO - Running pre-action listener: _resource_record_pre_action 09:00:28 INFO - Running main action method: read_buildbot_config 09:00:28 INFO - Using buildbot properties: 09:00:28 INFO - { 09:00:28 INFO - "project": "", 09:00:28 INFO - "product": "firefox", 09:00:28 INFO - "script_repo_revision": "production", 09:00:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:00:28 INFO - "repository": "", 09:00:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:00:28 INFO - "buildid": "20160317064223", 09:00:28 INFO - "pgo_build": "False", 09:00:28 INFO - "basedir": "/builds/slave/test", 09:00:28 INFO - "buildnumber": 627, 09:00:28 INFO - "slavename": "t-yosemite-r7-0083", 09:00:28 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:00:28 INFO - "platform": "yosemite_r7", 09:00:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:00:28 INFO - "branch": "fx-team", 09:00:28 INFO - "repo_path": "integration/fx-team", 09:00:28 INFO - "revision": "5b3f81a3277026268277c0ba4fe4815de7751228", 09:00:28 INFO - "stage_platform": "macosx64", 09:00:28 INFO - "builduid": "4409d237126a4110b9d71b67d6e834a9", 09:00:28 INFO - "slavebuilddir": "test" 09:00:28 INFO - } 09:00:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:00:28 INFO - Running post-action listener: _resource_record_post_action 09:00:28 INFO - ##### 09:00:28 INFO - ##### Running download-and-extract step. 09:00:28 INFO - ##### 09:00:28 INFO - Running pre-action listener: _resource_record_pre_action 09:00:28 INFO - Running main action method: download_and_extract 09:00:28 INFO - mkdir: /builds/slave/test/build/tests 09:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:28 INFO - https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:00:32 INFO - Downloaded 1199 bytes. 09:00:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:00:32 INFO - Using the following test package requirements: 09:00:32 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:00:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:00:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:00:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'jsshell-mac.zip'], 09:00:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:00:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:00:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:00:32 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:00:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:00:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:00:32 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:00:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:00:32 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')]} 09:00:32 INFO - https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:00:34 INFO - Downloaded 17870585 bytes. 09:00:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:00:37 INFO - Return code: 0 09:00:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:37 INFO - https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:00:38 INFO - Downloaded 17870585 bytes. 09:00:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:00:42 INFO - Return code: 0 09:00: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')]} 09:00:42 INFO - https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:00:43 INFO - Downloaded 10846565 bytes. 09:00:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:00:43 INFO - Return code: 0 09:00:43 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')]} 09:00:43 INFO - https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:00:47 INFO - Downloaded 111212842 bytes. 09:00:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:00:47 INFO - mkdir: /builds/slave/test/properties 09:00:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:00:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:00:47 INFO - Contents: 09:00:47 INFO - build_url:https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:00:48 INFO - Running post-action listener: _resource_record_post_action 09:00:48 INFO - Running post-action listener: set_extra_try_arguments 09:00:48 INFO - ##### 09:00:48 INFO - ##### Running populate-webroot step. 09:00:48 INFO - ##### 09:00:48 INFO - Running pre-action listener: _resource_record_pre_action 09:00:48 INFO - Running main action method: populate_webroot 09:00:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:00:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:00:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:00:48 INFO - '--tppagecycles', 09:00:48 INFO - '7'], 09:00:48 INFO - 'tests': ['tsvgm']}}, 09:00:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:00:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:00:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:00:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:00:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'tests': ['damp', 'tps']}, 09:00:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['damp', 'tps']}, 09:00:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:00:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:00:48 INFO - 'other': {'tests': ['a11yr', 09:00:48 INFO - 'ts_paint', 09:00:48 INFO - 'tpaint', 09:00:48 INFO - 'sessionrestore', 09:00:48 INFO - 'sessionrestore_no_auto_restore', 09:00:48 INFO - 'tabpaint']}, 09:00:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['a11yr', 09:00:48 INFO - 'ts_paint', 09:00:48 INFO - 'tpaint', 09:00:48 INFO - 'sessionrestore', 09:00:48 INFO - 'sessionrestore_no_auto_restore', 09:00:48 INFO - 'tabpaint']}, 09:00:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['a11yr', 09:00:48 INFO - 'ts_paint', 09:00:48 INFO - 'tpaint', 09:00:48 INFO - 'sessionrestore', 09:00:48 INFO - 'sessionrestore_no_auto_restore', 09:00:48 INFO - 'tabpaint']}, 09:00:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['a11yr', 09:00:48 INFO - 'ts_paint', 09:00:48 INFO - 'tpaint', 09:00:48 INFO - 'sessionrestore', 09:00:48 INFO - 'sessionrestore_no_auto_restore', 09:00:48 INFO - 'tabpaint']}, 09:00:48 INFO - 'other_l64': {'tests': ['a11yr', 09:00:48 INFO - 'ts_paint', 09:00:48 INFO - 'tpaint', 09:00:48 INFO - 'sessionrestore', 09:00:48 INFO - 'sessionrestore_no_auto_restore', 09:00:48 INFO - 'tabpaint']}, 09:00:48 INFO - 'other_nol64': {'tests': ['a11yr', 09:00:48 INFO - 'ts_paint', 09:00:48 INFO - 'tpaint', 09:00:48 INFO - 'sessionrestore', 09:00:48 INFO - 'sessionrestore_no_auto_restore', 09:00:48 INFO - 'tabpaint']}, 09:00:48 INFO - 'svgr': {'tests': ['tsvgx', 09:00:48 INFO - 'tsvgr_opacity', 09:00:48 INFO - 'tart', 09:00:48 INFO - 'tscrollx', 09:00:48 INFO - 'cart']}, 09:00:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['tsvgx', 09:00:48 INFO - 'tsvgr_opacity', 09:00:48 INFO - 'tart', 09:00:48 INFO - 'tscrollx', 09:00:48 INFO - 'cart']}, 09:00:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'tests': ['tp5o']}, 09:00:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'talos_options': ['--e10s'], 09:00:48 INFO - 'tests': ['tp5o']}, 09:00:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'talos_options': ['--xperf_path', 09:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:48 INFO - 'tests': ['tp5n']}, 09:00:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:48 INFO - 'talos_options': ['--e10s', 09:00:48 INFO - '--xperf_path', 09:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:48 INFO - 'tests': ['tp5n']}}, 09:00:48 INFO - 'talos.zip': {'path': '', 09:00:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:00:48 INFO - Running post-action listener: _resource_record_post_action 09:00:48 INFO - ##### 09:00:48 INFO - ##### Running create-virtualenv step. 09:00:48 INFO - ##### 09:00:48 INFO - Running pre-action listener: _resource_record_pre_action 09:00:48 INFO - Running main action method: create_virtualenv 09:00:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:00:48 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 09:00:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:00:48 INFO - Using real prefix '/tools/python27' 09:00:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:00:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:00:52 INFO - Installing pip.................done. 09:00:52 INFO - Return code: 0 09:00:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:00:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:00:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:52 INFO - 'HOME': '/Users/cltbld', 09:00:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:52 INFO - 'LOGNAME': 'cltbld', 09:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:52 INFO - 'MOZ_NO_REMOTE': '1', 09:00:52 INFO - 'NO_EM_RESTART': '1', 09:00:52 INFO - 'PAGER': '/bin/cat', 09:00:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:52 INFO - 'PWD': '/builds/slave/test', 09:00:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:52 INFO - 'SHELL': '/bin/bash', 09:00:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:00:52 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:00:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:52 INFO - 'USER': 'cltbld', 09:00:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:52 INFO - 'XPC_FLAGS': '0x0', 09:00:52 INFO - 'XPC_SERVICE_NAME': '0', 09:00:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:52 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 09:00:52 INFO - Cleaning up... 09:00:52 INFO - Return code: 0 09:00:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:00:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:00:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:52 INFO - 'HOME': '/Users/cltbld', 09:00:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:52 INFO - 'LOGNAME': 'cltbld', 09:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:52 INFO - 'MOZ_NO_REMOTE': '1', 09:00:52 INFO - 'NO_EM_RESTART': '1', 09:00:52 INFO - 'PAGER': '/bin/cat', 09:00:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:52 INFO - 'PWD': '/builds/slave/test', 09:00:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:52 INFO - 'SHELL': '/bin/bash', 09:00:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:00:52 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:00:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:52 INFO - 'USER': 'cltbld', 09:00:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:52 INFO - 'XPC_FLAGS': '0x0', 09:00:52 INFO - 'XPC_SERVICE_NAME': '0', 09:00:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:52 INFO - Downloading/unpacking psutil>=0.7.1 09:00:52 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 09:00:52 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 09:00:52 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 09:00:52 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 09:00:52 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 09:00:52 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 09:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:55 INFO - Installing collected packages: psutil 09:00:55 INFO - Running setup.py install for psutil 09:00:55 INFO - building 'psutil._psutil_osx' extension 09:00:55 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 09:00:55 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 09:00:56 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 09:00:56 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 09:00:56 INFO - building 'psutil._psutil_posix' extension 09:00:56 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 09:00:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:00:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:00:56 INFO - ^ 09:00:56 INFO - 1 warning generated. 09:00:56 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 09:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:56 INFO - Successfully installed psutil 09:00:56 INFO - Cleaning up... 09:00:56 INFO - Return code: 0 09:00:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:56 INFO - 'HOME': '/Users/cltbld', 09:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:56 INFO - 'LOGNAME': 'cltbld', 09:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:56 INFO - 'MOZ_NO_REMOTE': '1', 09:00:56 INFO - 'NO_EM_RESTART': '1', 09:00:56 INFO - 'PAGER': '/bin/cat', 09:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:56 INFO - 'PWD': '/builds/slave/test', 09:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:56 INFO - 'SHELL': '/bin/bash', 09:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:00:56 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:56 INFO - 'USER': 'cltbld', 09:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:56 INFO - 'XPC_FLAGS': '0x0', 09:00:56 INFO - 'XPC_SERVICE_NAME': '0', 09:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:00:59 INFO - Installing collected packages: mozsystemmonitor 09:00:59 INFO - Running setup.py install for mozsystemmonitor 09:00:59 INFO - Successfully installed mozsystemmonitor 09:00:59 INFO - Cleaning up... 09:00:59 INFO - Return code: 0 09:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:59 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 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:00:59 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 09:00:59 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 09:00:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:00:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:59 INFO - 'HOME': '/Users/cltbld', 09:00:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:59 INFO - 'LOGNAME': 'cltbld', 09:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:59 INFO - 'MOZ_NO_REMOTE': '1', 09:00:59 INFO - 'NO_EM_RESTART': '1', 09:00:59 INFO - 'PAGER': '/bin/cat', 09:00:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:59 INFO - 'PWD': '/builds/slave/test', 09:00:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:59 INFO - 'SHELL': '/bin/bash', 09:00:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:00:59 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:00:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:59 INFO - 'USER': 'cltbld', 09:00:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:59 INFO - 'XPC_FLAGS': '0x0', 09:00:59 INFO - 'XPC_SERVICE_NAME': '0', 09:00:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:01:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01:02 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 09:01:02 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 09:01:02 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 09:01:02 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 09:01:02 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 09:01:02 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 09:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:01:02 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 09:01:02 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 09:01:02 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 09:01:02 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 09:01:02 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 09:01:02 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 09:01:03 INFO - Downloading docopt-0.6.1.tar.gz 09:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:03 INFO - Running setup.py install for blobuploader 09:01:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:03 INFO - Running setup.py install for requests 09:01:04 INFO - Running setup.py install for docopt 09:01:04 INFO - Successfully installed blobuploader requests docopt 09:01:04 INFO - Cleaning up... 09:01:04 INFO - Return code: 0 09:01:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:04 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')]} 09:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 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')]} 09:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 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 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:01:04 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 09:01:04 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 09:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:04 INFO - 'HOME': '/Users/cltbld', 09:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:04 INFO - 'LOGNAME': 'cltbld', 09:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:04 INFO - 'MOZ_NO_REMOTE': '1', 09:01:04 INFO - 'NO_EM_RESTART': '1', 09:01:04 INFO - 'PAGER': '/bin/cat', 09:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:04 INFO - 'PWD': '/builds/slave/test', 09:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:04 INFO - 'SHELL': '/bin/bash', 09:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:01:04 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:04 INFO - 'USER': 'cltbld', 09:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:04 INFO - 'XPC_FLAGS': '0x0', 09:01:04 INFO - 'XPC_SERVICE_NAME': '0', 09:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:04 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-9jpqqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:04 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-GJ7CQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:04 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-JBQWww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:04 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RatX9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dxX_9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-KxY_Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-7YrOV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-PtrbJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-aqbqAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-b7sPDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EdvS6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-gdOvbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Am4ITt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:05 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-v3ebtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-XZladf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-hlW83E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-uTDgl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:06 INFO - Running setup.py install for manifestparser 09:01:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:06 INFO - Running setup.py install for mozcrash 09:01:06 INFO - Running setup.py install for mozdebug 09:01:06 INFO - Running setup.py install for mozdevice 09:01:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:01:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:06 INFO - Running setup.py install for mozfile 09:01:07 INFO - Running setup.py install for mozhttpd 09:01:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:07 INFO - Running setup.py install for mozinfo 09:01:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:07 INFO - Running setup.py install for mozInstall 09:01:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:07 INFO - Running setup.py install for mozleak 09:01:07 INFO - Running setup.py install for mozlog 09:01:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:07 INFO - Running setup.py install for moznetwork 09:01:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:08 INFO - Running setup.py install for mozprocess 09:01:08 INFO - Running setup.py install for mozprofile 09:01:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:08 INFO - Running setup.py install for mozrunner 09:01:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:08 INFO - Running setup.py install for mozscreenshot 09:01:08 INFO - Running setup.py install for moztest 09:01:08 INFO - Running setup.py install for mozversion 09:01:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:08 INFO - Cleaning up... 09:01:08 INFO - Return code: 0 09:01:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:08 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 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:01:08 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 09:01:08 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 09:01:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:01:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:08 INFO - 'HOME': '/Users/cltbld', 09:01:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:08 INFO - 'LOGNAME': 'cltbld', 09:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:08 INFO - 'MOZ_NO_REMOTE': '1', 09:01:08 INFO - 'NO_EM_RESTART': '1', 09:01:08 INFO - 'PAGER': '/bin/cat', 09:01:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:08 INFO - 'PWD': '/builds/slave/test', 09:01:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:08 INFO - 'SHELL': '/bin/bash', 09:01:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:01:08 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:01:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:08 INFO - 'USER': 'cltbld', 09:01:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:08 INFO - 'XPC_FLAGS': '0x0', 09:01:08 INFO - 'XPC_SERVICE_NAME': '0', 09:01:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-KCyh6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:09 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)) 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-MJK6UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-NR_V5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:09 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)) 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-S3piJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:09 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)) 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-kODIiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:09 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)) 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Sm9ENQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:09 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)) 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-_wEg0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:09 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)) 09:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:09 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-o4VTXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Pt6nEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RgtI2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-iakagU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-9GYATF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-UifCkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-t3vbDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Vut9VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dUIQs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:10 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)) 09:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-CA8Cuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:11 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)) 09:01:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:01:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:01:11 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)) 09:01:11 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)) 09:01:11 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)) 09:01:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:13 INFO - Downloading blessings-1.6.tar.gz 09:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:13 INFO - Installing collected packages: blessings 09:01:13 INFO - Running setup.py install for blessings 09:01:13 INFO - Successfully installed blessings 09:01:13 INFO - Cleaning up... 09:01:13 INFO - Return code: 0 09:01:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:14 INFO - Reading from file tmpfile_stdout 09:01:14 INFO - Current package versions: 09:01:14 INFO - blessings == 1.6 09:01:14 INFO - blobuploader == 1.2.4 09:01:14 INFO - docopt == 0.6.1 09:01:14 INFO - manifestparser == 1.1 09:01:14 INFO - mozInstall == 1.12 09:01:14 INFO - mozcrash == 0.17 09:01:14 INFO - mozdebug == 0.1 09:01:14 INFO - mozdevice == 0.48 09:01:14 INFO - mozfile == 1.2 09:01:14 INFO - mozhttpd == 0.7 09:01:14 INFO - mozinfo == 0.9 09:01:14 INFO - mozleak == 0.1 09:01:14 INFO - mozlog == 3.1 09:01:14 INFO - moznetwork == 0.27 09:01:14 INFO - mozprocess == 0.22 09:01:14 INFO - mozprofile == 0.28 09:01:14 INFO - mozrunner == 6.11 09:01:14 INFO - mozscreenshot == 0.1 09:01:14 INFO - mozsystemmonitor == 0.0 09:01:14 INFO - moztest == 0.7 09:01:14 INFO - mozversion == 1.4 09:01:14 INFO - psutil == 3.1.1 09:01:14 INFO - requests == 1.2.3 09:01:14 INFO - wsgiref == 0.1.2 09:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:14 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 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:01:14 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 09:01:14 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 09:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:14 INFO - 'HOME': '/Users/cltbld', 09:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:14 INFO - 'LOGNAME': 'cltbld', 09:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:14 INFO - 'MOZ_NO_REMOTE': '1', 09:01:14 INFO - 'NO_EM_RESTART': '1', 09:01:14 INFO - 'PAGER': '/bin/cat', 09:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:14 INFO - 'PWD': '/builds/slave/test', 09:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:14 INFO - 'SHELL': '/bin/bash', 09:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:01:14 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:14 INFO - 'USER': 'cltbld', 09:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:14 INFO - 'XPC_FLAGS': '0x0', 09:01:14 INFO - 'XPC_SERVICE_NAME': '0', 09:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 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)) 09:01:14 INFO - Cleaning up... 09:01:14 INFO - Return code: 0 09:01:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:14 INFO - 'HOME': '/Users/cltbld', 09:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:14 INFO - 'LOGNAME': 'cltbld', 09:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:14 INFO - 'MOZ_NO_REMOTE': '1', 09:01:14 INFO - 'NO_EM_RESTART': '1', 09:01:14 INFO - 'PAGER': '/bin/cat', 09:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:14 INFO - 'PWD': '/builds/slave/test', 09:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:14 INFO - 'SHELL': '/bin/bash', 09:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:01:14 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:14 INFO - 'USER': 'cltbld', 09:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:14 INFO - 'XPC_FLAGS': '0x0', 09:01:14 INFO - 'XPC_SERVICE_NAME': '0', 09:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:14 INFO - Downloading/unpacking jsonschema 09:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:16 INFO - Downloading/unpacking functools32 (from jsonschema) 09:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:17 INFO - warning: no files found matching '*.txt' 09:01:17 INFO - no previously-included directories found matching 'build' 09:01:17 INFO - no previously-included directories found matching 'dist' 09:01:17 INFO - no previously-included directories found matching '.git*' 09:01:17 INFO - Installing collected packages: jsonschema, functools32 09:01:17 INFO - Running setup.py install for functools32 09:01:17 INFO - warning: no files found matching '*.txt' 09:01:17 INFO - no previously-included directories found matching 'build' 09:01:17 INFO - no previously-included directories found matching 'dist' 09:01:17 INFO - no previously-included directories found matching '.git*' 09:01:17 INFO - Successfully installed jsonschema functools32 09:01:17 INFO - Cleaning up... 09:01:17 INFO - Return code: 0 09:01:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa65bd93460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, '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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 09:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:17 INFO - 'HOME': '/Users/cltbld', 09:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:17 INFO - 'LOGNAME': 'cltbld', 09:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:17 INFO - 'MOZ_NO_REMOTE': '1', 09:01:17 INFO - 'NO_EM_RESTART': '1', 09:01:17 INFO - 'PAGER': '/bin/cat', 09:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:17 INFO - 'PWD': '/builds/slave/test', 09:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:17 INFO - 'SHELL': '/bin/bash', 09:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:01:17 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:17 INFO - 'USER': 'cltbld', 09:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:17 INFO - 'XPC_FLAGS': '0x0', 09:01:17 INFO - 'XPC_SERVICE_NAME': '0', 09:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:17 INFO - Downloading/unpacking flake8 09:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:01:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:01:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:21 INFO - no previously-included directories found matching 'docs/_build' 09:01:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:01:21 INFO - Running setup.py install for pep8 09:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:21 INFO - no previously-included directories found matching 'docs/_build' 09:01:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:01:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:01:21 INFO - Cleaning up... 09:01:21 INFO - Return code: 0 09:01:21 INFO - Running post-action listener: _resource_record_post_action 09:01:21 INFO - Running post-action listener: _start_resource_monitoring 09:01:22 INFO - Starting resource monitoring. 09:01:22 INFO - ##### 09:01:22 INFO - ##### Running install step. 09:01:22 INFO - ##### 09:01:22 INFO - Running pre-action listener: _resource_record_pre_action 09:01:22 INFO - Running main action method: install 09:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:22 INFO - Reading from file tmpfile_stdout 09:01:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:22 INFO - Reading from file tmpfile_stdout 09:01:22 INFO - Output received: 09:01:22 INFO - Usage: mozinstall [options] installer 09:01:22 INFO - Options: 09:01:22 INFO - -h, --help show this help message and exit 09:01:22 INFO - -d DEST, --destination=DEST 09:01:22 INFO - Directory to install application into. [default: 09:01:22 INFO - "/builds/slave/test"] 09:01:22 INFO - --app=APP Application being installed. [default: firefox] 09:01:22 INFO - mkdir: /builds/slave/test/build/application 09:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:01:56 INFO - Reading from file tmpfile_stdout 09:01:56 INFO - Output received: 09:01:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:01:56 INFO - Running post-action listener: _resource_record_post_action 09:01:56 INFO - ##### 09:01:56 INFO - ##### Running run-tests step. 09:01:56 INFO - ##### 09:01:56 INFO - Running pre-action listener: _resource_record_pre_action 09:01:56 INFO - Running main action method: run_tests 09:01:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:56 INFO - 2016-03-17 09:01:56.560 screenresolution[1909:10829] starting screenresolution argv=screenresolution get 09:01:56 INFO - 2016-03-17 09:01:56.563 screenresolution[1909:10829] Display 0: 1600x1200x32@60 09:01:56 INFO - 2016-03-17 09:01:56.569 screenresolution[1910:10831] starting screenresolution argv=screenresolution list 09:01:56 INFO - Available Modes on Display 0 09:01:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:56 INFO - Intel Iris: 09:01:56 INFO - Chipset Model: Intel Iris 09:01:56 INFO - Type: GPU 09:01:56 INFO - Bus: Built-In 09:01:56 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:56 INFO - Vendor: Intel (0x8086) 09:01:56 INFO - Device ID: 0x0a2e 09:01:56 INFO - Revision ID: 0x0009 09:01:56 INFO - Displays: 09:01:56 INFO - Display: 09:01:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:56 INFO - Display Serial Number: 1600x1200 60 09:01:56 INFO - Main Display: Yes 09:01:56 INFO - Mirror: Off 09:01:56 INFO - Online: Yes 09:01:56 INFO - Rotation: Supported 09:01:56 INFO - Return code: 0 09:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:56 INFO - Python 2.7.3 09:01:56 INFO - Return code: 0 09:01:56 INFO - grabbing minidump binary from tooltool 09:01: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')]} 09:01:56 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 0x10e010e00>, '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 0x10de79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e00bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:56 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 09:01:56 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 09:01:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:56 INFO - Return code: 0 09:01:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:01:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:01:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:01:58 INFO - Return code: 0 09:01:58 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/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 09:01:58 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/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --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 09:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YudyWMpOIZ/Render', 09:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:58 INFO - 'HOME': '/Users/cltbld', 09:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:58 INFO - 'LOGNAME': 'cltbld', 09:01:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:58 INFO - 'MOZ_NO_REMOTE': '1', 09:01:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:58 INFO - 'NO_EM_RESTART': '1', 09:01:58 INFO - 'PAGER': '/bin/cat', 09:01:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:58 INFO - 'PWD': '/builds/slave/test', 09:01:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:58 INFO - 'SHELL': '/bin/bash', 09:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQUeiM9AMq/Listeners', 09:01:58 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 09:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:58 INFO - 'USER': 'cltbld', 09:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:58 INFO - 'XPC_FLAGS': '0x0', 09:01:58 INFO - 'XPC_SERVICE_NAME': '0', 09:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:58 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/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 09:01:58 INFO - mozversion application_buildid: 20160317064223 09:01:58 INFO - mozversion application_changeset: 5b3f81a3277026268277c0ba4fe4815de7751228 09:01:58 INFO - mozversion application_display_name: Nightly 09:01:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:58 INFO - mozversion application_name: Firefox 09:01:58 INFO - mozversion application_remotingname: firefox 09:01:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:01:58 INFO - mozversion application_vendor: Mozilla 09:01:58 INFO - mozversion application_version: 48.0a1 09:01:58 INFO - mozversion platform_buildid: 20160317064223 09:01:58 INFO - mozversion platform_changeset: 5b3f81a3277026268277c0ba4fe4815de7751228 09:01:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:01:58 INFO - mozversion platform_version: 48.0a1 09:01:58 INFO - using testdate: 1458230518 09:01:58 INFO - actual date: 1458230518 09:01:58 INFO - starting webserver on 'localhost:49423' 09:01:58 INFO - SUITE-START | Running 2 tests 09:01:58 INFO - TEST-START | dromaeo_css 09:01:58 INFO - operating with platform_type : mac_ 09:01:58 INFO - Initialising browser for dromaeo_css test... 09:01:58 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmplzyg_b/profile http://localhost:49423/getInfo.html) 09:02:00 INFO - PROCESS | 1928 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:02:01 INFO - PROCESS | 1928 | __metrics Screen width/height:1600/1200 09:02:01 INFO - PROCESS | 1928 | colorDepth:24 09:02:01 INFO - PROCESS | 1928 | Browser inner width/height: 1024/689 09:02:01 INFO - PROCESS | 1928 | __metrics 09:02:01 ERROR - PROCESS | 1928 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:02:02 INFO - TEST-INFO | 1928: exit 0 09:02:02 INFO - Browser initialized. 09:02:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:02:02 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmplzyg_b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:14 INFO - PROCESS | 1932 | RSS: Main: 255598592 09:02:14 INFO - PROCESS | 1932 | 09:03:03 INFO - PROCESS | 1932 | 1458230583808 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] 09:05:13 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49423/tests/dromaeo/cssquery-ext.html) 09:05:15 INFO - PROCESS | 1932 | RSS: Main: 268308480 09:05:15 INFO - PROCESS | 1932 | 09:08:17 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49423/tests/dromaeo/cssquery-ext.html (next: http://localhost:49423/tests/dromaeo/cssquery-jquery.html) 09:08:17 INFO - PROCESS | 1932 | RSS: Main: 281419776 09:08:17 INFO - PROCESS | 1932 | 09:11:19 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49423/tests/dromaeo/cssquery-mootools.html) 09:11:20 INFO - PROCESS | 1932 | RSS: Main: 282959872 09:11:20 INFO - PROCESS | 1932 | 09:14:21 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49423/tests/dromaeo/cssquery-prototype.html) 09:14:22 INFO - PROCESS | 1932 | RSS: Main: 285409280 09:14:22 INFO - PROCESS | 1932 | 09:17:24 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49423/tests/dromaeo/cssquery-yui.html) 09:17:25 INFO - PROCESS | 1932 | RSS: Main: 286244864 09:17:25 INFO - PROCESS | 1932 | 09:20:27 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49423/tests/dromaeo/cssquery-yui.html (next: http://localhost:49423/tests/dromaeo/cssquery-dojo.html) 09:20:28 INFO - PROCESS | 1932 | RSS: Main: 288837632 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | __start_tp_report 09:20:28 INFO - PROCESS | 1932 | _x_x_mozilla_page_load 09:20:28 INFO - PROCESS | 1932 | _x_x_mozilla_page_load_details 09:20:28 INFO - PROCESS | 1932 | |i|pagename|runs| 09:20:28 INFO - PROCESS | 1932 | |0;dojo.html;2923.488389531832;2982.2544363909024;3518.7360947928905;3567.6432356764312;3598.1364472526584;5821.0686290193635;5837.7373018214175;5839.32847722511;5879.500242479389;5923.644581325118;5697.8005769798065;5836.2996440427205;5848.1812546243455;5946.464818166364;6032.125341825433;4395.6483481321575;5225.294585230983;5269.314989051418;5318.282031925679;5318.547923426513;88.13212328510612;5277.234800953859;5290.259363689087;5315;5375.731213439332;5259.368875734917;5266.7366631668265;5270.947290527103;5271.130263506517;5281.2342210379475;5219.982103489821;5302.681839089667;5303.071962406563;5324.893502129975;5331.706756128411;5196.0647083524955;5259.947400525984;5262.079136151158;5301.284326615896;5310.681359118426;5616.494515493625;5700.429957004308;5734.598578099534;5738.684372359518;5838.328592211908;5168.302279192336;6134.17188679527;6217.96891015542;6242.094896240065;6252.249730032379;6170.629762214281;6223.564350495421;6234.158388617524;6245.437910588069;6282.96858515709;5956.52347812174;6000.699965001732;6019.55910153166;6031.668258245839;6067.544934129914;6215.254169499689;6284.748610055546;6305.185303164494;6353.332900045429;6393.104965304861;6226.875462490725;6246.906296405557;6247.156633854463;6257.749690012349;6276.748930042747;6197.845053873689;6233.2208473940755;6274.058891166362;6291.905621415683;6297.811065668037;6123.343628574293;6177.81466556004;6180.7527698891545;6237.376262373727;6247.656378899113;4353.717008394444;5744.339400968942;6141.762184092961;6143.450468055797;6216.906746398808;4885.438174609965;4960.330355402047;5018.347614810052;5033.993201359743;5061.367329083864;4419.513853476115;4432.335149727567;4496.19068567661;4504.48198457175;4557.6581756368405;5830.679312637845;5931.9703401483575;6012.428819262163;6016.909746353808;6048.848778780478;6223.222097237845;6246.718897649616;6247.687615619201;6249;6262.091996660459;5857.414258574194;5961.509622594352;6009.1587177795145;6048.697565121726;6073.453389194905;5422.972885135549;5445.455454454523;5454.563634909197;5466.590005749585;5483.479069488392;6324.841878952971;6478.740850366027;6486.189226346707;6486.643234622046;6487.610743355413;6165.32181460048;6191.504679625709;6229.3770622937345;6243.250809902659;6252.531060170414;6444.742210311535;6466.51501137426;6488.837779055372;6502.219733631994;6505.642189679613;6113.663748493876;6248.406401392042;6263.561550691408;6282.937170628418;6375.9362406377195;6164.7842325518395;6236.908541005397;6253.624782513064;6253.78111766086;6262.15460912771;5210.244514545446;6213.099100630474;6245.9694150466485;6255.124282600531;6262.968685156545;6090.69546522681;6121;6121.635889161253;6177.2587289525545;6199.956289364436;5945.34601193877;6100.664463454553;6106.084087386927;6108.236470441195;6111.7740652348275;6048.879022419439;6192.195014648067;6232.968835155795;6234.220722409699;6234.345393733593;6005.759769609167;6073.969630151821;6099.75600975956;6112.358202388863;6144.662043587646 09:20:28 INFO - PROCESS | 1932 | |1;ext.html;575.0224618149144;577.494692144374;600.3216365506977;638.7604648256904;645.2289514030733;37758.622413775855;38310.85067447981;38500.61499385009;38510.22979540408;38592.80703596478;39676.60323396765;39702.40446393307;39799.602003979955;39960.400593991115;40079.59920400795;9389.530523473833;9598.328117031811;9612.134907858292;9613.327067105305;9679.90320096797;9375.249980001583;9522;9647.421154730739;9648.083432073978;9686.70939871805;9520.190783783386;9558.474283914382;9595.040495950385;9644.469554174517;9649.372790768577;9583.712488625317;9598.136167744937;9639.518024098803;9653.613855445774;9664.468454235015;9549.952250238774;9657.565409556586;9661.90338096617;9678.612855485771;9731.12419882207;32212.838935805405;38329;38675.41986870199;38693.419598706045;38827.22345553073;3118.5010398336385;3172.317951640385;3264.755143364257;3752.7560708553856;3964.8810535683974;23082;24586.385340366633;27254.45491090187;27456.039038633753;27810;2695.17797071893;2702.8918843246443;2757.200411880552;2794.4690508803264;2843.3460304130167;307292.9999999978;315506;357387;358478;362029;45119.77440112778;45712.77143614327;62231;62649.68675156595;62710.68644656839;44123.558764411944;44194.11611767811;44281;44325.55674443214;44389.112217755464;15932.681346373007;16014.19929003545;16260.59348516273;16272.75590866138;16373.590660233589;12740.872591274154;12883.420246088948;12928.224306541637;12959.935200323938;13011.544595939286;11938.582149624895;14557.199354035629;14682.706345873023;14682.779758303634;14837.777433338508;6485.513586481033;6554.344565543408;6579.111819904251;6604.14146160996;6659.700313485905;775.6005657086605;957.818014577228;958.6644674364056;987.195435719886;1093.6227001684406;29256.853715731286;29645.143917180198;29656.851715741283;29685.703142968727;30063.398732025238;973.8587904753771;1070.421972135054;1094.9069329107115;1130;1140.8117660586076;14373.92813035949;15029.699406012038;15165.848341516443;15298.158601277037;15413.229338533252;515980;521227;524102;525556;525803;58570.707146463996;58958;59788.701056494436;59895.401045989856;60038.699806501565;1395.4069520453766;1446.681730019394;1470.8970372074066;1479.142097583399;1488.9106653600818;29152.70847291585;29287.460443631273;29782.8510857453;29929.700702993563;30026.69973300239;50618;50690.98618027545;50820;50978;51028.489715102376;480270;493706;494430;495422;496031;33265.00204993854;33551.993440196835;33689.494657579664;34122.658773411946;34243.4863477043;44580.10839783251;44999.775001124784;45233.547664522936;45283.54716452793;45734.771326143156;36955;36990.815045924595;37295.06762330963;37515.43726844154;38249;36537.63462365342;36816.89549313525;37474;37523.81238093792;37832.243355132196;35686;36246.63753362433;37141.814290929455;37399.62600373961;37627.623723762415;28447.857760711064;32381.838090809397;32805;33526.66473335333;33692.83153584216;23989.880050599637;24371.903264353503;24442;24584.877075615223;24834.379140521633 09:20:28 INFO - PROCESS | 1932 | |2;jquery.html;325.4386183832888;352.418509459392;358.28700885238374;361.9348517266891;363.3477907156653;19598;19839.206431742732;20360.69458958113;20588.97055147244;21068.68396974043;17168.9698618083;17357.82642173578;20130.396088117344;21180;21265.255716049942;5179.870503237412;5325.440828712978;5367.329083864517;6036.245469316335;6053.334133245339;4255.276602977501;5964.687768690881;6327.019312006646;6601.7359305627715;6615.768448104293;6554.049662798891;6556.672166391685;6562.245341785684;6568.573042752229;6576.704048317837;5745.626534275259;5821.09772985188;5826.388229235954;5985.401459854002;6003.1895694081395;5573.41479144692;5644.971775141098;5668.716564171817;5718.313802343704;5724.313082430135;13001.219926804328;13110.14784039044;13125.540606078837;13278.734425311439;13319.334033298297;2072.823809976154;2095.5180308529125;2183.235867446397;2267.478479949604;2296.873671948042;9887.110160085555;10199.235057370726;10389.584416623326;11332.546698132064;15043.473478428203;1463.656040830404;1711.1187738314777;1723.500184946364;1794.2195145111787;1816.5186225650214;94986.05013949842;97104;98268;98341;98805.50597247039;11146.832797508045;11338.60314888975;11383.715407114723;11401.771964560663;11467.254628449291;13673.453061877612;13713.697198766102;13736.244506552235;13747.38136783847;13777.897768178522;6548.6725663716625;8092.069412017693;8522;8692.695755648649;8770.780730481662;7012.719491220396;8796.912030879737;8801.119888011148;8886.333524985652;8929.151730585583;4443.289073748185;4499.415076040159;4504.076664283814;4551.7724113794175;4555.271156614992;1775.8934463932205;1845.1696736468643;1866.2441711107024;1898.1932678611536;1922.4521011511652;872.3152325424511;897.7306807957586;916.2669864108686;917.8852643419573;923.3351986569659;18795.90602046981;19467.707984380246;19769.901150494443;20279.29022484206;20380.082896269705;837.9413441059189;967.4727273635885;993.0813997052697;1004.3622299839654;1008.4251976373397;9862.753431164278;9941;10513.316634418738;10816.891831081588;10829.404382759023;585222;615755;616736;636382;657683;110135.34796978052;112861;115324;115497.4225128869;130192.69807301805;1068.2362111090608;1075.1184029096223;1088.9618863339904;1112.0825319111766;1115.9274647147909;17992.280308787504;18075.457736267934;18281.817181828545;18561.53596160107;19433.736807107492;48842;49398;50253.497465024884;50372.748136259084;51275;65252;65347;65843.01235481376;66304.33695662982;66817.33182668306;5437.510624043855;7504.649163150467;7813.10149332834;7992.880106798519;8039.15588863161;7832.530048197126;11676;12181.33002684861;12202.938985305016;12576.434060467118;9938.602455901682;10494.265401421828;10713.625023124154;10759.3544387337;10762.623308184176;8732.738017859474;8819.867701984604;9361.923378811523;10071.949640251752;10310.690679279634;10504.42225677595;10592.629257975934;10690;11124.888751112385;11377.20359574855;7722.382209423345;7766.223377662189;7804.453688241769;7877.803054923444;8194.262516373556;8114.878276825971;9962.750931226487;10892.346459212156;11240.606578769704;11252.043576296106 09:20:28 INFO - PROCESS | 1932 | |3;mootools.html;1607.0518394147455;1633.1262774415686;1940.3790786948182;2008.5480766827466;2019.717239586459;7829.960850195741;8689;8937;9123.635054597817;9223.400478968862;8776.605052772624;8802.251808596277;8871.822563548725;8873.334499912517;8885.111488851111;2475.393528585499;2490.850548967068;2499.3501689560753;2504.584909526121;2510.2092840755195;2436.8659723715186;2492.476579918219;2496.8252222344445;2512.8617926014063;2513.6355228491857;2462.9753702462926;2476.5170791695627;2481.081999660128;2517.8615176165304;2528.797696184301;2342.402687314724;2455.8403703759286;2461.126300163443;2480.4790993891215;2501.774840264367;1995.5510010247579;2449.6080627099755;2479.3429741118616;2490.1657944588583;2497.463045445238;7571.621418929031;8858.68994585193;9014.233790127848;9041.502717350542;9069.818603627957;5444.8366549003595;5501.064818980783;5559.166125081229;5578.525825304854;5679.233303504016;3621.149029977953;3679.172186258097;3750.868719594801;3773.396256598931;3778.7732736035928;1055.9260851740382;1073.6295977887617;1075.0539525217757;1075.2419544221384;1081.2971568480473;11976.580819671357;12157.148999570034;12163.878361216452;12185.45165467556;12205.93897030518;4859.271109333628;4892.828750993698;4916.0905232532095;4928.802847886116;4963.8014479421145;10333.22500812442;10333.22500812442;10344.482775861177;10346.637867674595;10351.741206469747;5487.451254874481;5503.449655034465;5535.391106978229;5537.501624853782;5558.972205138948;4461.531539188403;4876;4982.277569752366;5015.27278544609;5023.799048038038;3910.2961466936226;3975.0062484378905;3993.2412841560013;4018.698597605133;4037.555868854424;1324.7615429222833;1324.7747882859937;1335.5459143891123;1339.7387509435762;1350.4598160735588;1331.7269959658247;1339.7856342985076;1352.1008529328083;1367.2070199284392;1372.670559065817;8254.257116859511;8256.669733210605;8262.504249745034;8300.70947516834;8313.08556058833;503.7103665392341;510.4104759003357;514.6911852888312;515.2580284390466;517.0899217377367;6143.692815359214;6228.968855155696;6243.875122497616;6255.280642726145;6276.435120839055;10492.370457772558;10951.069159121405;10992.120630349553;11039.83440248397;11104.555817767361;10540.367577945348;10837.241393102564;10840.078593319657;10896.836547451794;10958.506867190996;8397.748067557983;8474.364422668325;8482.151784821468;8523.445976011539;8563.186497282748;7857.371410287049;7933.206679332021;8055.516668999879;8057.5165490070785;8094.271515563628;9376.249900008119;9437;9538.998405167635;9570.521473926416;9656;8929.464232146092;9728.659496917573;9757.902420975983;9935.751606209902;10063;6847;7348.706051758084;7514.661840217313;7535.284148005931;7556.773296801105;8193.303569196685;8305.294050005818;8372.204640559137;8377.748667539983;8390.496570205807;6460.547761656639;7355.926440735524;7452.254774522505;7509.474336796372;7635.847283054419;7126.429885609243;7288.234735352712;7408.666610002455;7412.518186317872;7418.517796343221;7469.178390377163;7664.73173438927;7787;7876.763697089096;7900.881486777818;6931.514793964374;7065.540739851893;7095.716171353088;7103.467239957127;7136;7168;7230.674619642234;7235.565866048054;7242.565446073252;7260.310270524292 09:20:28 INFO - PROCESS | 1932 | |4;prototype.html;329.1064759178829;330.7073240182438;331.7743934124797;336.47845838949627;340.14284004309127;7053.977173309867;7135.964320178392;7140.50016498844;7154.177269613996;7160.6419679016035;7028.578285302872;7032.929670703292;7065.646717664109;7068.0104785330095;7090.3618674319305;3721.6464435878684;4884.19410797218;4967.950320496803;5023.773930173133;5154.020736060146;4953.3560637117125;5064.544191022807;5078.619103567229;5089.7455127243675;5096.184610462326;5024.799008039692;5026.145555255597;5046.84859454217;5051.267566202917;5084.288199652052;5040.319556859832;5048.242763585492;5051.494850514956;5053.267276244942;5064.265681476184;3568.4468907319406;4349.630281426083;4358.455193100863;4359.561344756223;4363.978180109111;6397.5521713480075;6660.633665148415;6761;6792.626405547693;6795.762148324785;4911.484294149134;5788.42115788422;5914.349421563625;5922.7038648067855;5929;5965.821025369202;7466.066741657293;7481.962590187069;7486.700531978714;7518.097828260589;3769.773813571167;4651.651126165551;4742.834000809955;4747.7388743619085;4771.23660214364;6336.303006669263;6347.9047814283285;6393.7762178324;7989.520628762293;7996.200379962015;4659.767011649404;4816.229403295456;4818.903621927612;4833.782479788418;4839.177339852234;4015.3374693175883;4874.926876096862;4928.162212423897;4932.432770231398;4947.208446648519;4828.830990915301;5903.3801450847905;5961.5230781537375;5983.760649574056;6005.219321488178;7515.586642734702;7521.4734968551675;7530.5858177799655;7545.320921117126;7575.621218939031;1589.682063587287;1684.4525529203058;1705.5224537129623;1706.385701147586;1706.6858518940346;1040.3497813866334;1073.4793625091825;1085.8696956365286;1087.2280680716622;1102.8676558812833;5708.686022268815;6967;7009.1939426966555;7045.859082818418;7051.153861536648;7473.252674732592;7793.220677932275;7794.532328060334;7806.453548251681;7815;6496.7726129585235;6822.863542729117;7077.902925046626;7083.92916070843;7085.433165346863;4077.8164982575854;4132.194222126656;4140.91718165635;4142.482189726285;4145.067359844072;8193.82863541162;8211.17888211174;8211.630476628567;8229.547374894439;8243.464174828618;7857.646405911748;8088.797780055428;8102.880391049488;8130.268275855202;8135.430519863553;8183.099859015503;8227.629756660965;8236.176382361835;8243.299319557786;8245.257926786619;6271;7830.33442157423;7856.292933636;7864.449488535747;7908.6045697713735;6180.81457556274;7693.49992250502;7715.189905059888;7734.187910269341;7907.971963644689;7930.127685954656;8204.83590328202;8204.83590328202;8207.466514676527;8217.876731848908;4806.158922188673;4823.807047718193;4826.396700412449;4829.806807727651;4839.491853355347;7776.300132988058;7777.727779527916;7784.41616878725;7787.29914307715;7789.454738168501;7216.5670059796585;7487.625618719151;7494.812629684301;7500;7518.586477743776;6458.095866578588;7163;7514.924850751422;7517.661705223388;7520.097588289222;7274.781756547312;7340.339369456775;7343.3390994810725;7348.044754181922;7362.079740032496;7431.479796414199;7472.29013243741;7473.364763995121;7490.70037198506;7504.887426688495;7039.859202815813;7332.48040940341;7350.448716346403;7359.484836061639;7406.7037318506655 09:20:28 INFO - PROCESS | 1932 | |5;yui.html;702.3889216381747;728.3444899590371;757.2805834457265;766.321805202396;783.1189911349732;14578.78131828022;14670.559883203494;14782.18697971611;14791.926040369797;14825.703485930288;13607.727845443085;13678.794818077737;13700.314984250772;13708.040437169402;13878.583642490716;706;848;894.1237587164583;912.8356895758761;913.0732306708663;901.0223907060847;908.9227415669676;919.0258326174243;921.7096614566424;922.5848368234288;918.1002617434917;967.4485543240356;974.8001659659752;975.1321324021626;979.5102448775613;919.1360121485782;953.6709835106947;961.1013702188407;968.9660861869836;972.9902700972971;707.0172460280214;713.6396119959387;713.9250378710265;726.9927300726978;727.5162017258517;14399.136051836924;14421.567352979428;14438.783418248735;14516.346764395628;14776.778348324784;12449.377531123499;12460.75078498425;12504.687382815502;12666.176698514568;12747.36263186837;9807.607695692235;9886;9926.602935882556;9979.101880830687;10333.22500812442;3458.8962331130106;3503.6321186275327;3559.893203203908;3566.982165089184;3621.8189090545366;78526;78559.6072019642;78726.03184920366;80959.59520202361;81411.59294203551;9180.495072771062;9345.532723363805;9477.905220947703;9641.855372169422;10018.699439016842;21077.26229581988;21456.034478448506;21493.89253053756;21499.817510036784;21533.03101360411;6435.452986496107;7190.424766018706;7406.925930740731;7504.737334193277;7533.510321829063;3557.146284891659;3900.531936167678;4093.4473846031;4096.713230073866;4099.159672267178;3577.803220822828;3585.731070169748;3590.7845529267806;3611.8013509256716;3621.619729928372;557.6096732287415;677.5906115280205;677.7187467201056;680.3706571421515;681.0397339750928;583.7081459270365;592.9673867937305;597.1073245497921;604.4620287943734;613.4448324266546;7821.765347039598;7844.882326765103;7950.880736788837;8035.236652518001;8145.551994640352;567.7501899164355;585.1719816459662;587.9208979155552;589.3988132105314;595.8569943213685;3710.777353358807;3723.255348930171;3771.5474143103;3888.8250028748207;3928.0769019280447;92279;94137;94289.0571094294;94432;95261;68732.656336719;70263.89208323759;80195;81551;82016.53950381499;50877.23684144741;69140.27149321207;69445.999999999;71525.64237178885;71783.64108179425;7598.164201937893;7602.043346724242;7607.505512141693;7886.211378862068;8006.83986320282;52300.95398092093;52345.73827130992;52581.9483610318;52743.736281319885;52921.94156116779;65002.34997649963;68415;70428.94356584758;72207;72249.638751808;9700.660476883275;9701.757456063655;9794.75513112178;9823;10215.693529194135;10663.520141593492;10726.195535334726;10755.354678719303;10813.243072984815;10830.458477076272;10140.391576505433;10151.289409741246;10161.847572286273;10463.581456741646;10484;10017.749556261151;10146.391216527032;10194.490275486345;11501.079913607058;11514.94242528782;10827.133829293794;10845.674629761119;11145.38700371455;11215.214934954802;11545.422728863692;9087.909120908706;9312.44125352481;9454.290928180551;9577.569009394454;9782.559784809842;9475.763105922408;9534.427665568286;9575;9576.616935322509;9744.415335079635 09:20:28 INFO - PROCESS | 1932 | __end_tp_report 09:20:28 INFO - PROCESS | 1932 | __start_cc_report 09:20:28 INFO - PROCESS | 1932 | _x_x_mozilla_cycle_collect,365 09:20:28 INFO - PROCESS | 1932 | __end_cc_report 09:20:28 INFO - PROCESS | 1932 | __startTimestamp1458231628053__endTimestamp 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | ------- Summary: start ------- 09:20:28 INFO - PROCESS | 1932 | Number of tests: 6 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | [#0] dojo.html Cycles:165 Average:5765.78 Median:6090.70 stddev:802.35 (13.2%) stddev-sans-first:773.21 09:20:28 INFO - PROCESS | 1932 | Values: 2923.5 2982.3 3518.7 3567.6 3598.1 5821.1 5837.7 5839.3 5879.5 5923.6 5697.8 5836.3 5848.2 5946.5 6032.1 4395.6 5225.3 5269.3 5318.3 5318.5 88.1 5277.2 5290.3 5315.0 5375.7 5259.4 5266.7 5270.9 5271.1 5281.2 5220.0 5302.7 5303.1 5324.9 5331.7 5196.1 5259.9 5262.1 5301.3 5310.7 5616.5 5700.4 5734.6 5738.7 5838.3 5168.3 6134.2 6218.0 6242.1 6252.2 6170.6 6223.6 6234.2 6245.4 6283.0 5956.5 6000.7 6019.6 6031.7 6067.5 6215.3 6284.7 6305.2 6353.3 6393.1 6226.9 6246.9 6247.2 6257.7 6276.7 6197.8 6233.2 6274.1 6291.9 6297.8 6123.3 6177.8 6180.8 6237.4 6247.7 4353.7 5744.3 6141.8 6143.5 6216.9 4885.4 4960.3 5018.3 5034.0 5061.4 4419.5 4432.3 4496.2 4504.5 4557.7 5830.7 5932.0 6012.4 6016.9 6048.8 6223.2 6246.7 6247.7 6249.0 6262.1 5857.4 5961.5 6009.2 6048.7 6073.5 5423.0 5445.5 5454.6 5466.6 5483.5 6324.8 6478.7 6486.2 6486.6 6487.6 6165.3 6191.5 6229.4 6243.3 6252.5 6444.7 6466.5 6488.8 6502.2 6505.6 6113.7 6248.4 6263.6 6282.9 6375.9 6164.8 6236.9 6253.6 6253.8 6262.2 5210.2 6213.1 6246.0 6255.1 6263.0 6090.7 6121.0 6121.6 6177.3 6200.0 5945.3 6100.7 6106.1 6108.2 6111.8 6048.9 6192.2 6233.0 6234.2 6234.3 6005.8 6074.0 6099.8 6112.4 6144.7 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | [#1] ext.html Cycles:180 Average:59331.61 Median:38279.93 stddev:122033.80 (318.8%) stddev-sans-first:122296.40 09:20:28 INFO - PROCESS | 1932 | Values: 575.0 577.5 600.3 638.8 645.2 37758.6 38310.9 38500.6 38510.2 38592.8 39676.6 39702.4 39799.6 39960.4 40079.6 9389.5 9598.3 9612.1 9613.3 9679.9 9375.2 9522.0 9647.4 9648.1 9686.7 9520.2 9558.5 9595.0 9644.5 9649.4 9583.7 9598.1 9639.5 9653.6 9664.5 9550.0 9657.6 9661.9 9678.6 9731.1 32212.8 38329.0 38675.4 38693.4 38827.2 3118.5 3172.3 3264.8 3752.8 3964.9 23082.0 24586.4 27254.5 27456.0 27810.0 2695.2 2702.9 2757.2 2794.5 2843.3 307293.0 315506.0 357387.0 358478.0 362029.0 45119.8 45712.8 62231.0 62649.7 62710.7 44123.6 44194.1 44281.0 44325.6 44389.1 15932.7 16014.2 16260.6 16272.8 16373.6 12740.9 12883.4 12928.2 12959.9 13011.5 11938.6 14557.2 14682.7 14682.8 14837.8 6485.5 6554.3 6579.1 6604.1 6659.7 775.6 957.8 958.7 987.2 1093.6 29256.9 29645.1 29656.9 29685.7 30063.4 973.9 1070.4 1094.9 1130.0 1140.8 14373.9 15029.7 15165.8 15298.2 15413.2 515980.0 521227.0 524102.0 525556.0 525803.0 58570.7 58958.0 59788.7 59895.4 60038.7 1395.4 1446.7 1470.9 1479.1 1488.9 29152.7 29287.5 29782.9 29929.7 30026.7 50618.0 50691.0 50820.0 50978.0 51028.5 480270.0 493706.0 494430.0 495422.0 496031.0 33265.0 33552.0 33689.5 34122.7 34243.5 44580.1 44999.8 45233.5 45283.5 45734.8 36955.0 36990.8 37295.1 37515.4 38249.0 36537.6 36816.9 37474.0 37523.8 37832.2 35686.0 36246.6 37141.8 37399.6 37627.6 28447.9 32381.8 32805.0 33526.7 33692.8 23989.9 24371.9 24442.0 24584.9 24834.4 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | [#2] jquery.html Cycles:180 Average:33834.03 Median:362.64 stddev:103030.11 (28411.0%) stddev-sans-first:103288.41 09:20:28 INFO - PROCESS | 1932 | Values: 325.4 352.4 358.3 361.9 363.3 19598.0 19839.2 20360.7 20589.0 21068.7 17169.0 17357.8 20130.4 21180.0 21265.3 5179.9 5325.4 5367.3 6036.2 6053.3 4255.3 5964.7 6327.0 6601.7 6615.8 6554.0 6556.7 6562.2 6568.6 6576.7 5745.6 5821.1 5826.4 5985.4 6003.2 5573.4 5645.0 5668.7 5718.3 5724.3 13001.2 13110.1 13125.5 13278.7 13319.3 2072.8 2095.5 2183.2 2267.5 2296.9 9887.1 10199.2 10389.6 11332.5 15043.5 1463.7 1711.1 1723.5 1794.2 1816.5 94986.1 97104.0 98268.0 98341.0 98805.5 11146.8 11338.6 11383.7 11401.8 11467.3 13673.5 13713.7 13736.2 13747.4 13777.9 6548.7 8092.1 8522.0 8692.7 8770.8 7012.7 8796.9 8801.1 8886.3 8929.2 4443.3 4499.4 4504.1 4551.8 4555.3 1775.9 1845.2 1866.2 1898.2 1922.5 872.3 897.7 916.3 917.9 923.3 18795.9 19467.7 19769.9 20279.3 20380.1 837.9 967.5 993.1 1004.4 1008.4 9862.8 9941.0 10513.3 10816.9 10829.4 585222.0 615755.0 616736.0 636382.0 657683.0 110135.3 112861.0 115324.0 115497.4 130192.7 1068.2 1075.1 1089.0 1112.1 1115.9 17992.3 18075.5 18281.8 18561.5 19433.7 48842.0 49398.0 50253.5 50372.7 51275.0 65252.0 65347.0 65843.0 66304.3 66817.3 5437.5 7504.6 7813.1 7992.9 8039.2 7832.5 11676.0 12181.3 12202.9 12576.4 9938.6 10494.3 10713.6 10759.4 10762.6 8732.7 8819.9 9361.9 10071.9 10310.7 10504.4 10592.6 10690.0 11124.9 11377.2 7722.4 7766.2 7804.5 7877.8 8194.3 8114.9 9962.8 10892.3 11240.6 11252.0 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | [#3] mootools.html Cycles:180 Average:6112.40 Median:2980.96 stddev:3237.41 (108.6%) stddev-sans-first:3228.79 09:20:28 INFO - PROCESS | 1932 | Values: 1607.1 1633.1 1940.4 2008.5 2019.7 7830.0 8689.0 8937.0 9123.6 9223.4 8776.6 8802.3 8871.8 8873.3 8885.1 2475.4 2490.9 2499.4 2504.6 2510.2 2436.9 2492.5 2496.8 2512.9 2513.6 2463.0 2476.5 2481.1 2517.9 2528.8 2342.4 2455.8 2461.1 2480.5 2501.8 1995.6 2449.6 2479.3 2490.2 2497.5 7571.6 8858.7 9014.2 9041.5 9069.8 5444.8 5501.1 5559.2 5578.5 5679.2 3621.1 3679.2 3750.9 3773.4 3778.8 1055.9 1073.6 1075.1 1075.2 1081.3 11976.6 12157.1 12163.9 12185.5 12205.9 4859.3 4892.8 4916.1 4928.8 4963.8 10333.2 10333.2 10344.5 10346.6 10351.7 5487.5 5503.4 5535.4 5537.5 5559.0 4461.5 4876.0 4982.3 5015.3 5023.8 3910.3 3975.0 3993.2 4018.7 4037.6 1324.8 1324.8 1335.5 1339.7 1350.5 1331.7 1339.8 1352.1 1367.2 1372.7 8254.3 8256.7 8262.5 8300.7 8313.1 503.7 510.4 514.7 515.3 517.1 6143.7 6229.0 6243.9 6255.3 6276.4 10492.4 10951.1 10992.1 11039.8 11104.6 10540.4 10837.2 10840.1 10896.8 10958.5 8397.7 8474.4 8482.2 8523.4 8563.2 7857.4 7933.2 8055.5 8057.5 8094.3 9376.2 9437.0 9539.0 9570.5 9656.0 8929.5 9728.7 9757.9 9935.8 10063.0 6847.0 7348.7 7514.7 7535.3 7556.8 8193.3 8305.3 8372.2 8377.7 8390.5 6460.5 7355.9 7452.3 7509.5 7635.8 7126.4 7288.2 7408.7 7412.5 7418.5 7469.2 7664.7 7787.0 7876.8 7900.9 6931.5 7065.5 7095.7 7103.5 7136.0 7168.0 7230.7 7235.6 7242.6 7260.3 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | [#4] prototype.html Cycles:180 Average:6052.13 Median:6988.10 stddev:2004.48 (28.7%) stddev-sans-first:1963.54 09:20:28 INFO - PROCESS | 1932 | Values: 329.1 330.7 331.8 336.5 340.1 7054.0 7136.0 7140.5 7154.2 7160.6 7028.6 7032.9 7065.6 7068.0 7090.4 3721.6 4884.2 4968.0 5023.8 5154.0 4953.4 5064.5 5078.6 5089.7 5096.2 5024.8 5026.1 5046.8 5051.3 5084.3 5040.3 5048.2 5051.5 5053.3 5064.3 3568.4 4349.6 4358.5 4359.6 4364.0 6397.6 6660.6 6761.0 6792.6 6795.8 4911.5 5788.4 5914.3 5922.7 5929.0 5965.8 7466.1 7482.0 7486.7 7518.1 3769.8 4651.7 4742.8 4747.7 4771.2 6336.3 6347.9 6393.8 7989.5 7996.2 4659.8 4816.2 4818.9 4833.8 4839.2 4015.3 4874.9 4928.2 4932.4 4947.2 4828.8 5903.4 5961.5 5983.8 6005.2 7515.6 7521.5 7530.6 7545.3 7575.6 1589.7 1684.5 1705.5 1706.4 1706.7 1040.3 1073.5 1085.9 1087.2 1102.9 5708.7 6967.0 7009.2 7045.9 7051.2 7473.3 7793.2 7794.5 7806.5 7815.0 6496.8 6822.9 7077.9 7083.9 7085.4 4077.8 4132.2 4140.9 4142.5 4145.1 8193.8 8211.2 8211.6 8229.5 8243.5 7857.6 8088.8 8102.9 8130.3 8135.4 8183.1 8227.6 8236.2 8243.3 8245.3 6271.0 7830.3 7856.3 7864.4 7908.6 6180.8 7693.5 7715.2 7734.2 7908.0 7930.1 8204.8 8204.8 8207.5 8217.9 4806.2 4823.8 4826.4 4829.8 4839.5 7776.3 7777.7 7784.4 7787.3 7789.5 7216.6 7487.6 7494.8 7500.0 7518.6 6458.1 7163.0 7514.9 7517.7 7520.1 7274.8 7340.3 7343.3 7348.0 7362.1 7431.5 7472.3 7473.4 7490.7 7504.9 7039.9 7332.5 7350.4 7359.5 7406.7 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - PROCESS | 1932 | [#5] yui.html Cycles:180 Average:18111.48 Median:34548.02 stddev:25780.72 (74.6%) stddev-sans-first:25819.90 09:20:28 INFO - PROCESS | 1932 | Values: 702.4 728.3 757.3 766.3 783.1 14578.8 14670.6 14782.2 14791.9 14825.7 13607.7 13678.8 13700.3 13708.0 13878.6 706.0 848.0 894.1 912.8 913.1 901.0 908.9 919.0 921.7 922.6 918.1 967.4 974.8 975.1 979.5 919.1 953.7 961.1 969.0 973.0 707.0 713.6 713.9 727.0 727.5 14399.1 14421.6 14438.8 14516.3 14776.8 12449.4 12460.8 12504.7 12666.2 12747.4 9807.6 9886.0 9926.6 9979.1 10333.2 3458.9 3503.6 3559.9 3567.0 3621.8 78526.0 78559.6 78726.0 80959.6 81411.6 9180.5 9345.5 9477.9 9641.9 10018.7 21077.3 21456.0 21493.9 21499.8 21533.0 6435.5 7190.4 7406.9 7504.7 7533.5 3557.1 3900.5 4093.4 4096.7 4099.2 3577.8 3585.7 3590.8 3611.8 3621.6 557.6 677.6 677.7 680.4 681.0 583.7 593.0 597.1 604.5 613.4 7821.8 7844.9 7950.9 8035.2 8145.6 567.8 585.2 587.9 589.4 595.9 3710.8 3723.3 3771.5 3888.8 3928.1 92279.0 94137.0 94289.1 94432.0 95261.0 68732.7 70263.9 80195.0 81551.0 82016.5 50877.2 69140.3 69446.0 71525.6 71783.6 7598.2 7602.0 7607.5 7886.2 8006.8 52301.0 52345.7 52581.9 52743.7 52921.9 65002.3 68415.0 70428.9 72207.0 72249.6 9700.7 9701.8 9794.8 9823.0 10215.7 10663.5 10726.2 10755.4 10813.2 10830.5 10140.4 10151.3 10161.8 10463.6 10484.0 10017.7 10146.4 10194.5 11501.1 11514.9 10827.1 10845.7 11145.4 11215.2 11545.4 9087.9 9312.4 9454.3 9577.6 9782.6 9475.8 9534.4 9575.0 9576.6 9744.4 09:20:28 INFO - PROCESS | 1932 | -------- Summary: end -------- 09:20:28 INFO - PROCESS | 1932 | 09:20:28 INFO - TEST-INFO | 1932: exit 0 09:20:28 INFO - TEST-OK | dromaeo_css | took 1110274ms 09:20:28 INFO - TEST-START | kraken 09:20:28 INFO - operating with platform_type : mac_ 09:20:28 INFO - Initialising browser for kraken test... 09:20:28 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp8QRRYV/profile http://localhost:49423/getInfo.html) 09:20:31 INFO - PROCESS | 1939 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:20:31 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 09:20:31 INFO - PROCESS | 1939 | colorDepth:24 09:20:31 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 09:20:31 INFO - PROCESS | 1939 | __metrics 09:20:31 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:20:32 INFO - TEST-INFO | 1939: exit 0 09:20:32 INFO - Browser initialized. 09:20:32 INFO - Running cycle 1/1 for kraken test... 09:20:32 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp8QRRYV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:44 INFO - PROCESS | 1942 | RSS: Main: 257359872 09:20:44 INFO - PROCESS | 1942 | 09:20:47 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49423/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:47 INFO - PROCESS | 1942 | RSS: Main: 267780096 09:20:47 INFO - PROCESS | 1942 | 09:20:50 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49423/tests/kraken/driver.html?testName=audio-dft) 09:20:51 INFO - PROCESS | 1942 | RSS: Main: 276684800 09:20:51 INFO - PROCESS | 1942 | 09:20:54 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49423/tests/kraken/driver.html?testName=audio-fft) 09:20:54 INFO - PROCESS | 1942 | RSS: Main: 281272320 09:20:54 INFO - PROCESS | 1942 | 09:20:56 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49423/tests/kraken/driver.html?testName=audio-oscillator) 09:20:57 INFO - PROCESS | 1942 | RSS: Main: 283430912 09:20:57 INFO - PROCESS | 1942 | 09:20:59 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:00 INFO - PROCESS | 1942 | RSS: Main: 284246016 09:21:00 INFO - PROCESS | 1942 | 09:21:02 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49423/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:03 INFO - PROCESS | 1942 | RSS: Main: 283537408 09:21:03 INFO - PROCESS | 1942 | 09:21:06 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49423/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:06 INFO - PROCESS | 1942 | RSS: Main: 283631616 09:21:06 INFO - PROCESS | 1942 | 09:21:09 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49423/tests/kraken/driver.html?testName=json-parse-financial) 09:21:10 INFO - PROCESS | 1942 | RSS: Main: 283959296 09:21:10 INFO - PROCESS | 1942 | 09:21:12 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:12 INFO - PROCESS | 1942 | RSS: Main: 283725824 09:21:12 INFO - PROCESS | 1942 | 09:21:14 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:15 INFO - PROCESS | 1942 | RSS: Main: 283619328 09:21:15 INFO - PROCESS | 1942 | 09:21:17 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:17 INFO - PROCESS | 1942 | RSS: Main: 283865088 09:21:17 INFO - PROCESS | 1942 | 09:21:20 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:21 INFO - PROCESS | 1942 | RSS: Main: 284844032 09:21:21 INFO - PROCESS | 1942 | 09:21:23 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:24 INFO - PROCESS | 1942 | RSS: Main: 284221440 09:21:24 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49423/tests/kraken/driver.html?testName=ai-astar) 09:21:26 INFO - PROCESS | 1942 | RSS: Main: 284819456 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | __start_tp_report 09:21:26 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 09:21:26 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 09:21:26 INFO - PROCESS | 1942 | |i|pagename|runs| 09:21:26 INFO - PROCESS | 1942 | |0;ai-astar;115;113;117;116;114;124;118;160;168;116 09:21:26 INFO - PROCESS | 1942 | |1;audio-beat-detection;159;117;148;171;127;146;139;123;158;118 09:21:26 INFO - PROCESS | 1942 | |2;audio-dft;198;197;197;212;230;223;232;195;202;198 09:21:26 INFO - PROCESS | 1942 | |3;audio-fft;59;60;67;75;111;132;59;59;57;61 09:21:26 INFO - PROCESS | 1942 | |4;audio-oscillator;95;87;120;81;81;83;118;83;110;113 09:21:26 INFO - PROCESS | 1942 | |5;imaging-gaussian-blur;91;88;90;87;90;106;91;89;92;124 09:21:26 INFO - PROCESS | 1942 | |6;imaging-darkroom;96;97;96;96;94;96;96;104;95;95 09:21:26 INFO - PROCESS | 1942 | |7;imaging-desaturate;141;133;92;98;131;92;93;91;90;94 09:21:26 INFO - PROCESS | 1942 | |8;json-parse-financial;58;59;56;57;55;58;57;63;56;56 09:21:26 INFO - PROCESS | 1942 | |9;json-stringify-tinderbox;67;64;69;65;76;71;67;65;69;70 09:21:26 INFO - PROCESS | 1942 | |10;stanford-crypto-aes;98;99;90;83;84;84;85;85;83;102 09:21:26 INFO - PROCESS | 1942 | |11;stanford-crypto-ccm;118;122;124;133;139;142;123;137;138;141 09:21:26 INFO - PROCESS | 1942 | |12;stanford-crypto-pbkdf2;131;144;142;142;144;139;169;183;185;179 09:21:26 INFO - PROCESS | 1942 | |13;stanford-crypto-sha256-iterative;58;63;77;86;87;79;96;101;58;89 09:21:26 INFO - PROCESS | 1942 | __end_tp_report 09:21:26 INFO - PROCESS | 1942 | __start_cc_report 09:21:26 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,962 09:21:26 INFO - PROCESS | 1942 | __end_cc_report 09:21:26 INFO - PROCESS | 1942 | __startTimestamp1458231686507__endTimestamp 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | ------- Summary: start ------- 09:21:26 INFO - PROCESS | 1942 | Number of tests: 14 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#0] ai-astar Cycles:10 Average:126.10 Median:117.50 stddev:20.28 (17.3%) stddev-sans-first:21.11 09:21:26 INFO - PROCESS | 1942 | Values: 115.0 113.0 117.0 116.0 114.0 124.0 118.0 160.0 168.0 116.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:147.00 stddev:18.90 (12.9%) stddev-sans-first:18.84 09:21:26 INFO - PROCESS | 1942 | Values: 159.0 117.0 148.0 171.0 127.0 146.0 139.0 123.0 158.0 118.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#2] audio-dft Cycles:10 Average:208.40 Median:207.00 stddev:14.71 (7.1%) stddev-sans-first:15.11 09:21:26 INFO - PROCESS | 1942 | Values: 198.0 197.0 197.0 212.0 230.0 223.0 232.0 195.0 202.0 198.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#3] audio-fft Cycles:10 Average:74.00 Median:59.50 stddev:26.06 (43.8%) stddev-sans-first:27.07 09:21:26 INFO - PROCESS | 1942 | Values: 59.0 60.0 67.0 75.0 111.0 132.0 59.0 59.0 57.0 61.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:82.00 stddev:16.34 (19.9%) stddev-sans-first:17.31 09:21:26 INFO - PROCESS | 1942 | Values: 95.0 87.0 120.0 81.0 81.0 83.0 118.0 83.0 110.0 113.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:90.00 stddev:11.55 (12.8%) stddev-sans-first:12.17 09:21:26 INFO - PROCESS | 1942 | Values: 91.0 88.0 90.0 87.0 90.0 106.0 91.0 89.0 92.0 124.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:96.00 stddev:2.76 (2.9%) stddev-sans-first:2.92 09:21:26 INFO - PROCESS | 1942 | Values: 96.0 97.0 96.0 96.0 94.0 96.0 96.0 104.0 95.0 95.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:92.00 stddev:20.62 (22.4%) stddev-sans-first:17.41 09:21:26 INFO - PROCESS | 1942 | Values: 141.0 133.0 92.0 98.0 131.0 92.0 93.0 91.0 90.0 94.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:2.27 (4.0%) stddev-sans-first:2.40 09:21:26 INFO - PROCESS | 1942 | Values: 58.0 59.0 56.0 57.0 55.0 58.0 57.0 63.0 56.0 56.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:3.56 (5.2%) stddev-sans-first:3.75 09:21:26 INFO - PROCESS | 1942 | Values: 67.0 64.0 69.0 65.0 76.0 71.0 67.0 65.0 69.0 70.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:85.00 stddev:7.48 (8.8%) stddev-sans-first:7.25 09:21:26 INFO - PROCESS | 1942 | Values: 98.0 99.0 90.0 83.0 84.0 84.0 85.0 85.0 83.0 102.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:137.50 stddev:9.02 (6.6%) stddev-sans-first:8.09 09:21:26 INFO - PROCESS | 1942 | Values: 118.0 122.0 124.0 133.0 139.0 142.0 123.0 137.0 138.0 141.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:156.50 stddev:20.71 (13.2%) stddev-sans-first:19.93 09:21:26 INFO - PROCESS | 1942 | Values: 131.0 144.0 142.0 142.0 144.0 139.0 169.0 183.0 185.0 179.0 09:21:26 INFO - PROCESS | 1942 | 09:21:26 INFO - PROCESS | 1942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.40 Median:82.50 stddev:15.37 (18.6%) stddev-sans-first:14.22 09:21:26 INFO - PROCESS | 1942 | Values: 58.0 63.0 77.0 86.0 87.0 79.0 96.0 101.0 58.0 89.0 09:21:26 INFO - PROCESS | 1942 | -------- Summary: end -------- 09:21:26 INFO - PROCESS | 1942 | 09:21:27 INFO - TEST-INFO | 1942: exit 0 09:21:27 INFO - TEST-OK | kraken | took 58647ms 09:21:27 INFO - SUITE-END | took 1168s 09:21:27 INFO - Completed test suite (00:19:29) 09:21:27 INFO - javascript benchmark 09:21:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2923.488389531832, 2982.2544363909024, 3518.7360947928905, 3567.6432356764312, 3598.1364472526584, 5821.0686290193635, 5837.7373018214175, 5839.32847722511, 5879.500242479389, 5923.644581325118, 5697.8005769798065, 5836.2996440427205, 5848.1812546243455, 5946.464818166364, 6032.125341825433, 4395.6483481321575, 5225.294585230983, 5269.314989051418, 5318.282031925679, 5318.547923426513, 88.13212328510612, 5277.234800953859, 5290.259363689087, 5315.0, 5375.731213439332, 5259.368875734917, 5266.7366631668265, 5270.947290527103, 5271.130263506517, 5281.2342210379475, 5219.982103489821, 5302.681839089667, 5303.071962406563, 5324.893502129975, 5331.706756128411, 5196.0647083524955, 5259.947400525984, 5262.079136151158, 5301.284326615896, 5310.681359118426, 5616.494515493625, 5700.429957004308, 5734.598578099534, 5738.684372359518, 5838.328592211908, 5168.302279192336, 6134.17188679527, 6217.96891015542, 6242.094896240065, 6252.249730032379, 6170.629762214281, 6223.564350495421, 6234.158388617524, 6245.437910588069, 6282.96858515709, 5956.52347812174, 6000.699965001732, 6019.55910153166, 6031.668258245839, 6067.544934129914, 6215.254169499689, 6284.748610055546, 6305.185303164494, 6353.332900045429, 6393.104965304861, 6226.875462490725, 6246.906296405557, 6247.156633854463, 6257.749690012349, 6276.748930042747, 6197.845053873689, 6233.2208473940755, 6274.058891166362, 6291.905621415683, 6297.811065668037, 6123.343628574293, 6177.81466556004, 6180.7527698891545, 6237.376262373727, 6247.656378899113, 4353.717008394444, 5744.339400968942, 6141.762184092961, 6143.450468055797, 6216.906746398808, 4885.438174609965, 4960.330355402047, 5018.347614810052, 5033.993201359743, 5061.367329083864, 4419.513853476115, 4432.335149727567, 4496.19068567661, 4504.48198457175, 4557.6581756368405, 5830.679312637845, 5931.9703401483575, 6012.428819262163, 6016.909746353808, 6048.848778780478, 6223.222097237845, 6246.718897649616, 6247.687615619201, 6249.0, 6262.091996660459, 5857.414258574194, 5961.509622594352, 6009.1587177795145, 6048.697565121726, 6073.453389194905, 5422.972885135549, 5445.455454454523, 5454.563634909197, 5466.590005749585, 5483.479069488392, 6324.841878952971, 6478.740850366027, 6486.189226346707, 6486.643234622046, 6487.610743355413, 6165.32181460048, 6191.504679625709, 6229.3770622937345, 6243.250809902659, 6252.531060170414, 6444.742210311535, 6466.51501137426, 6488.837779055372, 6502.219733631994, 6505.642189679613, 6113.663748493876, 6248.406401392042, 6263.561550691408, 6282.937170628418, 6375.9362406377195, 6164.7842325518395, 6236.908541005397, 6253.624782513064, 6253.78111766086, 6262.15460912771, 5210.244514545446, 6213.099100630474, 6245.9694150466485, 6255.124282600531, 6262.968685156545, 6090.69546522681, 6121.0, 6121.635889161253, 6177.2587289525545, 6199.956289364436, 5945.34601193877, 6100.664463454553, 6106.084087386927, 6108.236470441195, 6111.7740652348275, 6048.879022419439, 6192.195014648067, 6232.968835155795, 6234.220722409699, 6234.345393733593, 6005.759769609167, 6073.969630151821, 6099.75600975956, 6112.358202388863, 6144.662043587646], "unit": "score", "name": "dojo.html", "value": 5716.5035221991}, {"lowerIsBetter": false, "replicates": [575.0224618149144, 577.494692144374, 600.3216365506977, 638.7604648256904, 645.2289514030733, 37758.622413775855, 38310.85067447981, 38500.61499385009, 38510.22979540408, 38592.80703596478, 39676.60323396765, 39702.40446393307, 39799.602003979955, 39960.400593991115, 40079.59920400795, 9389.530523473833, 9598.328117031811, 9612.134907858292, 9613.327067105305, 9679.90320096797, 9375.249980001583, 9522.0, 9647.421154730739, 9648.083432073978, 9686.70939871805, 9520.190783783386, 9558.474283914382, 9595.040495950385, 9644.469554174517, 9649.372790768577, 9583.712488625317, 9598.136167744937, 9639.518024098803, 9653.613855445774, 9664.468454235015, 9549.952250238774, 9657.565409556586, 9661.90338096617, 9678.612855485771, 9731.12419882207, 32212.838935805405, 38329.0, 38675.41986870199, 38693.419598706045, 38827.22345553073, 3118.5010398336385, 3172.317951640385, 3264.755143364257, 3752.7560708553856, 3964.8810535683974, 23082.0, 24586.385340366633, 27254.45491090187, 27456.039038633753, 27810.0, 2695.17797071893, 2702.8918843246443, 2757.200411880552, 2794.4690508803264, 2843.3460304130167, 307292.9999999978, 315506.0, 357387.0, 358478.0, 362029.0, 45119.77440112778, 45712.77143614327, 62231.0, 62649.68675156595, 62710.68644656839, 44123.558764411944, 44194.11611767811, 44281.0, 44325.55674443214, 44389.112217755464, 15932.681346373007, 16014.19929003545, 16260.59348516273, 16272.75590866138, 16373.590660233589, 12740.872591274154, 12883.420246088948, 12928.224306541637, 12959.935200323938, 13011.544595939286, 11938.582149624895, 14557.199354035629, 14682.706345873023, 14682.779758303634, 14837.777433338508, 6485.513586481033, 6554.344565543408, 6579.111819904251, 6604.14146160996, 6659.700313485905, 775.6005657086605, 957.818014577228, 958.6644674364056, 987.195435719886, 1093.6227001684406, 29256.853715731286, 29645.143917180198, 29656.851715741283, 29685.703142968727, 30063.398732025238, 973.8587904753771, 1070.421972135054, 1094.9069329107115, 1130.0, 1140.8117660586076, 14373.92813035949, 15029.699406012038, 15165.848341516443, 15298.158601277037, 15413.229338533252, 515980.0, 521227.0, 524102.0, 525556.0, 525803.0, 58570.707146463996, 58958.0, 59788.701056494436, 59895.401045989856, 60038.699806501565, 1395.4069520453766, 1446.681730019394, 1470.8970372074066, 1479.142097583399, 1488.9106653600818, 29152.70847291585, 29287.460443631273, 29782.8510857453, 29929.700702993563, 30026.69973300239, 50618.0, 50690.98618027545, 50820.0, 50978.0, 51028.489715102376, 480270.0, 493706.0, 494430.0, 495422.0, 496031.0, 33265.00204993854, 33551.993440196835, 33689.494657579664, 34122.658773411946, 34243.4863477043, 44580.10839783251, 44999.775001124784, 45233.547664522936, 45283.54716452793, 45734.771326143156, 36955.0, 36990.815045924595, 37295.06762330963, 37515.43726844154, 38249.0, 36537.63462365342, 36816.89549313525, 37474.0, 37523.81238093792, 37832.243355132196, 35686.0, 36246.63753362433, 37141.814290929455, 37399.62600373961, 37627.623723762415, 28447.857760711064, 32381.838090809397, 32805.0, 33526.66473335333, 33692.83153584216, 23989.880050599637, 24371.903264353503, 24442.0, 24584.877075615223, 24834.379140521633], "unit": "score", "name": "ext.html", "value": 19004.37977866034}, {"lowerIsBetter": false, "replicates": [325.4386183832888, 352.418509459392, 358.28700885238374, 361.9348517266891, 363.3477907156653, 19598.0, 19839.206431742732, 20360.69458958113, 20588.97055147244, 21068.68396974043, 17168.9698618083, 17357.82642173578, 20130.396088117344, 21180.0, 21265.255716049942, 5179.870503237412, 5325.440828712978, 5367.329083864517, 6036.245469316335, 6053.334133245339, 4255.276602977501, 5964.687768690881, 6327.019312006646, 6601.7359305627715, 6615.768448104293, 6554.049662798891, 6556.672166391685, 6562.245341785684, 6568.573042752229, 6576.704048317837, 5745.626534275259, 5821.09772985188, 5826.388229235954, 5985.401459854002, 6003.1895694081395, 5573.41479144692, 5644.971775141098, 5668.716564171817, 5718.313802343704, 5724.313082430135, 13001.219926804328, 13110.14784039044, 13125.540606078837, 13278.734425311439, 13319.334033298297, 2072.823809976154, 2095.5180308529125, 2183.235867446397, 2267.478479949604, 2296.873671948042, 9887.110160085555, 10199.235057370726, 10389.584416623326, 11332.546698132064, 15043.473478428203, 1463.656040830404, 1711.1187738314777, 1723.500184946364, 1794.2195145111787, 1816.5186225650214, 94986.05013949842, 97104.0, 98268.0, 98341.0, 98805.50597247039, 11146.832797508045, 11338.60314888975, 11383.715407114723, 11401.771964560663, 11467.254628449291, 13673.453061877612, 13713.697198766102, 13736.244506552235, 13747.38136783847, 13777.897768178522, 6548.6725663716625, 8092.069412017693, 8522.0, 8692.695755648649, 8770.780730481662, 7012.719491220396, 8796.912030879737, 8801.119888011148, 8886.333524985652, 8929.151730585583, 4443.289073748185, 4499.415076040159, 4504.076664283814, 4551.7724113794175, 4555.271156614992, 1775.8934463932205, 1845.1696736468643, 1866.2441711107024, 1898.1932678611536, 1922.4521011511652, 872.3152325424511, 897.7306807957586, 916.2669864108686, 917.8852643419573, 923.3351986569659, 18795.90602046981, 19467.707984380246, 19769.901150494443, 20279.29022484206, 20380.082896269705, 837.9413441059189, 967.4727273635885, 993.0813997052697, 1004.3622299839654, 1008.4251976373397, 9862.753431164278, 9941.0, 10513.316634418738, 10816.891831081588, 10829.404382759023, 585222.0, 615755.0, 616736.0, 636382.0, 657683.0, 110135.34796978052, 112861.0, 115324.0, 115497.4225128869, 130192.69807301805, 1068.2362111090608, 1075.1184029096223, 1088.9618863339904, 1112.0825319111766, 1115.9274647147909, 17992.280308787504, 18075.457736267934, 18281.817181828545, 18561.53596160107, 19433.736807107492, 48842.0, 49398.0, 50253.497465024884, 50372.748136259084, 51275.0, 65252.0, 65347.0, 65843.01235481376, 66304.33695662982, 66817.33182668306, 5437.510624043855, 7504.649163150467, 7813.10149332834, 7992.880106798519, 8039.15588863161, 7832.530048197126, 11676.0, 12181.33002684861, 12202.938985305016, 12576.434060467118, 9938.602455901682, 10494.265401421828, 10713.625023124154, 10759.3544387337, 10762.623308184176, 8732.738017859474, 8819.867701984604, 9361.923378811523, 10071.949640251752, 10310.690679279634, 10504.42225677595, 10592.629257975934, 10690.0, 11124.888751112385, 11377.20359574855, 7722.382209423345, 7766.223377662189, 7804.453688241769, 7877.803054923444, 8194.262516373556, 8114.878276825971, 9962.750931226487, 10892.346459212156, 11240.606578769704, 11252.043576296106], "unit": "score", "name": "jquery.html", "value": 9082.568806324109}, {"lowerIsBetter": false, "replicates": [1607.0518394147455, 1633.1262774415686, 1940.3790786948182, 2008.5480766827466, 2019.717239586459, 7829.960850195741, 8689.0, 8937.0, 9123.635054597817, 9223.400478968862, 8776.605052772624, 8802.251808596277, 8871.822563548725, 8873.334499912517, 8885.111488851111, 2475.393528585499, 2490.850548967068, 2499.3501689560753, 2504.584909526121, 2510.2092840755195, 2436.8659723715186, 2492.476579918219, 2496.8252222344445, 2512.8617926014063, 2513.6355228491857, 2462.9753702462926, 2476.5170791695627, 2481.081999660128, 2517.8615176165304, 2528.797696184301, 2342.402687314724, 2455.8403703759286, 2461.126300163443, 2480.4790993891215, 2501.774840264367, 1995.5510010247579, 2449.6080627099755, 2479.3429741118616, 2490.1657944588583, 2497.463045445238, 7571.621418929031, 8858.68994585193, 9014.233790127848, 9041.502717350542, 9069.818603627957, 5444.8366549003595, 5501.064818980783, 5559.166125081229, 5578.525825304854, 5679.233303504016, 3621.149029977953, 3679.172186258097, 3750.868719594801, 3773.396256598931, 3778.7732736035928, 1055.9260851740382, 1073.6295977887617, 1075.0539525217757, 1075.2419544221384, 1081.2971568480473, 11976.580819671357, 12157.148999570034, 12163.878361216452, 12185.45165467556, 12205.93897030518, 4859.271109333628, 4892.828750993698, 4916.0905232532095, 4928.802847886116, 4963.8014479421145, 10333.22500812442, 10333.22500812442, 10344.482775861177, 10346.637867674595, 10351.741206469747, 5487.451254874481, 5503.449655034465, 5535.391106978229, 5537.501624853782, 5558.972205138948, 4461.531539188403, 4876.0, 4982.277569752366, 5015.27278544609, 5023.799048038038, 3910.2961466936226, 3975.0062484378905, 3993.2412841560013, 4018.698597605133, 4037.555868854424, 1324.7615429222833, 1324.7747882859937, 1335.5459143891123, 1339.7387509435762, 1350.4598160735588, 1331.7269959658247, 1339.7856342985076, 1352.1008529328083, 1367.2070199284392, 1372.670559065817, 8254.257116859511, 8256.669733210605, 8262.504249745034, 8300.70947516834, 8313.08556058833, 503.7103665392341, 510.4104759003357, 514.6911852888312, 515.2580284390466, 517.0899217377367, 6143.692815359214, 6228.968855155696, 6243.875122497616, 6255.280642726145, 6276.435120839055, 10492.370457772558, 10951.069159121405, 10992.120630349553, 11039.83440248397, 11104.555817767361, 10540.367577945348, 10837.241393102564, 10840.078593319657, 10896.836547451794, 10958.506867190996, 8397.748067557983, 8474.364422668325, 8482.151784821468, 8523.445976011539, 8563.186497282748, 7857.371410287049, 7933.206679332021, 8055.516668999879, 8057.5165490070785, 8094.271515563628, 9376.249900008119, 9437.0, 9538.998405167635, 9570.521473926416, 9656.0, 8929.464232146092, 9728.659496917573, 9757.902420975983, 9935.751606209902, 10063.0, 6847.0, 7348.706051758084, 7514.661840217313, 7535.284148005931, 7556.773296801105, 8193.303569196685, 8305.294050005818, 8372.204640559137, 8377.748667539983, 8390.496570205807, 6460.547761656639, 7355.926440735524, 7452.254774522505, 7509.474336796372, 7635.847283054419, 7126.429885609243, 7288.234735352712, 7408.666610002455, 7412.518186317872, 7418.517796343221, 7469.178390377163, 7664.73173438927, 7787.0, 7876.763697089096, 7900.881486777818, 6931.514793964374, 7065.540739851893, 7095.716171353088, 7103.467239957127, 7136.0, 7168.0, 7230.674619642234, 7235.565866048054, 7242.565446073252, 7260.310270524292], "unit": "score", "name": "mootools.html", "value": 4909.337564709773}, {"lowerIsBetter": false, "replicates": [329.1064759178829, 330.7073240182438, 331.7743934124797, 336.47845838949627, 340.14284004309127, 7053.977173309867, 7135.964320178392, 7140.50016498844, 7154.177269613996, 7160.6419679016035, 7028.578285302872, 7032.929670703292, 7065.646717664109, 7068.0104785330095, 7090.3618674319305, 3721.6464435878684, 4884.19410797218, 4967.950320496803, 5023.773930173133, 5154.020736060146, 4953.3560637117125, 5064.544191022807, 5078.619103567229, 5089.7455127243675, 5096.184610462326, 5024.799008039692, 5026.145555255597, 5046.84859454217, 5051.267566202917, 5084.288199652052, 5040.319556859832, 5048.242763585492, 5051.494850514956, 5053.267276244942, 5064.265681476184, 3568.4468907319406, 4349.630281426083, 4358.455193100863, 4359.561344756223, 4363.978180109111, 6397.5521713480075, 6660.633665148415, 6761.0, 6792.626405547693, 6795.762148324785, 4911.484294149134, 5788.42115788422, 5914.349421563625, 5922.7038648067855, 5929.0, 5965.821025369202, 7466.066741657293, 7481.962590187069, 7486.700531978714, 7518.097828260589, 3769.773813571167, 4651.651126165551, 4742.834000809955, 4747.7388743619085, 4771.23660214364, 6336.303006669263, 6347.9047814283285, 6393.7762178324, 7989.520628762293, 7996.200379962015, 4659.767011649404, 4816.229403295456, 4818.903621927612, 4833.782479788418, 4839.177339852234, 4015.3374693175883, 4874.926876096862, 4928.162212423897, 4932.432770231398, 4947.208446648519, 4828.830990915301, 5903.3801450847905, 5961.5230781537375, 5983.760649574056, 6005.219321488178, 7515.586642734702, 7521.4734968551675, 7530.5858177799655, 7545.320921117126, 7575.621218939031, 1589.682063587287, 1684.4525529203058, 1705.5224537129623, 1706.385701147586, 1706.6858518940346, 1040.3497813866334, 1073.4793625091825, 1085.8696956365286, 1087.2280680716622, 1102.8676558812833, 5708.686022268815, 6967.0, 7009.1939426966555, 7045.859082818418, 7051.153861536648, 7473.252674732592, 7793.220677932275, 7794.532328060334, 7806.453548251681, 7815.0, 6496.7726129585235, 6822.863542729117, 7077.902925046626, 7083.92916070843, 7085.433165346863, 4077.8164982575854, 4132.194222126656, 4140.91718165635, 4142.482189726285, 4145.067359844072, 8193.82863541162, 8211.17888211174, 8211.630476628567, 8229.547374894439, 8243.464174828618, 7857.646405911748, 8088.797780055428, 8102.880391049488, 8130.268275855202, 8135.430519863553, 8183.099859015503, 8227.629756660965, 8236.176382361835, 8243.299319557786, 8245.257926786619, 6271.0, 7830.33442157423, 7856.292933636, 7864.449488535747, 7908.6045697713735, 6180.81457556274, 7693.49992250502, 7715.189905059888, 7734.187910269341, 7907.971963644689, 7930.127685954656, 8204.83590328202, 8204.83590328202, 8207.466514676527, 8217.876731848908, 4806.158922188673, 4823.807047718193, 4826.396700412449, 4829.806807727651, 4839.491853355347, 7776.300132988058, 7777.727779527916, 7784.41616878725, 7787.29914307715, 7789.454738168501, 7216.5670059796585, 7487.625618719151, 7494.812629684301, 7500.0, 7518.586477743776, 6458.095866578588, 7163.0, 7514.924850751422, 7517.661705223388, 7520.097588289222, 7274.781756547312, 7340.339369456775, 7343.3390994810725, 7348.044754181922, 7362.079740032496, 7431.479796414199, 7472.29013243741, 7473.364763995121, 7490.70037198506, 7504.887426688495, 7039.859202815813, 7332.48040940341, 7350.448716346403, 7359.484836061639, 7406.7037318506655], "unit": "score", "name": "prototype.html", "value": 5378.805862340815}, {"lowerIsBetter": false, "replicates": [702.3889216381747, 728.3444899590371, 757.2805834457265, 766.321805202396, 783.1189911349732, 14578.78131828022, 14670.559883203494, 14782.18697971611, 14791.926040369797, 14825.703485930288, 13607.727845443085, 13678.794818077737, 13700.314984250772, 13708.040437169402, 13878.583642490716, 706.0, 848.0, 894.1237587164583, 912.8356895758761, 913.0732306708663, 901.0223907060847, 908.9227415669676, 919.0258326174243, 921.7096614566424, 922.5848368234288, 918.1002617434917, 967.4485543240356, 974.8001659659752, 975.1321324021626, 979.5102448775613, 919.1360121485782, 953.6709835106947, 961.1013702188407, 968.9660861869836, 972.9902700972971, 707.0172460280214, 713.6396119959387, 713.9250378710265, 726.9927300726978, 727.5162017258517, 14399.136051836924, 14421.567352979428, 14438.783418248735, 14516.346764395628, 14776.778348324784, 12449.377531123499, 12460.75078498425, 12504.687382815502, 12666.176698514568, 12747.36263186837, 9807.607695692235, 9886.0, 9926.602935882556, 9979.101880830687, 10333.22500812442, 3458.8962331130106, 3503.6321186275327, 3559.893203203908, 3566.982165089184, 3621.8189090545366, 78526.0, 78559.6072019642, 78726.03184920366, 80959.59520202361, 81411.59294203551, 9180.495072771062, 9345.532723363805, 9477.905220947703, 9641.855372169422, 10018.699439016842, 21077.26229581988, 21456.034478448506, 21493.89253053756, 21499.817510036784, 21533.03101360411, 6435.452986496107, 7190.424766018706, 7406.925930740731, 7504.737334193277, 7533.510321829063, 3557.146284891659, 3900.531936167678, 4093.4473846031, 4096.713230073866, 4099.159672267178, 3577.803220822828, 3585.731070169748, 3590.7845529267806, 3611.8013509256716, 3621.619729928372, 557.6096732287415, 677.5906115280205, 677.7187467201056, 680.3706571421515, 681.0397339750928, 583.7081459270365, 592.9673867937305, 597.1073245497921, 604.4620287943734, 613.4448324266546, 7821.765347039598, 7844.882326765103, 7950.880736788837, 8035.236652518001, 8145.551994640352, 567.7501899164355, 585.1719816459662, 587.9208979155552, 589.3988132105314, 595.8569943213685, 3710.777353358807, 3723.255348930171, 3771.5474143103, 3888.8250028748207, 3928.0769019280447, 92279.0, 94137.0, 94289.0571094294, 94432.0, 95261.0, 68732.656336719, 70263.89208323759, 80195.0, 81551.0, 82016.53950381499, 50877.23684144741, 69140.27149321207, 69445.999999999, 71525.64237178885, 71783.64108179425, 7598.164201937893, 7602.043346724242, 7607.505512141693, 7886.211378862068, 8006.83986320282, 52300.95398092093, 52345.73827130992, 52581.9483610318, 52743.736281319885, 52921.94156116779, 65002.34997649963, 68415.0, 70428.94356584758, 72207.0, 72249.638751808, 9700.660476883275, 9701.757456063655, 9794.75513112178, 9823.0, 10215.693529194135, 10663.520141593492, 10726.195535334726, 10755.354678719303, 10813.243072984815, 10830.458477076272, 10140.391576505433, 10151.289409741246, 10161.847572286273, 10463.581456741646, 10484.0, 10017.749556261151, 10146.391216527032, 10194.490275486345, 11501.079913607058, 11514.94242528782, 10827.133829293794, 10845.674629761119, 11145.38700371455, 11215.214934954802, 11545.422728863692, 9087.909120908706, 9312.44125352481, 9454.290928180551, 9577.569009394454, 9782.559784809842, 9475.763105922408, 9534.427665568286, 9575.0, 9576.616935322509, 9744.415335079635], "unit": "score", "name": "yui.html", "value": 6799.810614782535}], "name": "dromaeo_css", "value": 7494.42661027577}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 113.0, 117.0, 116.0, 114.0, 124.0, 118.0, 160.0, 168.0, 116.0], "unit": "score", "name": "ai-astar", "value": 126.1}, {"lowerIsBetter": true, "replicates": [159.0, 117.0, 148.0, 171.0, 127.0, 146.0, 139.0, 123.0, 158.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 140.6}, {"lowerIsBetter": true, "replicates": [198.0, 197.0, 197.0, 212.0, 230.0, 223.0, 232.0, 195.0, 202.0, 198.0], "unit": "score", "name": "audio-dft", "value": 208.4}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 67.0, 75.0, 111.0, 132.0, 59.0, 59.0, 57.0, 61.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [95.0, 87.0, 120.0, 81.0, 81.0, 83.0, 118.0, 83.0, 110.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 97.1}, {"lowerIsBetter": true, "replicates": [91.0, 88.0, 90.0, 87.0, 90.0, 106.0, 91.0, 89.0, 92.0, 124.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 94.0, 96.0, 96.0, 104.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 96.5}, {"lowerIsBetter": true, "replicates": [141.0, 133.0, 92.0, 98.0, 131.0, 92.0, 93.0, 91.0, 90.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 105.5}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 56.0, 57.0, 55.0, 58.0, 57.0, 63.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 69.0, 65.0, 76.0, 71.0, 67.0, 65.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 90.0, 83.0, 84.0, 84.0, 85.0, 85.0, 83.0, 102.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 124.0, 133.0, 139.0, 142.0, 123.0, 137.0, 138.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.7}, {"lowerIsBetter": true, "replicates": [131.0, 144.0, 142.0, 142.0, 144.0, 139.0, 169.0, 183.0, 185.0, 179.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.8}, {"lowerIsBetter": true, "replicates": [58.0, 63.0, 77.0, 86.0, 87.0, 79.0, 96.0, 101.0, 58.0, 89.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.4}], "name": "kraken", "value": 1525.0}]} 09:21:27 INFO - Return code: 0 09:21:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:21:27 ERROR - # TBPL SUCCESS # 09:21:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:21:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:21:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:21:27 INFO - 2016-03-17 09:21:27.795 screenresolution[1947:13635] starting screenresolution argv=screenresolution get 09:21:27 INFO - 2016-03-17 09:21:27.798 screenresolution[1947:13635] Display 0: 1600x1200x32@60 09:21:27 INFO - 2016-03-17 09:21:27.804 screenresolution[1948:13638] starting screenresolution argv=screenresolution list 09:21:27 INFO - Available Modes on Display 0 09:21:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:21:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:21:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:21:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:21:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:21:28 INFO - Intel Iris: 09:21:28 INFO - Chipset Model: Intel Iris 09:21:28 INFO - Type: GPU 09:21:28 INFO - Bus: Built-In 09:21:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:21:28 INFO - Vendor: Intel (0x8086) 09:21:28 INFO - Device ID: 0x0a2e 09:21:28 INFO - Revision ID: 0x0009 09:21:28 INFO - Displays: 09:21:28 INFO - Display: 09:21:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:21:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:21:28 INFO - Display Serial Number: 1600x1200 60 09:21:28 INFO - Main Display: Yes 09:21:28 INFO - Mirror: Off 09:21:28 INFO - Online: Yes 09:21:28 INFO - Rotation: Supported 09:21:28 INFO - Return code: 0 09:21:28 INFO - Running post-action listener: _resource_record_post_action 09:21:28 INFO - Running post-run listener: _resource_record_post_run 09:21:29 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 2740224; Write bytes: 707092480; Read time: 45; Write time: 2289 09:21:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393277952; Write bytes: 386974720; Read time: 30009; Write time: 688 09:21:29 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 2740224; Write bytes: 301714432; Read time: 45; Write time: 1556 09:21:29 INFO - Running post-run listener: _upload_blobber_files 09:21:29 INFO - Blob upload gear active. 09:21:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:29 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 09:21:29 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'] 09:21:29 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 09:21:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:30 INFO - (blobuploader) - INFO - Done attempting. 09:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:31 INFO - (blobuploader) - INFO - Done attempting. 09:21:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:31 INFO - Return code: 0 09:21:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92878e2dfc86d0c22efd32a599f09988dd9c2660f56bf7df7509227fcb40628ce4623b156a061aca10470746fcc99f340e93e0a7d6435eff7f59e39c5d82c919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2bc7951e23abd341fc7bfcaa098e4929aac6cb3b2531a622716b7a21c79b9e6c7a64f2275a61a53466c62f0b84a778e481ce733b3430eb88e8ba85952890126"} 09:21:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:31 INFO - Contents: 09:21:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92878e2dfc86d0c22efd32a599f09988dd9c2660f56bf7df7509227fcb40628ce4623b156a061aca10470746fcc99f340e93e0a7d6435eff7f59e39c5d82c919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2bc7951e23abd341fc7bfcaa098e4929aac6cb3b2531a622716b7a21c79b9e6c7a64f2275a61a53466c62f0b84a778e481ce733b3430eb88e8ba85952890126"} 09:21:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:31 INFO - Copying logs to upload dir... 09:21:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.851881 ========= master_lag: 4.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-17 09:21:36.389431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 09:21:36.394842) ========= 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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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/92878e2dfc86d0c22efd32a599f09988dd9c2660f56bf7df7509227fcb40628ce4623b156a061aca10470746fcc99f340e93e0a7d6435eff7f59e39c5d82c919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2bc7951e23abd341fc7bfcaa098e4929aac6cb3b2531a622716b7a21c79b9e6c7a64f2275a61a53466c62f0b84a778e481ce733b3430eb88e8ba85952890126"} build_url:https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011008 build_url: 'https://queue.taskcluster.net/v1/task/DBBNTxb8QTGt57wqh4SxDA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92878e2dfc86d0c22efd32a599f09988dd9c2660f56bf7df7509227fcb40628ce4623b156a061aca10470746fcc99f340e93e0a7d6435eff7f59e39c5d82c919", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2bc7951e23abd341fc7bfcaa098e4929aac6cb3b2531a622716b7a21c79b9e6c7a64f2275a61a53466c62f0b84a778e481ce733b3430eb88e8ba85952890126"}' ========= master_lag: 0.77 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 09:21:37.172156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:21:37.172486) ========= 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.YudyWMpOIZ/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.PQUeiM9AMq/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005347 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:21:37.224757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 09:21:37.225066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 09:21:37.230439) ========= ========= Total master_lag: 31.65 =========