builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1460058371.0 results: success (0) buildid: 20160407115853 builduid: 61865a9ba917442790027f8857189b7d revision: 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:11.003012) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:11.003436) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-04-07 12:46:11.003765) ========= 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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005818 basedir: '/builds/slave/test' ========= master_lag: 4.99 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-04-07 12:46:15.999918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-04-07 12:46:16.000291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-04-07 12:46:22.087070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.087523) ========= 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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005543 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.114912) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.115242) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.115789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.116124) ========= 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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-07 12:46:22-- 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.93M=0.001s 2016-04-07 12:46:22 (7.93 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190579 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.477925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.478287) ========= 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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.020290 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:22.516685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 12:46:22.517478) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 --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 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-07 12:46:22,599 truncating revision to first 12 chars 2016-04-07 12:46:22,600 Setting DEBUG logging. 2016-04-07 12:46:22,600 attempt 1/10 2016-04-07 12:46:22,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0559e1ea4660?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 12:46:23,819 unpacking tar archive at: fx-team-0559e1ea4660/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 12:46:24.014339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:24.015247) ========= echo 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0559e1ea4660abf46d6ad114bb6518e9d26c5b33'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 program finished with exit code 0 elapsedTime=0.005171 script_repo_revision: '0559e1ea4660abf46d6ad114bb6518e9d26c5b33' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:24.071039) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:24.071749) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 12:46:24.087325) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-07 12:46:24.088049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:46:24 INFO - MultiFileLogger online at 20160407 12:46:24 in /builds/slave/test 12:46:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:46:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:46:24 INFO - {'append_to_log': False, 12:46:24 INFO - 'base_work_dir': '/builds/slave/test', 12:46:24 INFO - 'blob_upload_branch': 'Fx-Team', 12:46:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:46:24 INFO - 'branch': 'Fx-Team', 12:46:24 INFO - 'buildbot_json_path': 'buildprops.json', 12:46:24 INFO - 'config_files': ('talos/mac_config.py',), 12:46:24 INFO - 'default_actions': ('clobber', 12:46:24 INFO - 'read-buildbot-config', 12:46:24 INFO - 'download-and-extract', 12:46:24 INFO - 'populate-webroot', 12:46:24 INFO - 'create-virtualenv', 12:46:24 INFO - 'install', 12:46:24 INFO - 'run-tests'), 12:46:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:46:24 INFO - 'download_minidump_stackwalk': True, 12:46:24 INFO - 'download_symbols': 'ondemand', 12:46:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:46:24 INFO - 'tooltool.py': '/tools/tooltool.py', 12:46:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:46:24 INFO - '/tools/misc-python/virtualenv.py')}, 12:46:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:46:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:46:24 INFO - 'installer_path': 'installer.exe', 12:46:24 INFO - 'log_level': 'info', 12:46:24 INFO - 'log_name': 'talos', 12:46:24 INFO - 'log_to_console': True, 12:46:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:46:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:46:24 INFO - 'opt_config_files': (), 12:46:24 INFO - 'pip_index': False, 12:46:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:46:24 INFO - 'cmd': ('bash', 12:46:24 INFO - '-c', 12:46:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:46:24 INFO - 'enabled': True, 12:46:24 INFO - 'halt_on_failure': False, 12:46:24 INFO - 'name': 'check_screen_resolution'},), 12:46:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:46:24 INFO - 'cmd': ('bash', 12:46:24 INFO - '-c', 12:46:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:46:24 INFO - 'enabled': True, 12:46:24 INFO - 'halt_on_failure': False, 12:46:24 INFO - 'name': 'check_screen_resolution'},), 12:46:24 INFO - 'run_cmd_checks_enabled': True, 12:46:24 INFO - 'sps_profile': False, 12:46:24 INFO - 'sps_profile_interval': 0, 12:46:24 INFO - 'suite': 'dromaeojs', 12:46:24 INFO - 'system_bits': '32', 12:46:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:46:24 INFO - 'title': 't-yosemite-r7-0192', 12:46:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:46:24 INFO - 'use_talos_json': True, 12:46:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:46:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:46:24 INFO - 'work_dir': 'build'} 12:46:24 INFO - ##### 12:46:24 INFO - ##### Running clobber step. 12:46:24 INFO - ##### 12:46:24 INFO - Running pre-action listener: _resource_record_pre_action 12:46:24 INFO - Running main action method: clobber 12:46:24 INFO - rmtree: /builds/slave/test/build 12:46:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:46:25 INFO - Running post-action listener: _resource_record_post_action 12:46:25 INFO - ##### 12:46:25 INFO - ##### Running read-buildbot-config step. 12:46:25 INFO - ##### 12:46:25 INFO - Running pre-action listener: _resource_record_pre_action 12:46:25 INFO - Running main action method: read_buildbot_config 12:46:25 INFO - Using buildbot properties: 12:46:25 INFO - { 12:46:25 INFO - "project": "", 12:46:25 INFO - "product": "firefox", 12:46:25 INFO - "script_repo_revision": "production", 12:46:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:46:25 INFO - "repository": "", 12:46:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:46:25 INFO - "buildid": "20160407115853", 12:46:25 INFO - "pgo_build": "False", 12:46:25 INFO - "basedir": "/builds/slave/test", 12:46:25 INFO - "buildnumber": 638, 12:46:25 INFO - "slavename": "t-yosemite-r7-0192", 12:46:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:46:25 INFO - "platform": "yosemite_r7", 12:46:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:46:25 INFO - "branch": "fx-team", 12:46:25 INFO - "repo_path": "integration/fx-team", 12:46:25 INFO - "revision": "0559e1ea4660abf46d6ad114bb6518e9d26c5b33", 12:46:25 INFO - "stage_platform": "macosx64", 12:46:25 INFO - "builduid": "61865a9ba917442790027f8857189b7d", 12:46:25 INFO - "slavebuilddir": "test" 12:46:25 INFO - } 12:46:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 12:46:25 INFO - Running post-action listener: _resource_record_post_action 12:46:25 INFO - ##### 12:46:25 INFO - ##### Running download-and-extract step. 12:46:25 INFO - ##### 12:46:25 INFO - Running pre-action listener: _resource_record_pre_action 12:46:25 INFO - Running main action method: download_and_extract 12:46:25 INFO - mkdir: /builds/slave/test/build/tests 12:46:25 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')]} 12:46:25 INFO - https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:46:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:46:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:46:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:27 INFO - Downloaded 1199 bytes. 12:46:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:46:27 INFO - Using the following test package requirements: 12:46:27 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:46:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 12:46:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 12:46:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'jsshell-mac.zip'], 12:46:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 12:46:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:46:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 12:46:27 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 12:46:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 12:46:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:46:27 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 12:46:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:46:27 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')]} 12:46:27 INFO - https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:28 INFO - Downloaded 17971747 bytes. 12:46:28 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'] 12:46:28 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 12:46:31 INFO - Return code: 0 12:46:31 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 12:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:31 INFO - https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:33 INFO - Downloaded 17971747 bytes. 12:46:33 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'] 12:46:33 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 12:46:36 INFO - Return code: 0 12:46:36 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')]} 12:46:36 INFO - https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:38 INFO - Downloaded 10847693 bytes. 12:46:38 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'] 12:46:38 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 12:46:38 INFO - Return code: 0 12:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:38 INFO - https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 12:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FHolCg0VQZuCecp5j7Og6g/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 12:46:44 INFO - Downloaded 108876645 bytes. 12:46:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:46:44 INFO - mkdir: /builds/slave/test/properties 12:46:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:46:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:46:44 INFO - Contents: 12:46:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:46:45 INFO - Running post-action listener: _resource_record_post_action 12:46:45 INFO - Running post-action listener: set_extra_try_arguments 12:46:45 INFO - ##### 12:46:45 INFO - ##### Running populate-webroot step. 12:46:45 INFO - ##### 12:46:45 INFO - Running pre-action listener: _resource_record_pre_action 12:46:45 INFO - Running main action method: populate_webroot 12:46:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:46:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:46:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:46:45 INFO - '--tppagecycles', 12:46:45 INFO - '7'], 12:46:45 INFO - 'tests': ['tsvgm']}}, 12:46:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:46:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:46:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:46:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:46:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:46:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:46:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['damp', 'tps']}, 12:46:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'tests': ['damp', 'tps']}, 12:46:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['dromaeo_dom']}, 12:46:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:46:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['a11yr', 12:46:45 INFO - 'ts_paint', 12:46:45 INFO - 'tpaint', 12:46:45 INFO - 'sessionrestore', 12:46:45 INFO - 'sessionrestore_no_auto_restore', 12:46:45 INFO - 'tabpaint']}, 12:46:45 INFO - 'other-e10s': {'tests': ['a11yr', 12:46:45 INFO - 'ts_paint', 12:46:45 INFO - 'tpaint', 12:46:45 INFO - 'sessionrestore', 12:46:45 INFO - 'sessionrestore_no_auto_restore', 12:46:45 INFO - 'tabpaint']}, 12:46:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:46:45 INFO - 'ts_paint', 12:46:45 INFO - 'tpaint', 12:46:45 INFO - 'sessionrestore', 12:46:45 INFO - 'sessionrestore_no_auto_restore', 12:46:45 INFO - 'tabpaint']}, 12:46:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:46:45 INFO - 'ts_paint', 12:46:45 INFO - 'tpaint', 12:46:45 INFO - 'sessionrestore', 12:46:45 INFO - 'sessionrestore_no_auto_restore', 12:46:45 INFO - 'tabpaint']}, 12:46:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['a11yr', 12:46:45 INFO - 'ts_paint', 12:46:45 INFO - 'tpaint', 12:46:45 INFO - 'sessionrestore', 12:46:45 INFO - 'sessionrestore_no_auto_restore', 12:46:45 INFO - 'tabpaint']}, 12:46:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['a11yr', 12:46:45 INFO - 'ts_paint', 12:46:45 INFO - 'tpaint', 12:46:45 INFO - 'sessionrestore', 12:46:45 INFO - 'sessionrestore_no_auto_restore', 12:46:45 INFO - 'tabpaint']}, 12:46:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['tsvgx', 12:46:45 INFO - 'tsvgr_opacity', 12:46:45 INFO - 'tart', 12:46:45 INFO - 'tscrollx', 12:46:45 INFO - 'cart']}, 12:46:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:46:45 INFO - 'tsvgr_opacity', 12:46:45 INFO - 'tart', 12:46:45 INFO - 'tscrollx', 12:46:45 INFO - 'cart']}, 12:46:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'talos_options': ['--disable-e10s'], 12:46:45 INFO - 'tests': ['tp5o']}, 12:46:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'tests': ['tp5o']}, 12:46:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'talos_options': ['--disable-e10s', 12:46:45 INFO - '--xperf_path', 12:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:46:45 INFO - 'tests': ['tp5n']}, 12:46:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:45 INFO - 'talos_options': ['--xperf_path', 12:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:46:45 INFO - 'tests': ['tp5n']}}, 12:46:45 INFO - 'talos.zip': {'path': '', 12:46:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:46:45 INFO - Running post-action listener: _resource_record_post_action 12:46:45 INFO - ##### 12:46:45 INFO - ##### Running create-virtualenv step. 12:46:45 INFO - ##### 12:46:45 INFO - Running pre-action listener: _resource_record_pre_action 12:46:45 INFO - Running main action method: create_virtualenv 12:46:45 INFO - Creating virtualenv /builds/slave/test/build/venv 12:46:45 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 12:46:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:46:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:46:45 INFO - Using real prefix '/tools/python27' 12:46:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 12:46:49 INFO - Installing pip.................done. 12:46:49 INFO - Return code: 0 12:46:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:46:49 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')]} 12:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:49 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')]} 12:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:49 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:46:49 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 12:46:49 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 12:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:46:49 INFO - 'HOME': '/Users/cltbld', 12:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:46:49 INFO - 'LOGNAME': 'cltbld', 12:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:49 INFO - 'MOZ_NO_REMOTE': '1', 12:46:49 INFO - 'NO_EM_RESTART': '1', 12:46:49 INFO - 'PAGER': '/bin/cat', 12:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:49 INFO - 'PWD': '/builds/slave/test', 12:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:46:49 INFO - 'SHELL': '/bin/bash', 12:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:46:49 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:46:49 INFO - 'USER': 'cltbld', 12:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:49 INFO - 'XPC_FLAGS': '0x0', 12:46:49 INFO - 'XPC_SERVICE_NAME': '0', 12:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:49 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 12:46:49 INFO - Cleaning up... 12:46:49 INFO - Return code: 0 12:46:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:46:49 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')]} 12:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:49 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')]} 12:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:49 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:46:49 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 12:46:49 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 12:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:46:49 INFO - 'HOME': '/Users/cltbld', 12:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:46:49 INFO - 'LOGNAME': 'cltbld', 12:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:49 INFO - 'MOZ_NO_REMOTE': '1', 12:46:49 INFO - 'NO_EM_RESTART': '1', 12:46:49 INFO - 'PAGER': '/bin/cat', 12:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:49 INFO - 'PWD': '/builds/slave/test', 12:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:46:49 INFO - 'SHELL': '/bin/bash', 12:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:46:49 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:46:49 INFO - 'USER': 'cltbld', 12:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:49 INFO - 'XPC_FLAGS': '0x0', 12:46:49 INFO - 'XPC_SERVICE_NAME': '0', 12:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:49 INFO - Downloading/unpacking psutil>=0.7.1 12:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:46:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:46:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:46:52 INFO - Installing collected packages: psutil 12:46:52 INFO - Running setup.py install for psutil 12:46:52 INFO - building 'psutil._psutil_osx' extension 12:46:52 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 12:46:52 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 12:46:52 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 12:46:52 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 12:46:52 INFO - building 'psutil._psutil_posix' extension 12:46:52 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 12:46:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:46:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:46:52 INFO - ^ 12:46:52 INFO - 1 warning generated. 12:46:52 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 12:46:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:46:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:46:53 INFO - Successfully installed psutil 12:46:53 INFO - Cleaning up... 12:46:53 INFO - Return code: 0 12:46:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:53 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:46:53 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 12:46:53 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 12:46:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:46:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:46:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:46:53 INFO - 'HOME': '/Users/cltbld', 12:46:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:46:53 INFO - 'LOGNAME': 'cltbld', 12:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:53 INFO - 'MOZ_NO_REMOTE': '1', 12:46:53 INFO - 'NO_EM_RESTART': '1', 12:46:53 INFO - 'PAGER': '/bin/cat', 12:46:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:53 INFO - 'PWD': '/builds/slave/test', 12:46:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:46:53 INFO - 'SHELL': '/bin/bash', 12:46:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:46:53 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:46:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:46:53 INFO - 'USER': 'cltbld', 12:46:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:46:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:53 INFO - 'XPC_FLAGS': '0x0', 12:46:53 INFO - 'XPC_SERVICE_NAME': '0', 12:46:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:46:55 INFO - Installing collected packages: mozsystemmonitor 12:46:55 INFO - Running setup.py install for mozsystemmonitor 12:46:55 INFO - Successfully installed mozsystemmonitor 12:46:55 INFO - Cleaning up... 12:46:56 INFO - Return code: 0 12:46:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:46: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')]} 12:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46: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')]} 12:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46: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', '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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:46: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 blobuploader==1.2.4 12:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:46:56 INFO - 'HOME': '/Users/cltbld', 12:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:46:56 INFO - 'LOGNAME': 'cltbld', 12:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:56 INFO - 'MOZ_NO_REMOTE': '1', 12:46:56 INFO - 'NO_EM_RESTART': '1', 12:46:56 INFO - 'PAGER': '/bin/cat', 12:46:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:56 INFO - 'PWD': '/builds/slave/test', 12:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:46:56 INFO - 'SHELL': '/bin/bash', 12:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:46:56 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:46:56 INFO - 'USER': 'cltbld', 12:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:56 INFO - 'XPC_FLAGS': '0x0', 12:46:56 INFO - 'XPC_SERVICE_NAME': '0', 12:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46:58 INFO - Downloading blobuploader-1.2.4.tar.gz 12:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:46:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:46:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46:59 INFO - Downloading docopt-0.6.1.tar.gz 12:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:46:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:46:59 INFO - Running setup.py install for blobuploader 12:47:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:47:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:47:00 INFO - Running setup.py install for requests 12:47:00 INFO - Running setup.py install for docopt 12:47:00 INFO - Successfully installed blobuploader requests docopt 12:47:00 INFO - Cleaning up... 12:47:00 INFO - Return code: 0 12:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:00 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:00 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 12:47:00 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 12:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:00 INFO - 'HOME': '/Users/cltbld', 12:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:00 INFO - 'LOGNAME': 'cltbld', 12:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:00 INFO - 'MOZ_NO_REMOTE': '1', 12:47:00 INFO - 'NO_EM_RESTART': '1', 12:47:00 INFO - 'PAGER': '/bin/cat', 12:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:00 INFO - 'PWD': '/builds/slave/test', 12:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:00 INFO - 'SHELL': '/bin/bash', 12:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:47:00 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:00 INFO - 'USER': 'cltbld', 12:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:00 INFO - 'XPC_FLAGS': '0x0', 12:47:00 INFO - 'XPC_SERVICE_NAME': '0', 12:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-DSGgnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-f7et45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Jj7lBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-WcsgZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1hvqtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3TZPSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-gUIsFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-8PsvAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-fX_GuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-aKif3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-D2GYDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-5s7YgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zD2E0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-dF1cLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-5buGnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-kGgN2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-lndxOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:47:02 INFO - Running setup.py install for manifestparser 12:47:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:47:02 INFO - Running setup.py install for mozcrash 12:47:03 INFO - Running setup.py install for mozdebug 12:47:03 INFO - Running setup.py install for mozdevice 12:47:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Running setup.py install for mozfile 12:47:03 INFO - Running setup.py install for mozhttpd 12:47:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Running setup.py install for mozinfo 12:47:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Running setup.py install for mozInstall 12:47:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:47:03 INFO - Running setup.py install for mozleak 12:47:04 INFO - Running setup.py install for mozlog 12:47:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:47:04 INFO - Running setup.py install for moznetwork 12:47:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:47:04 INFO - Running setup.py install for mozprocess 12:47:04 INFO - Running setup.py install for mozprofile 12:47:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:47:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:47:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:47:04 INFO - Running setup.py install for mozrunner 12:47:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:47:04 INFO - Running setup.py install for mozscreenshot 12:47:05 INFO - Running setup.py install for moztest 12:47:05 INFO - Running setup.py install for mozversion 12:47:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:47:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:47:05 INFO - Cleaning up... 12:47:05 INFO - Return code: 0 12:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:05 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:05 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 12:47:05 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 12:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:05 INFO - 'HOME': '/Users/cltbld', 12:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:05 INFO - 'LOGNAME': 'cltbld', 12:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:05 INFO - 'MOZ_NO_REMOTE': '1', 12:47:05 INFO - 'NO_EM_RESTART': '1', 12:47:05 INFO - 'PAGER': '/bin/cat', 12:47:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:05 INFO - 'PWD': '/builds/slave/test', 12:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:05 INFO - 'SHELL': '/bin/bash', 12:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:47:05 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:05 INFO - 'USER': 'cltbld', 12:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:05 INFO - 'XPC_FLAGS': '0x0', 12:47:05 INFO - 'XPC_SERVICE_NAME': '0', 12:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zk6nqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:06 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)) 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-S1R9tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:06 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)) 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-KZQ2FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:06 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)) 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9_Fquk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:06 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)) 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1Ryed8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:06 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)) 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-2bsKXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:06 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)) 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-OXSKhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:06 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)) 12:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-UpQSzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-6VvUbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-fC66nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xoGS0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-KHahDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-AyrAyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-y7uiTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-N6Qz4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Mdn2Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:07 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)) 12:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-kp0gsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:08 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)) 12:47:08 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)) 12:47:08 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)) 12:47:08 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)) 12:47:08 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)) 12:47:08 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)) 12:47:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:10 INFO - Downloading blessings-1.6.tar.gz 12:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:47:10 INFO - Installing collected packages: blessings 12:47:10 INFO - Running setup.py install for blessings 12:47:10 INFO - Successfully installed blessings 12:47:10 INFO - Cleaning up... 12:47:11 INFO - Return code: 0 12:47:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:11 INFO - Reading from file tmpfile_stdout 12:47:11 INFO - Current package versions: 12:47:11 INFO - blessings == 1.6 12:47:11 INFO - blobuploader == 1.2.4 12:47:11 INFO - docopt == 0.6.1 12:47:11 INFO - manifestparser == 1.1 12:47:11 INFO - mozInstall == 1.12 12:47:11 INFO - mozcrash == 0.17 12:47:11 INFO - mozdebug == 0.1 12:47:11 INFO - mozdevice == 0.48 12:47:11 INFO - mozfile == 1.2 12:47:11 INFO - mozhttpd == 0.7 12:47:11 INFO - mozinfo == 0.9 12:47:11 INFO - mozleak == 0.1 12:47:11 INFO - mozlog == 3.1 12:47:11 INFO - moznetwork == 0.27 12:47:11 INFO - mozprocess == 0.22 12:47:11 INFO - mozprofile == 0.28 12:47:11 INFO - mozrunner == 6.11 12:47:11 INFO - mozscreenshot == 0.1 12:47:11 INFO - mozsystemmonitor == 0.0 12:47:11 INFO - moztest == 0.7 12:47:11 INFO - mozversion == 1.4 12:47:11 INFO - psutil == 3.1.1 12:47:11 INFO - requests == 1.2.3 12:47:11 INFO - wsgiref == 0.1.2 12:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:11 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')]} 12:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:11 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')]} 12:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:11 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:11 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 12:47:11 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 12:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:11 INFO - 'HOME': '/Users/cltbld', 12:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:11 INFO - 'LOGNAME': 'cltbld', 12:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:11 INFO - 'MOZ_NO_REMOTE': '1', 12:47:11 INFO - 'NO_EM_RESTART': '1', 12:47:11 INFO - 'PAGER': '/bin/cat', 12:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:11 INFO - 'PWD': '/builds/slave/test', 12:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:11 INFO - 'SHELL': '/bin/bash', 12:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:47:11 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:11 INFO - 'USER': 'cltbld', 12:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:11 INFO - 'XPC_FLAGS': '0x0', 12:47:11 INFO - 'XPC_SERVICE_NAME': '0', 12:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 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)) 12:47:11 INFO - Cleaning up... 12:47:11 INFO - Return code: 0 12:47:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:47:11 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')]} 12:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:11 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')]} 12:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:11 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:11 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 12:47:11 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 12:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:11 INFO - 'HOME': '/Users/cltbld', 12:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:11 INFO - 'LOGNAME': 'cltbld', 12:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:11 INFO - 'MOZ_NO_REMOTE': '1', 12:47:11 INFO - 'NO_EM_RESTART': '1', 12:47:11 INFO - 'PAGER': '/bin/cat', 12:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:11 INFO - 'PWD': '/builds/slave/test', 12:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:11 INFO - 'SHELL': '/bin/bash', 12:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:47:11 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:11 INFO - 'USER': 'cltbld', 12:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:11 INFO - 'XPC_FLAGS': '0x0', 12:47:11 INFO - 'XPC_SERVICE_NAME': '0', 12:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:11 INFO - Downloading/unpacking jsonschema 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:47:14 INFO - Downloading/unpacking functools32 (from jsonschema) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:14 INFO - Downloading functools32-3.2.3-2.tar.gz 12:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:47:14 INFO - warning: no files found matching '*.txt' 12:47:14 INFO - no previously-included directories found matching 'build' 12:47:14 INFO - no previously-included directories found matching 'dist' 12:47:14 INFO - no previously-included directories found matching '.git*' 12:47:14 INFO - Installing collected packages: jsonschema, functools32 12:47:14 INFO - Running setup.py install for functools32 12:47:14 INFO - warning: no files found matching '*.txt' 12:47:14 INFO - no previously-included directories found matching 'build' 12:47:14 INFO - no previously-included directories found matching 'dist' 12:47:14 INFO - no previously-included directories found matching '.git*' 12:47:14 INFO - Successfully installed jsonschema functools32 12:47:14 INFO - Cleaning up... 12:47:15 INFO - Return code: 0 12:47:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:47:15 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')]} 12:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:15 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')]} 12:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:15 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 0x10d9b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf535ac010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, '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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:15 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 12:47:15 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 12:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:15 INFO - 'HOME': '/Users/cltbld', 12:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:15 INFO - 'LOGNAME': 'cltbld', 12:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:15 INFO - 'MOZ_NO_REMOTE': '1', 12:47:15 INFO - 'NO_EM_RESTART': '1', 12:47:15 INFO - 'PAGER': '/bin/cat', 12:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:15 INFO - 'PWD': '/builds/slave/test', 12:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:15 INFO - 'SHELL': '/bin/bash', 12:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:47:15 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:15 INFO - 'USER': 'cltbld', 12:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:15 INFO - 'XPC_FLAGS': '0x0', 12:47:15 INFO - 'XPC_SERVICE_NAME': '0', 12:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:15 INFO - Downloading/unpacking flake8 12:47:15 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 12:47:15 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 12:47:15 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 12:47:15 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 12:47:15 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 12:47:15 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 12:47:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:47:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:47:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:47:18 INFO - no previously-included directories found matching 'docs/_build' 12:47:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:47:19 INFO - Running setup.py install for pep8 12:47:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:47:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:47:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:47:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:47:19 INFO - no previously-included directories found matching 'docs/_build' 12:47:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:47:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:47:19 INFO - Cleaning up... 12:47:19 INFO - Return code: 0 12:47:19 INFO - Running post-action listener: _resource_record_post_action 12:47:19 INFO - Running post-action listener: _start_resource_monitoring 12:47:19 INFO - Starting resource monitoring. 12:47:19 INFO - ##### 12:47:19 INFO - ##### Running install step. 12:47:19 INFO - ##### 12:47:19 INFO - Running pre-action listener: _resource_record_pre_action 12:47:19 INFO - Running main action method: install 12:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:19 INFO - Reading from file tmpfile_stdout 12:47:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:47:19 INFO - Reading from file tmpfile_stdout 12:47:19 INFO - Output received: 12:47:19 INFO - Usage: mozinstall [options] installer 12:47:19 INFO - Options: 12:47:19 INFO - -h, --help show this help message and exit 12:47:19 INFO - -d DEST, --destination=DEST 12:47:19 INFO - Directory to install application into. [default: 12:47:19 INFO - "/builds/slave/test"] 12:47:19 INFO - --app=APP Application being installed. [default: firefox] 12:47:19 INFO - mkdir: /builds/slave/test/build/application 12:47:19 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'] 12:47:19 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 12:47:53 INFO - Reading from file tmpfile_stdout 12:47:53 INFO - Output received: 12:47:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:47:53 INFO - Running post-action listener: _resource_record_post_action 12:47:53 INFO - ##### 12:47:53 INFO - ##### Running run-tests step. 12:47:53 INFO - ##### 12:47:53 INFO - Running pre-action listener: _resource_record_pre_action 12:47:53 INFO - Running main action method: run_tests 12:47:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:47:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:47:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:47:53 INFO - 2016-04-07 12:47:53.025 screenresolution[2265:22848] starting screenresolution argv=screenresolution get 12:47:53 INFO - 2016-04-07 12:47:53.028 screenresolution[2265:22848] Display 0: 1600x1200x32@60 12:47:53 INFO - 2016-04-07 12:47:53.034 screenresolution[2266:22850] starting screenresolution argv=screenresolution list 12:47:53 INFO - Available Modes on Display 0 12:47:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:47:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:47:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:47:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:47:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:47:53 INFO - Intel Iris: 12:47:53 INFO - Chipset Model: Intel Iris 12:47:53 INFO - Type: GPU 12:47:53 INFO - Bus: Built-In 12:47:53 INFO - VRAM (Dynamic, Max): 1536 MB 12:47:53 INFO - Vendor: Intel (0x8086) 12:47:53 INFO - Device ID: 0x0a2e 12:47:53 INFO - Revision ID: 0x0009 12:47:53 INFO - Displays: 12:47:53 INFO - Display: 12:47:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:47:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:47:53 INFO - Display Serial Number: 1600x1200 60 12:47:53 INFO - Main Display: Yes 12:47:53 INFO - Mirror: Off 12:47:53 INFO - Online: Yes 12:47:53 INFO - Rotation: Supported 12:47:53 INFO - Return code: 0 12:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:47:53 INFO - Python 2.7.3 12:47:53 INFO - Return code: 0 12:47:53 INFO - grabbing minidump binary from tooltool 12:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:53 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 0x10d854e00>, '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 0x10d67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d84fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:47:53 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 12:47:53 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 12:47:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:47:53 INFO - Return code: 0 12:47:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:47:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:47:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:47:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:47:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:47:54 INFO - Return code: 0 12:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Xl1q8R9LVm/Render', 12:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:54 INFO - 'HOME': '/Users/cltbld', 12:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:54 INFO - 'LOGNAME': 'cltbld', 12:47:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:47:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:54 INFO - 'MOZ_NO_REMOTE': '1', 12:47:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:47:54 INFO - 'NO_EM_RESTART': '1', 12:47:54 INFO - 'PAGER': '/bin/cat', 12:47:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:54 INFO - 'PWD': '/builds/slave/test', 12:47:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:54 INFO - 'SHELL': '/bin/bash', 12:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCzI3dQ9jZ/Listeners', 12:47:54 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:54 INFO - 'USER': 'cltbld', 12:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:54 INFO - 'XPC_FLAGS': '0x0', 12:47:54 INFO - 'XPC_SERVICE_NAME': '0', 12:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:47:54 INFO - mozversion application_buildid: 20160407115853 12:47:54 INFO - mozversion application_changeset: 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 12:47:54 INFO - mozversion application_display_name: Nightly 12:47:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:47:54 INFO - mozversion application_name: Firefox 12:47:54 INFO - mozversion application_remotingname: firefox 12:47:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:47:54 INFO - mozversion application_vendor: Mozilla 12:47:54 INFO - mozversion application_version: 48.0a1 12:47:54 INFO - mozversion platform_buildid: 20160407115853 12:47:54 INFO - mozversion platform_changeset: 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 12:47:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:47:54 INFO - mozversion platform_version: 48.0a1 12:47:54 INFO - using testdate: 1460058474 12:47:54 INFO - actual date: 1460058474 12:47:54 INFO - starting webserver on 'localhost:53460' 12:47:54 INFO - SUITE-START | Running 2 tests 12:47:54 INFO - TEST-START | dromaeo_css 12:47:54 INFO - operating with platform_type : mac_ 12:47:54 INFO - Initialising browser for dromaeo_css test... 12:47:54 INFO - TEST-INFO | started process 2284 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpS3apgb/profile http://localhost:53460/getInfo.html) 12:47:57 INFO - PROCESS | 2284 | __metrics Screen width/height:1600/1200 12:47:57 INFO - PROCESS | 2284 | colorDepth:24 12:47:57 INFO - PROCESS | 2284 | Browser inner width/height: 1024/689 12:47:57 INFO - PROCESS | 2284 | __metrics 12:47:57 INFO - PROCESS | 2284 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:47:57 ERROR - PROCESS | 2284 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:47:57 INFO - TEST-INFO | 2284: exit 0 12:47:57 INFO - Browser initialized. 12:47:57 INFO - Running cycle 1/1 for dromaeo_css test... 12:47:57 INFO - TEST-INFO | started process 2286 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpS3apgb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:09 INFO - PROCESS | 2286 | RSS: Main: 236503040 12:48:09 INFO - PROCESS | 2286 | 12:49:00 INFO - PROCESS | 2286 | 1460058540758 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] 12:51:11 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53460/tests/dromaeo/cssquery-ext.html) 12:51:12 INFO - PROCESS | 2286 | RSS: Main: 379564032 12:51:12 INFO - PROCESS | 2286 | 12:54:15 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-ext.html (next: http://localhost:53460/tests/dromaeo/cssquery-jquery.html) 12:54:15 INFO - PROCESS | 2286 | RSS: Main: 374456320 12:54:15 INFO - PROCESS | 2286 | 12:57:17 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53460/tests/dromaeo/cssquery-mootools.html) 12:57:18 INFO - PROCESS | 2286 | RSS: Main: 366792704 12:57:18 INFO - PROCESS | 2286 | 13:00:20 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53460/tests/dromaeo/cssquery-prototype.html) 13:00:21 INFO - PROCESS | 2286 | RSS: Main: 331485184 13:00:21 INFO - PROCESS | 2286 | 13:03:24 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53460/tests/dromaeo/cssquery-yui.html) 13:03:25 INFO - PROCESS | 2286 | RSS: Main: 328474624 13:03:25 INFO - PROCESS | 2286 | 13:06:27 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-yui.html (next: http://localhost:53460/tests/dromaeo/cssquery-dojo.html) 13:06:28 INFO - PROCESS | 2286 | RSS: Main: 375406592 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | __start_tp_report 13:06:28 INFO - PROCESS | 2286 | _x_x_mozilla_page_load 13:06:28 INFO - PROCESS | 2286 | _x_x_mozilla_page_load_details 13:06:28 INFO - PROCESS | 2286 | |i|pagename|runs| 13:06:28 INFO - PROCESS | 2286 | |0;dojo.html;3090.737287330577;3348.430766769649;3376.7805092668973;3392.9491057634154;3431.8970430887084;5560.999020176367;5620.550355971523;5621.40975197604;5638.887222255553;5644.266245388099;5569.610127291091;5633.887322253552;5634.014047541685;5638.971805140968;5646.435356464352;5069.214271787879;5073.670211436263;5101.489851014906;5106.744662766865;5169.121249387613;5159.845204643867;5166.793328266865;5175.844724658266;5177.32694749682;5182.170852663575;5094.77073531692;5130;5137.614678899079;5140.742962851861;5159.122949098643;5132.230165475171;5174.120399532051;5179.974100129513;5181.533661970403;5227.764750586232;4848.22428411456;4945.357103576548;5002.2246551784165;5103.540681338697;5120.1039818031695;5488.615796894219;5514.255575497296;5518.530924871391;5540.9168862467095;5622.240997465331;6179.289381721114;6208.161898143738;6215.68921553925;6232.532560057968;6237.625742455467;6079.969600152015;6090.23872015998;6233.750649973996;6238.344973777734;6293.559450838443;5731.140328950649;5739.827805165852;5745.88508229833;5751.4536119068625;5770.961226979142;6280.120783090371;6316.399942005502;6342.429181373698;6354.4281014708895;6364.268109167505;5859.1797148399255;5977.103434484775;5984.102384642251;5985.461308482258;6040.637561746309;6116.785912493041;6117.431594453911;6212.4408803207925;6246.937530624727;6247.5939063960695;6140.600860944024;6151.815445536641;6159.692015399301;6165.969170154121;6172.197614310111;6022.337542870281;6109.877802443926;6221.595596286317;6221.9377806221355;6233.189685340967;4913.680610760361;4924.0890435268875;4925.901481970341;4930.556249937523;4935.3090567320605;4433;4437.090396468716;4453.19842428366;4480.619147372445;4486.910261794746;4702.576768090888;5564.221009058735;5611.382747897728;5668.489835914705;5682.289713785777;6156.846078848064;6238.376162383725;6244.344343843922;6246.094316324107;6260.405261500241;5502.724863756796;5566.053770858964;5579.497845193952;5580.748866301026;5582.525485333711;5286.3392075990505;5326.946730532645;5327.174287985368;5327.493888080626;5331.360236771535;6254.6872656366995;6269.12232287471;6311.305756366796;6327.683615819283;6338.176037115146;6219.533534984985;6236.095766113797;6254.6247225166635;6277.3408792078;6279.340669229848;6214.316425193316;6301.558890877778;6308.558400912076;6328.873422531616;6331.27190373113;6078.331383547895;6136.6429834816;6138.051223665275;6139.693015349126;6150.323464419;5837.912431313449;6014.338422773404;6015.669138197266;6020.157177994996;6085.6348619083;5500;5758.942410576008;5778.8266352009505;5835.183074369676;5965.701714914324;5913.201717768218;5929.733162007634;6002.429769171922;6011.60924539921;6086.72609732572;5807.332156802022;5819.970900145472;5824.767009319579;5848.239728835224;5849.210356601804;5847.590668653153;5954.225950626565;5967.76128954837;5972.313183983897;5988.131720900532;5892.7642894283745;5893.941060589339;5896.734646940812;5909.143174239625;5921.99326114553 13:06:28 INFO - PROCESS | 2286 | |1;ext.html;487.9878003049921;567.651748120579;573.5698226330252;617.3301967365406;631.8167731357905;30292.84853575732;30709.53935690961;30715.23211919703;30737.846310768444;30780.53829192564;31703.365932681332;39773;39797.20405591886;39889.20221595574;39974.80138592376;9327.486988215662;9514.904850951505;9525;9538.236941044699;9543.618255269816;9503.192228660537;9654.613815447374;9657.613695452173;9659.227261819038;9662.613495460173;9602.903970960271;9697.030296970317;9698.612055517771;9699.9815019423;9782.804343913152;9658.4687842169;9762;9767.267454940873;9771.609135634566;9782.168515676176;9583.664571739955;9720.465374404404;9720.659776907845;9728.562214700356;9760;39433.40849887254;39701.40447893284;39752.20495590072;39780.403293950614;39836.60163398358;3333.4833100869405;3463.757536972413;3554.449060395643;3604.387254166798;4055.0470639400014;28104.711418190578;28845.711542884514;28914.27714307138;29174;29880.954166604282;2724.8910043598235;2736.822106563067;2791.609174715521;2851.5580085086845;2858.5426331786816;465608.9999999966;472025;472092;472409;472431;45860.770696146305;46805.82985425392;65298;65783;65824;47133.293000605016;47166.5283347169;47374;47389.052218956116;47394.76302618465;14891.255437228096;15681.529554113395;15865.762013569805;15870.682586348208;15906.12516311614;12728.872711272768;12757.808632870514;12780.169288996185;12783.424745886457;12783.808242876365;12996.870031299755;14762;14783.926080369529;14809.259537023107;14817.259137043106;6345.143405640272;6415.166028416369;6426.678666066678;6468.8059358219325;6493.642849643221;854.7692123126845;976.1734002709396;1002.6240159940022;1006.9647562335283;1032.9225308101772;27014.087744811437;27090.1872943812;27318.863405682845;27717.58423623647;27743.861280693873;872.842888280103;945.1210374351919;953.7791626717813;954.1984732824461;1006.9496525173712;13793.724125517634;14024.158550487004;14168.858311416754;14183.64540886486;14258.928705356615;510992;757215;770266;771667;773048;57509;57700.422995769506;58436.53908652232;58438.12342814861;58590;1332.4736728991993;1362.9659258518418;1447.5657302809116;1462.3200211901303;1486.717523670499;25640;30119;30278.54582181313;30990.845045774626;31047.379052419277;52654;53208.20187697265;53244.73377633087;53305;53398;405019;419237;420485;420709;421192;27973.720262797113;31961.840190798895;32133;32767;32810.50784238286;39563.2087358257;40643.390349144196;40877.79561102176;41092.794536027126;42509.36235956525;28245.858770706014;33766.831165844014;35455.34084943588;35685.28629427449;36614.26771464609;35123.82438087793;35267.29465410729;35300.47049294211;36134.457983129745;36241.63758362383;34785.65214347824;35347.29305413826;35497.82251088728;35720.928372148875;35864.462033069;30814.229644259074;31347.68652313448;31374.68625313809;31463.84268078645;31478.370432591677;23301.76698232996;23478.178263760685;23925.760742392355;23962.640560391956;24100.15649452261 13:06:28 INFO - PROCESS | 2286 | |2;jquery.html;350.94735789631557;356.7752316040894;357.83539571796973;370.5923484167418;372.19605651792136;19109.99999999998;19240.3265885694;20730.27444039459;20769.27307544236;20831.27090551831;19650.919199444026;20406.285779997703;20984.475388115305;21124.471888202763;21207.787922120773;5602.187682785993;5734;5791.131330300446;5806.419358064202;5815.47660710536;4201.789910504478;4304.418903448026;5810.709464526778;6113.296970848365;6416.711247993828;5409.648372855771;6322;6339.936600634004;6345.238571371442;6347.936520634804;5494.1758736189895;6143.539234557426;6151.569390142692;6208.410201030895;6338.492920566367;3697.1126929536717;5237.13587258102;5456.045192091368;5475.0418676731415;5490.149026900836;19009.334673286507;23645.817709114646;24246.030158793805;24866.254012379657;24866.37834054145;2105.8315334773183;2138.454694053022;2194.6208906818197;2400.627902675088;2692.394211302461;13828.085410808497;14277.857221427757;14610.19643919584;14702.63243418923;14936.551903442914;1401.5935378740153;1747.2050217151166;1767.4344209852852;1769.7345398190246;1787.7497150398954;95142.52428737812;95685;95757.52121239419;98700.0129998698;100403;8662.566871656392;10326.586936522604;10465.9476702616;10693.251472396858;10694.625688101034;13009.739805203842;13125;13125.868741312655;13127.934360328138;13137.014723895554;6988.266232045664;8385.83228335442;8535.573221338907;8556.144385561394;8663.133686631287;8760.91239087601;8777.253933415732;8798.164174403422;8878.73363799087;8922.821543569093;6123.938760612336;6128.969355153285;6136.110264011782;6136.509079273647;6167.753289868445;1659.9585010374838;1737.8870373425939;1745.3891138101817;1762.2774662388358;1839.3194518028415;835.644850938361;842.473454091193;908.3060092926776;937.2829785214317;945.2013048973606;19060.809391905903;19357.90321048386;19742.70385944212;19975.60048799045;20069.792322844474;895.7984453497911;904.8914130304406;948.4262021477045;953.1421720451649;970.5632465390603;8679.234003546988;10337.06966373015;10907.18196135293;10913.781724365468;11076.169287303323;601102;610276;616626;623121;624484;99538.502307488;102469.48765256126;102698.45952310722;102746.48626756968;105461;953.423178976723;1023.3399457349967;1059.2532264753331;1080.2762149359949;1081.1242893256488;18028.819711802713;18402.539936501693;18451.16969736392;18457.90771046136;18600.534986625444;40792.98017549466;41490;42737.786311068245;43085.92285192895;44290.11419771651;50082.49917500924;55525.167122492385;55546.44453555575;55640.72179639076;55700.442995571146;7536.660850261642;7778.611069446618;7862.095858976291;7881.605919703878;8100.635471403683;12063.81904271419;12151;12414.379281036092;12507.93746031264;12513.687157821127;9883.11052005323;10055.39667619945;10217.74455638615;10464.162866970777;10978.505967231335;10078.546465409221;10181.389116652728;11011.61459348919;11040.742980820516;11280.32318060886;10769.62306319275;10789.028987391173;11039.448027598748;11134.777304454028;11310.660680179608;7663.578503182379;7772.883406749016;7885.763427097197;7909.24862138096;8220.671173153007;6747.257801641717;9524.761880952754;10647.094996925038;10810.783784324427;10814.945925270324 13:06:28 INFO - PROCESS | 2286 | |3;mootools.html;1393.3799459240643;1513.1375116183776;1606.437746788624;1854.7588813454258;2002.9499262518445;8049.396295277856;8235.094139644634;8246.546439945801;8247.21651443112;8255.876161857577;8122.796930076751;8526.829463410728;8707.129287071306;8719.17167869053;8748.518831464267;2247.71903512061;2264.62633665445;2439.243834411334;2514.8994040238367;2519.5212909547126;2223.788740069691;2289.9084036638596;2455.4107014316614;2480.9255722328357;2518.2948774343213;2472.752724727522;2482.950340993179;2510.447701505666;2513.956707966201;2521.5839386501207;2485.565026120422;2524.5582023145876;2524.734902835194;2525.2929179829584;2526.305266051832;2441.2432146034607;2497.400623850281;2497.475530138673;2498;2503.198976327576;7242;7429.7771066867535;8842.292616590657;8858.689945851864;8863.290936725047;4755.239161734106;5431.972840135813;5599.944000559983;5652.773889044474;5674.460926212003;3480.756347055707;3514.314708631792;3683.557973043225;3684.244729830378;3685.9631403686158;1055.1927775251938;1060.3160961180072;1069.6149386221032;1071.4696225368414;1075.639660713662;11838.289702617785;11956.103292253116;12014.759704805942;12039.337836418994;12047.39763011846;4836.46798852126;4953.860612059247;5017.222330538772;5024.2463630454995;5039.21892106724;10290.279680422449;10360.689179324632;10371.27401081917;10374.481275936323;10413.739656508647;5575.275214222125;5578.191162281447;5596.58025648078;5611.9438805612235;5620.91568626471;4989.875253118701;5012.248162775612;5067.391912970467;5069.594432445396;5069.771860266297;3338.9499157512655;3788;3833.6549710526187;3862.8454861805776;3868.3810590305416;1090.3239991205503;1223.614561413152;1268.4651571598285;1304.3478260869565;1348.1035111650838;1320.2474589484093;1330.993345033288;1358.2936872826076;1358.7758019926798;1363.277462944641;7928.365730741527;8008.399370047153;8393.916060839436;8400.873986890201;8402.495850248883;1162.3258510064143;1168.655246702208;1176.4705882352976;1184.3545267829054;1202.5790973159324;6240.777968132634;6244.438000579969;6305.90541141874;6315.147455093595;6328.905066424008;10446.320989135682;10892.237543372046;10899.346039237671;11027;11046.392448415414;10610.89389106099;10706.250562460553;10747.623833165802;10777.353358798497;10852.728681783019;8286.544240066734;8417.663293468315;8459.915400846035;8477.491350518989;8512.574371281411;7804.297613214838;7830.882536761839;7851.4111441643245;7907.525548467111;7913.089994650689;9563.174730108012;9634.13292803651;9715.659951901649;9752.46361450127;9850.852237216592;9830.55762490704;10104.494775261355;10141.645042423479;10252.743681408025;10266.076053154953;7005.299470052954;7154.069970903749;7166.964165179141;7193.640317983975;7571.091469023752;7563.8109047272055;8224.136465671258;8243.422960392714;8290.212429819157;8308.501489910625;6284.4344009039405;7375.889361659687;7449.14334851499;7491;7590.962045189739;7202.567845929051;7251.56490610565;7333.816654583678;7373.852522949618;7412.851742965003;7527.661255243418;7655.0813902332075;7710;7718.151003389735;7725.381969442319;6917.446604271747;6981.232064472802;7030.753923612649;7037.542559733601;7039.577625342496;6627.255446411635;6859.622720750406;6863.931360686329;6897.137857767779;7093.893591596234 13:06:28 INFO - PROCESS | 2286 | |4;prototype.html;323.9627442844073;325.9625143108543;330.7916012911865;331.1010606204156;332.90345799718096;5249.553787928021;6448.419642232198;6530.902036469457;6533.934660653398;6564.442022428093;6383.872322553558;6442.387973142544;6444.130042444269;6457.9677101614425;6458.967705161479;4579.22153233951;4653.720776753389;4704.529547045286;4722.5513576210205;4794.592459640935;3996.1008773025983;4591.540845915399;4732.840454088753;4735.66850320476;4768.23708206687;4698.624110071186;4710.3405523226775;4710.458297295803;4714.245720684691;4731.763411829412;4495.775211239425;4595.402597662316;4606.746628935441;4606.976965115186;4721;3971.9007024824323;4000.719949603529;4075.1442197138635;4078.5928854545136;4112.321466957948;6167.722452489604;6169.426796166994;6171.074338849164;6183.752649893999;6203.472704820096;5591.720413979326;5602.943970560324;5607.130894711327;5608.49523542879;5611.410801865786;6836.350546698056;6852.931470685279;6861.725530978755;6866.382025617669;6872.244053154149;3782.394816829322;4290.742555446652;4499.775011249457;4502.662300327489;4508.346289787963;7217.8556428871125;7272.236415176383;7302.926970730277;7314.890276645855;7322.121345438528;4536.228841097021;4540.500544940054;4540.977295113504;4547.681662283675;4553.408056952641;3673.577538583097;4617.746023968714;4642.675012749075;4649.511801260886;4650.86047418578;4428.4685837699035;5489.34127904646;5490.176473529003;5490.176473529003;5491.121420572769;6593.406593406617;6847.74732002295;6852.109225800614;6940.327973730049;6954.65226738661;1580.1151355241102;1582.3907795498815;1596.1540383596712;1599.288316699081;1604.4224079331432;1008.5209525475341;1014.8832884218261;1031.9587216511256;1033.6743925663393;1035.8808736995343;5516.862078447991;6230.6573138476915;6397.072424498515;6406.647634380154;6420.293767685551;5772.3938986406665;7105.857882842314;7180.958760979629;7182.8204294892;7213.531120477152;5913.76344946206;5978.491828194565;6469.482441404676;6517.794208071522;6530.444912182423;3778.1876896467393;3826.6747326477002;3828.73198876076;3828.9042773930873;3842.731008829411;7213.639318034077;7540.886886696704;7549.358304544176;7558.395328373717;7563.508371955805;6695.363940425652;6950.339717726808;7388.74139405129;7412.814679633052;7488.101427828696;7536.208698086732;7552.093748750075;7554.357879580188;7556.962215188889;7559.130699969464;7215.494915355875;7238.348548630648;7238.963805180941;7255;7264.89102663471;6774.356436138559;7071.257517960746;7086.326798954091;7090.539114957512;7093.929060709327;5737.713114344183;7191.316824901626;7503.362214211853;7536.924630753622;7575.848483030419;4711.764411779466;4765.833195838268;4777.163996300564;4783.162946484421;4785.330053792542;6610.768623098168;7038.049863268598;7098.822529436806;7113.359797618239;7119.67961441726;6615.239247486408;6870.45036397097;6871;6874.6562671867205;6875.828104297232;6871.175458944758;6900.2409734928115;6910.136232970879;6941.757038503628;6966.198887127843;6770.018347339706;6771.3905748482875;6774.017767423795;6783.762568310085;6796.93203067963;6921.411680007054;6923.307669233036;6923.342282483156;6924.480663950325;6928.4803639726215;6505.479561634963;6739.59562426256;6786.287439818945;6789.388954994074;6796.388325050769 13:06:28 INFO - PROCESS | 2286 | |5;yui.html;732.439683642014;741.377243115783;745.191467258025;753.8341564855732;799.2846402469789;14753;14809.25953702316;15116;15124.395024199019;15127.319270632821;14059.367328470218;14169.362378692958;14190;14191.858081419208;14196.93522985775;747.6075060593205;756.4666909828558;903.0472851142059;910.2945217456459;932.6828878181417;788.8146285622875;930.585889279271;934.434667026446;934.5841100710187;938.5635679409073;988.5304480371838;991.7322322972793;994.9303548751591;995.3082607587729;996.2329006664863;782.6478084861807;958.4297343080856;982.6413359123868;984.3109823123771;986;721.1130309719023;730.1238513783481;733.5928559649392;734.5592644413363;738.9778306650809;14892;15004;15013.399464021426;15021.248937553079;15062.246887655574;12042.759144817055;12395.876041239653;12425.689357766038;12464.875351246554;12535.122541422104;9800.607975680965;9913.206943444578;9917.801643967081;9957.45234012129;10253.231007674454;3431.759776815624;3462.9307413851584;3504.3341765064556;3505.509228707983;3590.2101537661674;75271.62364188144;75391.86912196322;75627.24372756257;75757.86363204502;75911;9093.136152065543;9268.165865072177;9464.90535094654;9544.713658590254;9707.708768736808;21436.356909292746;21490.032948517353;21493.355199344045;21512.677309840365;21548.35354939354;7156.105486814148;7189.90855245217;7260.128784545888;7281.235470275651;7369.4472914531625;3601.9639803602154;3954.62431069048;4028.274910516135;4030.8962099183464;4131.876043718693;3515.7187425005936;3561.2343346180696;3565.5186549815444;3567.6253993330847;3571.08937221007;493.39805437367073;617.2284644194757;626.8338890194102;634.2199095113036;649.6978904809287;435.88449060998863;558.6508432229856;586.5923183387505;606.7239406070228;611.1230384398402;7501.512401693982;7712.445625665677;7828.765137045898;7833.882491762628;8009.479383840032;516.3493997563097;543.7063985447893;579.6377264209868;582.9504492118217;602.340437221242;3696;3784.848606055782;3796.677282431024;3805.771653700787;3811.5235595550557;72151;73548.89676654854;73638.63180684169;82155.5892220535;83088.58455707804;66376;70042.59914801676;70630;70982;71850;62951;63781;63855.680721596094;65145.34854651488;65639.67180164164;8195.180481951757;8207.876881846896;8354.248117669438;8354.45696029756;8394.790130246793;41837.37243941282;42144.578554214066;42278.577214227465;43449;46249.537504624524;63347;66455;66574;67421.66289168522;68852.65573672099;11228.101751859995;11392;11540.480678369326;11853.229540079867;11912.76174476523;10180.287379883337;11087.501062452047;11611.303321800719;11773.411329433666;12113.273203607812;11209.271397359145;11331.376774277494;11342.262752921033;11342.716432089264;11343.376114313793;11472.541098355972;11478.827817582576;11514.539418423505;11683.299002059903;12480.313582753035;10424.972389918717;10576.84134737964;10662.520186591777;10702.625408110678;11463.770724585294;9407.576659050495;9509.429434233969;9580.66467673628;9605.711828645151;9643.662471813454;7973.800654983672;8880.934287885495;9118.498482583256;9612.01402166982;9644.95177524108 13:06:28 INFO - PROCESS | 2286 | __end_tp_report 13:06:28 INFO - PROCESS | 2286 | __start_cc_report 13:06:28 INFO - PROCESS | 2286 | _x_x_mozilla_cycle_collect,1369 13:06:28 INFO - PROCESS | 2286 | __end_cc_report 13:06:28 INFO - PROCESS | 2286 | __startTimestamp1460059588078__endTimestamp 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | ------- Summary: start ------- 13:06:28 INFO - PROCESS | 2286 | Number of tests: 6 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | [#0] dojo.html Cycles:165 Average:5666.90 Median:5837.91 stddev:638.34 (10.9%) stddev-sans-first:607.46 13:06:28 INFO - PROCESS | 2286 | Values: 3090.7 3348.4 3376.8 3392.9 3431.9 5561.0 5620.6 5621.4 5638.9 5644.3 5569.6 5633.9 5634.0 5639.0 5646.4 5069.2 5073.7 5101.5 5106.7 5169.1 5159.8 5166.8 5175.8 5177.3 5182.2 5094.8 5130.0 5137.6 5140.7 5159.1 5132.2 5174.1 5180.0 5181.5 5227.8 4848.2 4945.4 5002.2 5103.5 5120.1 5488.6 5514.3 5518.5 5540.9 5622.2 6179.3 6208.2 6215.7 6232.5 6237.6 6080.0 6090.2 6233.8 6238.3 6293.6 5731.1 5739.8 5745.9 5751.5 5771.0 6280.1 6316.4 6342.4 6354.4 6364.3 5859.2 5977.1 5984.1 5985.5 6040.6 6116.8 6117.4 6212.4 6246.9 6247.6 6140.6 6151.8 6159.7 6166.0 6172.2 6022.3 6109.9 6221.6 6221.9 6233.2 4913.7 4924.1 4925.9 4930.6 4935.3 4433.0 4437.1 4453.2 4480.6 4486.9 4702.6 5564.2 5611.4 5668.5 5682.3 6156.8 6238.4 6244.3 6246.1 6260.4 5502.7 5566.1 5579.5 5580.7 5582.5 5286.3 5326.9 5327.2 5327.5 5331.4 6254.7 6269.1 6311.3 6327.7 6338.2 6219.5 6236.1 6254.6 6277.3 6279.3 6214.3 6301.6 6308.6 6328.9 6331.3 6078.3 6136.6 6138.1 6139.7 6150.3 5837.9 6014.3 6015.7 6020.2 6085.6 5500.0 5758.9 5778.8 5835.2 5965.7 5913.2 5929.7 6002.4 6011.6 6086.7 5807.3 5820.0 5824.8 5848.2 5849.2 5847.6 5954.2 5967.8 5972.3 5988.1 5892.8 5893.9 5896.7 5909.1 5922.0 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | [#1] ext.html Cycles:180 Average:65844.28 Median:39632.31 stddev:148705.94 (375.2%) stddev-sans-first:149042.14 13:06:28 INFO - PROCESS | 2286 | Values: 488.0 567.7 573.6 617.3 631.8 30292.8 30709.5 30715.2 30737.8 30780.5 31703.4 39773.0 39797.2 39889.2 39974.8 9327.5 9514.9 9525.0 9538.2 9543.6 9503.2 9654.6 9657.6 9659.2 9662.6 9602.9 9697.0 9698.6 9700.0 9782.8 9658.5 9762.0 9767.3 9771.6 9782.2 9583.7 9720.5 9720.7 9728.6 9760.0 39433.4 39701.4 39752.2 39780.4 39836.6 3333.5 3463.8 3554.4 3604.4 4055.0 28104.7 28845.7 28914.3 29174.0 29881.0 2724.9 2736.8 2791.6 2851.6 2858.5 465609.0 472025.0 472092.0 472409.0 472431.0 45860.8 46805.8 65298.0 65783.0 65824.0 47133.3 47166.5 47374.0 47389.1 47394.8 14891.3 15681.5 15865.8 15870.7 15906.1 12728.9 12757.8 12780.2 12783.4 12783.8 12996.9 14762.0 14783.9 14809.3 14817.3 6345.1 6415.2 6426.7 6468.8 6493.6 854.8 976.2 1002.6 1007.0 1032.9 27014.1 27090.2 27318.9 27717.6 27743.9 872.8 945.1 953.8 954.2 1006.9 13793.7 14024.2 14168.9 14183.6 14258.9 510992.0 757215.0 770266.0 771667.0 773048.0 57509.0 57700.4 58436.5 58438.1 58590.0 1332.5 1363.0 1447.6 1462.3 1486.7 25640.0 30119.0 30278.5 30990.8 31047.4 52654.0 53208.2 53244.7 53305.0 53398.0 405019.0 419237.0 420485.0 420709.0 421192.0 27973.7 31961.8 32133.0 32767.0 32810.5 39563.2 40643.4 40877.8 41092.8 42509.4 28245.9 33766.8 35455.3 35685.3 36614.3 35123.8 35267.3 35300.5 36134.5 36241.6 34785.7 35347.3 35497.8 35720.9 35864.5 30814.2 31347.7 31374.7 31463.8 31478.4 23301.8 23478.2 23925.8 23962.6 24100.2 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | [#2] jquery.html Cycles:180 Average:33125.17 Median:357.31 stddev:101314.46 (28355.2%) stddev-sans-first:101568.78 13:06:28 INFO - PROCESS | 2286 | Values: 350.9 356.8 357.8 370.6 372.2 19110.0 19240.3 20730.3 20769.3 20831.3 19650.9 20406.3 20984.5 21124.5 21207.8 5602.2 5734.0 5791.1 5806.4 5815.5 4201.8 4304.4 5810.7 6113.3 6416.7 5409.6 6322.0 6339.9 6345.2 6347.9 5494.2 6143.5 6151.6 6208.4 6338.5 3697.1 5237.1 5456.0 5475.0 5490.1 19009.3 23645.8 24246.0 24866.3 24866.4 2105.8 2138.5 2194.6 2400.6 2692.4 13828.1 14277.9 14610.2 14702.6 14936.6 1401.6 1747.2 1767.4 1769.7 1787.7 95142.5 95685.0 95757.5 98700.0 100403.0 8662.6 10326.6 10465.9 10693.3 10694.6 13009.7 13125.0 13125.9 13127.9 13137.0 6988.3 8385.8 8535.6 8556.1 8663.1 8760.9 8777.3 8798.2 8878.7 8922.8 6123.9 6129.0 6136.1 6136.5 6167.8 1660.0 1737.9 1745.4 1762.3 1839.3 835.6 842.5 908.3 937.3 945.2 19060.8 19357.9 19742.7 19975.6 20069.8 895.8 904.9 948.4 953.1 970.6 8679.2 10337.1 10907.2 10913.8 11076.2 601102.0 610276.0 616626.0 623121.0 624484.0 99538.5 102469.5 102698.5 102746.5 105461.0 953.4 1023.3 1059.3 1080.3 1081.1 18028.8 18402.5 18451.2 18457.9 18600.5 40793.0 41490.0 42737.8 43085.9 44290.1 50082.5 55525.2 55546.4 55640.7 55700.4 7536.7 7778.6 7862.1 7881.6 8100.6 12063.8 12151.0 12414.4 12507.9 12513.7 9883.1 10055.4 10217.7 10464.2 10978.5 10078.5 10181.4 11011.6 11040.7 11280.3 10769.6 10789.0 11039.4 11134.8 11310.7 7663.6 7772.9 7885.8 7909.2 8220.7 6747.3 9524.8 10647.1 10810.8 10814.9 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | [#3] mootools.html Cycles:180 Average:6061.57 Median:5031.73 stddev:3189.07 (63.4%) stddev-sans-first:3178.71 13:06:28 INFO - PROCESS | 2286 | Values: 1393.4 1513.1 1606.4 1854.8 2002.9 8049.4 8235.1 8246.5 8247.2 8255.9 8122.8 8526.8 8707.1 8719.2 8748.5 2247.7 2264.6 2439.2 2514.9 2519.5 2223.8 2289.9 2455.4 2480.9 2518.3 2472.8 2483.0 2510.4 2514.0 2521.6 2485.6 2524.6 2524.7 2525.3 2526.3 2441.2 2497.4 2497.5 2498.0 2503.2 7242.0 7429.8 8842.3 8858.7 8863.3 4755.2 5432.0 5599.9 5652.8 5674.5 3480.8 3514.3 3683.6 3684.2 3686.0 1055.2 1060.3 1069.6 1071.5 1075.6 11838.3 11956.1 12014.8 12039.3 12047.4 4836.5 4953.9 5017.2 5024.2 5039.2 10290.3 10360.7 10371.3 10374.5 10413.7 5575.3 5578.2 5596.6 5611.9 5620.9 4989.9 5012.2 5067.4 5069.6 5069.8 3338.9 3788.0 3833.7 3862.8 3868.4 1090.3 1223.6 1268.5 1304.3 1348.1 1320.2 1331.0 1358.3 1358.8 1363.3 7928.4 8008.4 8393.9 8400.9 8402.5 1162.3 1168.7 1176.5 1184.4 1202.6 6240.8 6244.4 6305.9 6315.1 6328.9 10446.3 10892.2 10899.3 11027.0 11046.4 10610.9 10706.3 10747.6 10777.4 10852.7 8286.5 8417.7 8459.9 8477.5 8512.6 7804.3 7830.9 7851.4 7907.5 7913.1 9563.2 9634.1 9715.7 9752.5 9850.9 9830.6 10104.5 10141.6 10252.7 10266.1 7005.3 7154.1 7167.0 7193.6 7571.1 7563.8 8224.1 8243.4 8290.2 8308.5 6284.4 7375.9 7449.1 7491.0 7591.0 7202.6 7251.6 7333.8 7373.9 7412.9 7527.7 7655.1 7710.0 7718.2 7725.4 6917.4 6981.2 7030.8 7037.5 7039.6 6627.3 6859.6 6863.9 6897.1 7093.9 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | [#4] prototype.html Cycles:180 Average:5620.44 Median:6431.34 stddev:1809.87 (28.1%) stddev-sans-first:1770.75 13:06:28 INFO - PROCESS | 2286 | Values: 324.0 326.0 330.8 331.1 332.9 5249.6 6448.4 6530.9 6533.9 6564.4 6383.9 6442.4 6444.1 6458.0 6459.0 4579.2 4653.7 4704.5 4722.6 4794.6 3996.1 4591.5 4732.8 4735.7 4768.2 4698.6 4710.3 4710.5 4714.2 4731.8 4495.8 4595.4 4606.7 4607.0 4721.0 3971.9 4000.7 4075.1 4078.6 4112.3 6167.7 6169.4 6171.1 6183.8 6203.5 5591.7 5602.9 5607.1 5608.5 5611.4 6836.4 6852.9 6861.7 6866.4 6872.2 3782.4 4290.7 4499.8 4502.7 4508.3 7217.9 7272.2 7302.9 7314.9 7322.1 4536.2 4540.5 4541.0 4547.7 4553.4 3673.6 4617.7 4642.7 4649.5 4650.9 4428.5 5489.3 5490.2 5490.2 5491.1 6593.4 6847.7 6852.1 6940.3 6954.7 1580.1 1582.4 1596.2 1599.3 1604.4 1008.5 1014.9 1032.0 1033.7 1035.9 5516.9 6230.7 6397.1 6406.6 6420.3 5772.4 7105.9 7181.0 7182.8 7213.5 5913.8 5978.5 6469.5 6517.8 6530.4 3778.2 3826.7 3828.7 3828.9 3842.7 7213.6 7540.9 7549.4 7558.4 7563.5 6695.4 6950.3 7388.7 7412.8 7488.1 7536.2 7552.1 7554.4 7557.0 7559.1 7215.5 7238.3 7239.0 7255.0 7264.9 6774.4 7071.3 7086.3 7090.5 7093.9 5737.7 7191.3 7503.4 7536.9 7575.8 4711.8 4765.8 4777.2 4783.2 4785.3 6610.8 7038.0 7098.8 7113.4 7119.7 6615.2 6870.5 6871.0 6874.7 6875.8 6871.2 6900.2 6910.1 6941.8 6966.2 6770.0 6771.4 6774.0 6783.8 6796.9 6921.4 6923.3 6923.3 6924.5 6928.5 6505.5 6739.6 6786.3 6789.4 6796.4 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - PROCESS | 2286 | [#5] yui.html Cycles:180 Average:17062.12 Median:31990.61 stddev:23047.71 (72.0%) stddev-sans-first:23079.75 13:06:28 INFO - PROCESS | 2286 | Values: 732.4 741.4 745.2 753.8 799.3 14753.0 14809.3 15116.0 15124.4 15127.3 14059.4 14169.4 14190.0 14191.9 14196.9 747.6 756.5 903.0 910.3 932.7 788.8 930.6 934.4 934.6 938.6 988.5 991.7 994.9 995.3 996.2 782.6 958.4 982.6 984.3 986.0 721.1 730.1 733.6 734.6 739.0 14892.0 15004.0 15013.4 15021.2 15062.2 12042.8 12395.9 12425.7 12464.9 12535.1 9800.6 9913.2 9917.8 9957.5 10253.2 3431.8 3462.9 3504.3 3505.5 3590.2 75271.6 75391.9 75627.2 75757.9 75911.0 9093.1 9268.2 9464.9 9544.7 9707.7 21436.4 21490.0 21493.4 21512.7 21548.4 7156.1 7189.9 7260.1 7281.2 7369.4 3602.0 3954.6 4028.3 4030.9 4131.9 3515.7 3561.2 3565.5 3567.6 3571.1 493.4 617.2 626.8 634.2 649.7 435.9 558.7 586.6 606.7 611.1 7501.5 7712.4 7828.8 7833.9 8009.5 516.3 543.7 579.6 583.0 602.3 3696.0 3784.8 3796.7 3805.8 3811.5 72151.0 73548.9 73638.6 82155.6 83088.6 66376.0 70042.6 70630.0 70982.0 71850.0 62951.0 63781.0 63855.7 65145.3 65639.7 8195.2 8207.9 8354.2 8354.5 8394.8 41837.4 42144.6 42278.6 43449.0 46249.5 63347.0 66455.0 66574.0 67421.7 68852.7 11228.1 11392.0 11540.5 11853.2 11912.8 10180.3 11087.5 11611.3 11773.4 12113.3 11209.3 11331.4 11342.3 11342.7 11343.4 11472.5 11478.8 11514.5 11683.3 12480.3 10425.0 10576.8 10662.5 10702.6 11463.8 9407.6 9509.4 9580.7 9605.7 9643.7 7973.8 8880.9 9118.5 9612.0 9645.0 13:06:28 INFO - PROCESS | 2286 | -------- Summary: end -------- 13:06:28 INFO - PROCESS | 2286 | 13:06:28 INFO - TEST-INFO | 2286: exit 0 13:06:28 INFO - TEST-OK | dromaeo_css | took 1113901ms 13:06:28 INFO - TEST-START | kraken 13:06:28 INFO - operating with platform_type : mac_ 13:06:28 INFO - Initialising browser for kraken test... 13:06:28 INFO - TEST-INFO | started process 2289 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp4zMbLu/profile http://localhost:53460/getInfo.html) 13:06:30 INFO - PROCESS | 2289 | __metrics Screen width/height:1600/1200 13:06:30 INFO - PROCESS | 2289 | colorDepth:24 13:06:30 INFO - PROCESS | 2289 | Browser inner width/height: 1024/689 13:06:30 INFO - PROCESS | 2289 | __metrics 13:06:30 INFO - PROCESS | 2289 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:06:30 ERROR - PROCESS | 2289 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:06:31 INFO - TEST-INFO | 2289: exit 0 13:06:31 INFO - Browser initialized. 13:06:31 INFO - Running cycle 1/1 for kraken test... 13:06:31 INFO - TEST-INFO | started process 2291 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp4zMbLu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:06:43 INFO - PROCESS | 2291 | RSS: Main: 237187072 13:06:43 INFO - PROCESS | 2291 | 13:06:45 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-beat-detection) 13:06:46 INFO - PROCESS | 2291 | RSS: Main: 283484160 13:06:46 INFO - PROCESS | 2291 | 13:06:49 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-dft) 13:06:49 INFO - PROCESS | 2291 | RSS: Main: 293769216 13:06:49 INFO - PROCESS | 2291 | 13:06:52 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-fft) 13:06:53 INFO - PROCESS | 2291 | RSS: Main: 279240704 13:06:53 INFO - PROCESS | 2291 | 13:06:55 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-oscillator) 13:06:56 INFO - PROCESS | 2291 | RSS: Main: 281554944 13:06:56 INFO - PROCESS | 2291 | 13:06:58 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:06:58 INFO - PROCESS | 2291 | RSS: Main: 282210304 13:06:58 INFO - PROCESS | 2291 | 13:07:01 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53460/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:02 INFO - PROCESS | 2291 | RSS: Main: 282210304 13:07:02 INFO - PROCESS | 2291 | 13:07:04 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53460/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:05 INFO - PROCESS | 2291 | RSS: Main: 282333184 13:07:05 INFO - PROCESS | 2291 | 13:07:08 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53460/tests/kraken/driver.html?testName=json-parse-financial) 13:07:08 INFO - PROCESS | 2291 | RSS: Main: 282734592 13:07:08 INFO - PROCESS | 2291 | 13:07:10 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:07:10 INFO - PROCESS | 2291 | RSS: Main: 317165568 13:07:10 INFO - PROCESS | 2291 | 13:07:12 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:07:13 INFO - PROCESS | 2291 | RSS: Main: 317030400 13:07:13 INFO - PROCESS | 2291 | 13:07:15 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:07:16 INFO - PROCESS | 2291 | RSS: Main: 323997696 13:07:16 INFO - PROCESS | 2291 | 13:07:18 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:07:19 INFO - PROCESS | 2291 | RSS: Main: 325214208 13:07:19 INFO - PROCESS | 2291 | 13:07:22 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:07:22 INFO - PROCESS | 2291 | RSS: Main: 325468160 13:07:22 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53460/tests/kraken/driver.html?testName=ai-astar) 13:07:24 INFO - PROCESS | 2291 | RSS: Main: 388345856 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | __start_tp_report 13:07:24 INFO - PROCESS | 2291 | _x_x_mozilla_page_load 13:07:24 INFO - PROCESS | 2291 | _x_x_mozilla_page_load_details 13:07:24 INFO - PROCESS | 2291 | |i|pagename|runs| 13:07:24 INFO - PROCESS | 2291 | |0;ai-astar;111;111;109;111;110;112;116;111;112;110 13:07:24 INFO - PROCESS | 2291 | |1;audio-beat-detection;157;118;145;159;120;148;139;121;167;113 13:07:24 INFO - PROCESS | 2291 | |2;audio-dft;185;187;186;188;187;187;188;185;180;180 13:07:24 INFO - PROCESS | 2291 | |3;audio-fft;78;76;74;123;56;58;60;58;122;56 13:07:24 INFO - PROCESS | 2291 | |4;audio-oscillator;93;93;135;78;78;79;121;80;80;125 13:07:24 INFO - PROCESS | 2291 | |5;imaging-gaussian-blur;88;87;87;85;88;84;89;87;87;70 13:07:24 INFO - PROCESS | 2291 | |6;imaging-darkroom;92;92;94;93;94;92;93;93;93;93 13:07:24 INFO - PROCESS | 2291 | |7;imaging-desaturate;84;84;85;95;126;87;85;87;84;84 13:07:24 INFO - PROCESS | 2291 | |8;json-parse-financial;53;54;53;53;54;53;54;64;55;52 13:07:24 INFO - PROCESS | 2291 | |9;json-stringify-tinderbox;63;62;72;82;105;104;85;67;68;68 13:07:24 INFO - PROCESS | 2291 | |10;stanford-crypto-aes;82;85;85;84;86;83;84;83;85;84 13:07:24 INFO - PROCESS | 2291 | |11;stanford-crypto-ccm;135;133;131;133;120;121;123;128;124;128 13:07:24 INFO - PROCESS | 2291 | |12;stanford-crypto-pbkdf2;142;129;135;141;139;129;140;138;137;139 13:07:24 INFO - PROCESS | 2291 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;67;68;68;68;68 13:07:24 INFO - PROCESS | 2291 | __end_tp_report 13:07:24 INFO - PROCESS | 2291 | __start_cc_report 13:07:24 INFO - PROCESS | 2291 | _x_x_mozilla_cycle_collect,1323 13:07:24 INFO - PROCESS | 2291 | __end_cc_report 13:07:24 INFO - PROCESS | 2291 | __startTimestamp1460059644540__endTimestamp 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | ------- Summary: start ------- 13:07:24 INFO - PROCESS | 2291 | Number of tests: 14 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:2.00 13:07:24 INFO - PROCESS | 2291 | Values: 111.0 111.0 109.0 111.0 110.0 112.0 116.0 111.0 112.0 110.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:146.50 stddev:19.51 (13.3%) stddev-sans-first:19.54 13:07:24 INFO - PROCESS | 2291 | Values: 157.0 118.0 145.0 159.0 120.0 148.0 139.0 121.0 167.0 113.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#2] audio-dft Cycles:10 Average:185.30 Median:187.00 stddev:2.98 (1.6%) stddev-sans-first:3.16 13:07:24 INFO - PROCESS | 2291 | Values: 185.0 187.0 186.0 188.0 187.0 187.0 188.0 185.0 180.0 180.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#3] audio-fft Cycles:10 Average:76.10 Median:59.00 stddev:25.90 (43.9%) stddev-sans-first:27.46 13:07:24 INFO - PROCESS | 2291 | Values: 78.0 76.0 74.0 123.0 56.0 58.0 60.0 58.0 122.0 56.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.50 stddev:22.25 (28.0%) stddev-sans-first:23.56 13:07:24 INFO - PROCESS | 2291 | Values: 93.0 93.0 135.0 78.0 78.0 79.0 121.0 80.0 80.0 125.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:87.00 stddev:5.53 (6.4%) stddev-sans-first:5.78 13:07:24 INFO - PROCESS | 2291 | Values: 88.0 87.0 87.0 85.0 88.0 84.0 89.0 87.0 87.0 70.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:07:24 INFO - PROCESS | 2291 | Values: 92.0 92.0 94.0 93.0 94.0 92.0 93.0 93.0 93.0 93.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:85.00 stddev:13.05 (15.4%) stddev-sans-first:13.65 13:07:24 INFO - PROCESS | 2291 | Values: 84.0 84.0 85.0 95.0 126.0 87.0 85.0 87.0 84.0 84.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.44 (6.4%) stddev-sans-first:3.61 13:07:24 INFO - PROCESS | 2291 | Values: 53.0 54.0 53.0 53.0 54.0 53.0 54.0 64.0 55.0 52.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#9] json-stringify-tinderbox Cycles:10 Average:77.60 Median:68.00 stddev:16.01 (23.5%) stddev-sans-first:16.08 13:07:24 INFO - PROCESS | 2291 | Values: 63.0 62.0 72.0 82.0 105.0 104.0 85.0 67.0 68.0 68.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:1.20 (1.4%) stddev-sans-first:1.00 13:07:24 INFO - PROCESS | 2291 | Values: 82.0 85.0 85.0 84.0 86.0 83.0 84.0 83.0 85.0 84.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.50 stddev:5.38 (4.2%) stddev-sans-first:4.99 13:07:24 INFO - PROCESS | 2291 | Values: 135.0 133.0 131.0 133.0 120.0 121.0 123.0 128.0 124.0 128.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:139.00 stddev:4.61 (3.3%) stddev-sans-first:4.50 13:07:24 INFO - PROCESS | 2291 | Values: 142.0 129.0 135.0 141.0 139.0 129.0 140.0 138.0 137.0 139.0 13:07:24 INFO - PROCESS | 2291 | 13:07:24 INFO - PROCESS | 2291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:07:24 INFO - PROCESS | 2291 | Values: 68.0 68.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 68.0 13:07:24 INFO - PROCESS | 2291 | -------- Summary: end -------- 13:07:24 INFO - PROCESS | 2291 | 13:07:25 INFO - TEST-INFO | 2291: exit 0 13:07:25 INFO - TEST-OK | kraken | took 56775ms 13:07:25 INFO - SUITE-END | took 1170s 13:07:25 INFO - Completed test suite (00:19:30) 13:07:25 INFO - javascript benchmark 13:07:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.737287330577, 3348.430766769649, 3376.7805092668973, 3392.9491057634154, 3431.8970430887084, 5560.999020176367, 5620.550355971523, 5621.40975197604, 5638.887222255553, 5644.266245388099, 5569.610127291091, 5633.887322253552, 5634.014047541685, 5638.971805140968, 5646.435356464352, 5069.214271787879, 5073.670211436263, 5101.489851014906, 5106.744662766865, 5169.121249387613, 5159.845204643867, 5166.793328266865, 5175.844724658266, 5177.32694749682, 5182.170852663575, 5094.77073531692, 5130.0, 5137.614678899079, 5140.742962851861, 5159.122949098643, 5132.230165475171, 5174.120399532051, 5179.974100129513, 5181.533661970403, 5227.764750586232, 4848.22428411456, 4945.357103576548, 5002.2246551784165, 5103.540681338697, 5120.1039818031695, 5488.615796894219, 5514.255575497296, 5518.530924871391, 5540.9168862467095, 5622.240997465331, 6179.289381721114, 6208.161898143738, 6215.68921553925, 6232.532560057968, 6237.625742455467, 6079.969600152015, 6090.23872015998, 6233.750649973996, 6238.344973777734, 6293.559450838443, 5731.140328950649, 5739.827805165852, 5745.88508229833, 5751.4536119068625, 5770.961226979142, 6280.120783090371, 6316.399942005502, 6342.429181373698, 6354.4281014708895, 6364.268109167505, 5859.1797148399255, 5977.103434484775, 5984.102384642251, 5985.461308482258, 6040.637561746309, 6116.785912493041, 6117.431594453911, 6212.4408803207925, 6246.937530624727, 6247.5939063960695, 6140.600860944024, 6151.815445536641, 6159.692015399301, 6165.969170154121, 6172.197614310111, 6022.337542870281, 6109.877802443926, 6221.595596286317, 6221.9377806221355, 6233.189685340967, 4913.680610760361, 4924.0890435268875, 4925.901481970341, 4930.556249937523, 4935.3090567320605, 4433.0, 4437.090396468716, 4453.19842428366, 4480.619147372445, 4486.910261794746, 4702.576768090888, 5564.221009058735, 5611.382747897728, 5668.489835914705, 5682.289713785777, 6156.846078848064, 6238.376162383725, 6244.344343843922, 6246.094316324107, 6260.405261500241, 5502.724863756796, 5566.053770858964, 5579.497845193952, 5580.748866301026, 5582.525485333711, 5286.3392075990505, 5326.946730532645, 5327.174287985368, 5327.493888080626, 5331.360236771535, 6254.6872656366995, 6269.12232287471, 6311.305756366796, 6327.683615819283, 6338.176037115146, 6219.533534984985, 6236.095766113797, 6254.6247225166635, 6277.3408792078, 6279.340669229848, 6214.316425193316, 6301.558890877778, 6308.558400912076, 6328.873422531616, 6331.27190373113, 6078.331383547895, 6136.6429834816, 6138.051223665275, 6139.693015349126, 6150.323464419, 5837.912431313449, 6014.338422773404, 6015.669138197266, 6020.157177994996, 6085.6348619083, 5500.0, 5758.942410576008, 5778.8266352009505, 5835.183074369676, 5965.701714914324, 5913.201717768218, 5929.733162007634, 6002.429769171922, 6011.60924539921, 6086.72609732572, 5807.332156802022, 5819.970900145472, 5824.767009319579, 5848.239728835224, 5849.210356601804, 5847.590668653153, 5954.225950626565, 5967.76128954837, 5972.313183983897, 5988.131720900532, 5892.7642894283745, 5893.941060589339, 5896.734646940812, 5909.143174239625, 5921.99326114553], "value": 5625.564478670585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.9878003049921, 567.651748120579, 573.5698226330252, 617.3301967365406, 631.8167731357905, 30292.84853575732, 30709.53935690961, 30715.23211919703, 30737.846310768444, 30780.53829192564, 31703.365932681332, 39773.0, 39797.20405591886, 39889.20221595574, 39974.80138592376, 9327.486988215662, 9514.904850951505, 9525.0, 9538.236941044699, 9543.618255269816, 9503.192228660537, 9654.613815447374, 9657.613695452173, 9659.227261819038, 9662.613495460173, 9602.903970960271, 9697.030296970317, 9698.612055517771, 9699.9815019423, 9782.804343913152, 9658.4687842169, 9762.0, 9767.267454940873, 9771.609135634566, 9782.168515676176, 9583.664571739955, 9720.465374404404, 9720.659776907845, 9728.562214700356, 9760.0, 39433.40849887254, 39701.40447893284, 39752.20495590072, 39780.403293950614, 39836.60163398358, 3333.4833100869405, 3463.757536972413, 3554.449060395643, 3604.387254166798, 4055.0470639400014, 28104.711418190578, 28845.711542884514, 28914.27714307138, 29174.0, 29880.954166604282, 2724.8910043598235, 2736.822106563067, 2791.609174715521, 2851.5580085086845, 2858.5426331786816, 465608.9999999966, 472025.0, 472092.0, 472409.0, 472431.0, 45860.770696146305, 46805.82985425392, 65298.0, 65783.0, 65824.0, 47133.293000605016, 47166.5283347169, 47374.0, 47389.052218956116, 47394.76302618465, 14891.255437228096, 15681.529554113395, 15865.762013569805, 15870.682586348208, 15906.12516311614, 12728.872711272768, 12757.808632870514, 12780.169288996185, 12783.424745886457, 12783.808242876365, 12996.870031299755, 14762.0, 14783.926080369529, 14809.259537023107, 14817.259137043106, 6345.143405640272, 6415.166028416369, 6426.678666066678, 6468.8059358219325, 6493.642849643221, 854.7692123126845, 976.1734002709396, 1002.6240159940022, 1006.9647562335283, 1032.9225308101772, 27014.087744811437, 27090.1872943812, 27318.863405682845, 27717.58423623647, 27743.861280693873, 872.842888280103, 945.1210374351919, 953.7791626717813, 954.1984732824461, 1006.9496525173712, 13793.724125517634, 14024.158550487004, 14168.858311416754, 14183.64540886486, 14258.928705356615, 510992.0, 757215.0, 770266.0, 771667.0, 773048.0, 57509.0, 57700.422995769506, 58436.53908652232, 58438.12342814861, 58590.0, 1332.4736728991993, 1362.9659258518418, 1447.5657302809116, 1462.3200211901303, 1486.717523670499, 25640.0, 30119.0, 30278.54582181313, 30990.845045774626, 31047.379052419277, 52654.0, 53208.20187697265, 53244.73377633087, 53305.0, 53398.0, 405019.0, 419237.0, 420485.0, 420709.0, 421192.0, 27973.720262797113, 31961.840190798895, 32133.0, 32767.0, 32810.50784238286, 39563.2087358257, 40643.390349144196, 40877.79561102176, 41092.794536027126, 42509.36235956525, 28245.858770706014, 33766.831165844014, 35455.34084943588, 35685.28629427449, 36614.26771464609, 35123.82438087793, 35267.29465410729, 35300.47049294211, 36134.457983129745, 36241.63758362383, 34785.65214347824, 35347.29305413826, 35497.82251088728, 35720.928372148875, 35864.462033069, 30814.229644259074, 31347.68652313448, 31374.68625313809, 31463.84268078645, 31478.370432591677, 23301.76698232996, 23478.178263760685, 23925.760742392355, 23962.640560391956, 24100.15649452261], "value": 18897.58797358015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.94735789631557, 356.7752316040894, 357.83539571796973, 370.5923484167418, 372.19605651792136, 19109.99999999998, 19240.3265885694, 20730.27444039459, 20769.27307544236, 20831.27090551831, 19650.919199444026, 20406.285779997703, 20984.475388115305, 21124.471888202763, 21207.787922120773, 5602.187682785993, 5734.0, 5791.131330300446, 5806.419358064202, 5815.47660710536, 4201.789910504478, 4304.418903448026, 5810.709464526778, 6113.296970848365, 6416.711247993828, 5409.648372855771, 6322.0, 6339.936600634004, 6345.238571371442, 6347.936520634804, 5494.1758736189895, 6143.539234557426, 6151.569390142692, 6208.410201030895, 6338.492920566367, 3697.1126929536717, 5237.13587258102, 5456.045192091368, 5475.0418676731415, 5490.149026900836, 19009.334673286507, 23645.817709114646, 24246.030158793805, 24866.254012379657, 24866.37834054145, 2105.8315334773183, 2138.454694053022, 2194.6208906818197, 2400.627902675088, 2692.394211302461, 13828.085410808497, 14277.857221427757, 14610.19643919584, 14702.63243418923, 14936.551903442914, 1401.5935378740153, 1747.2050217151166, 1767.4344209852852, 1769.7345398190246, 1787.7497150398954, 95142.52428737812, 95685.0, 95757.52121239419, 98700.0129998698, 100403.0, 8662.566871656392, 10326.586936522604, 10465.9476702616, 10693.251472396858, 10694.625688101034, 13009.739805203842, 13125.0, 13125.868741312655, 13127.934360328138, 13137.014723895554, 6988.266232045664, 8385.83228335442, 8535.573221338907, 8556.144385561394, 8663.133686631287, 8760.91239087601, 8777.253933415732, 8798.164174403422, 8878.73363799087, 8922.821543569093, 6123.938760612336, 6128.969355153285, 6136.110264011782, 6136.509079273647, 6167.753289868445, 1659.9585010374838, 1737.8870373425939, 1745.3891138101817, 1762.2774662388358, 1839.3194518028415, 835.644850938361, 842.473454091193, 908.3060092926776, 937.2829785214317, 945.2013048973606, 19060.809391905903, 19357.90321048386, 19742.70385944212, 19975.60048799045, 20069.792322844474, 895.7984453497911, 904.8914130304406, 948.4262021477045, 953.1421720451649, 970.5632465390603, 8679.234003546988, 10337.06966373015, 10907.18196135293, 10913.781724365468, 11076.169287303323, 601102.0, 610276.0, 616626.0, 623121.0, 624484.0, 99538.502307488, 102469.48765256126, 102698.45952310722, 102746.48626756968, 105461.0, 953.423178976723, 1023.3399457349967, 1059.2532264753331, 1080.2762149359949, 1081.1242893256488, 18028.819711802713, 18402.539936501693, 18451.16969736392, 18457.90771046136, 18600.534986625444, 40792.98017549466, 41490.0, 42737.786311068245, 43085.92285192895, 44290.11419771651, 50082.49917500924, 55525.167122492385, 55546.44453555575, 55640.72179639076, 55700.442995571146, 7536.660850261642, 7778.611069446618, 7862.095858976291, 7881.605919703878, 8100.635471403683, 12063.81904271419, 12151.0, 12414.379281036092, 12507.93746031264, 12513.687157821127, 9883.11052005323, 10055.39667619945, 10217.74455638615, 10464.162866970777, 10978.505967231335, 10078.546465409221, 10181.389116652728, 11011.61459348919, 11040.742980820516, 11280.32318060886, 10769.62306319275, 10789.028987391173, 11039.448027598748, 11134.777304454028, 11310.660680179608, 7663.578503182379, 7772.883406749016, 7885.763427097197, 7909.24862138096, 8220.671173153007, 6747.257801641717, 9524.761880952754, 10647.094996925038, 10810.783784324427, 10814.945925270324], "value": 9204.194509326617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.3799459240643, 1513.1375116183776, 1606.437746788624, 1854.7588813454258, 2002.9499262518445, 8049.396295277856, 8235.094139644634, 8246.546439945801, 8247.21651443112, 8255.876161857577, 8122.796930076751, 8526.829463410728, 8707.129287071306, 8719.17167869053, 8748.518831464267, 2247.71903512061, 2264.62633665445, 2439.243834411334, 2514.8994040238367, 2519.5212909547126, 2223.788740069691, 2289.9084036638596, 2455.4107014316614, 2480.9255722328357, 2518.2948774343213, 2472.752724727522, 2482.950340993179, 2510.447701505666, 2513.956707966201, 2521.5839386501207, 2485.565026120422, 2524.5582023145876, 2524.734902835194, 2525.2929179829584, 2526.305266051832, 2441.2432146034607, 2497.400623850281, 2497.475530138673, 2498.0, 2503.198976327576, 7242.0, 7429.7771066867535, 8842.292616590657, 8858.689945851864, 8863.290936725047, 4755.239161734106, 5431.972840135813, 5599.944000559983, 5652.773889044474, 5674.460926212003, 3480.756347055707, 3514.314708631792, 3683.557973043225, 3684.244729830378, 3685.9631403686158, 1055.1927775251938, 1060.3160961180072, 1069.6149386221032, 1071.4696225368414, 1075.639660713662, 11838.289702617785, 11956.103292253116, 12014.759704805942, 12039.337836418994, 12047.39763011846, 4836.46798852126, 4953.860612059247, 5017.222330538772, 5024.2463630454995, 5039.21892106724, 10290.279680422449, 10360.689179324632, 10371.27401081917, 10374.481275936323, 10413.739656508647, 5575.275214222125, 5578.191162281447, 5596.58025648078, 5611.9438805612235, 5620.91568626471, 4989.875253118701, 5012.248162775612, 5067.391912970467, 5069.594432445396, 5069.771860266297, 3338.9499157512655, 3788.0, 3833.6549710526187, 3862.8454861805776, 3868.3810590305416, 1090.3239991205503, 1223.614561413152, 1268.4651571598285, 1304.3478260869565, 1348.1035111650838, 1320.2474589484093, 1330.993345033288, 1358.2936872826076, 1358.7758019926798, 1363.277462944641, 7928.365730741527, 8008.399370047153, 8393.916060839436, 8400.873986890201, 8402.495850248883, 1162.3258510064143, 1168.655246702208, 1176.4705882352976, 1184.3545267829054, 1202.5790973159324, 6240.777968132634, 6244.438000579969, 6305.90541141874, 6315.147455093595, 6328.905066424008, 10446.320989135682, 10892.237543372046, 10899.346039237671, 11027.0, 11046.392448415414, 10610.89389106099, 10706.250562460553, 10747.623833165802, 10777.353358798497, 10852.728681783019, 8286.544240066734, 8417.663293468315, 8459.915400846035, 8477.491350518989, 8512.574371281411, 7804.297613214838, 7830.882536761839, 7851.4111441643245, 7907.525548467111, 7913.089994650689, 9563.174730108012, 9634.13292803651, 9715.659951901649, 9752.46361450127, 9850.852237216592, 9830.55762490704, 10104.494775261355, 10141.645042423479, 10252.743681408025, 10266.076053154953, 7005.299470052954, 7154.069970903749, 7166.964165179141, 7193.640317983975, 7571.091469023752, 7563.8109047272055, 8224.136465671258, 8243.422960392714, 8290.212429819157, 8308.501489910625, 6284.4344009039405, 7375.889361659687, 7449.14334851499, 7491.0, 7590.962045189739, 7202.567845929051, 7251.56490610565, 7333.816654583678, 7373.852522949618, 7412.851742965003, 7527.661255243418, 7655.0813902332075, 7710.0, 7718.151003389735, 7725.381969442319, 6917.446604271747, 6981.232064472802, 7030.753923612649, 7037.542559733601, 7039.577625342496, 6627.255446411635, 6859.622720750406, 6863.931360686329, 6897.137857767779, 7093.893591596234], "value": 4955.8407066703785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.9627442844073, 325.9625143108543, 330.7916012911865, 331.1010606204156, 332.90345799718096, 5249.553787928021, 6448.419642232198, 6530.902036469457, 6533.934660653398, 6564.442022428093, 6383.872322553558, 6442.387973142544, 6444.130042444269, 6457.9677101614425, 6458.967705161479, 4579.22153233951, 4653.720776753389, 4704.529547045286, 4722.5513576210205, 4794.592459640935, 3996.1008773025983, 4591.540845915399, 4732.840454088753, 4735.66850320476, 4768.23708206687, 4698.624110071186, 4710.3405523226775, 4710.458297295803, 4714.245720684691, 4731.763411829412, 4495.775211239425, 4595.402597662316, 4606.746628935441, 4606.976965115186, 4721.0, 3971.9007024824323, 4000.719949603529, 4075.1442197138635, 4078.5928854545136, 4112.321466957948, 6167.722452489604, 6169.426796166994, 6171.074338849164, 6183.752649893999, 6203.472704820096, 5591.720413979326, 5602.943970560324, 5607.130894711327, 5608.49523542879, 5611.410801865786, 6836.350546698056, 6852.931470685279, 6861.725530978755, 6866.382025617669, 6872.244053154149, 3782.394816829322, 4290.742555446652, 4499.775011249457, 4502.662300327489, 4508.346289787963, 7217.8556428871125, 7272.236415176383, 7302.926970730277, 7314.890276645855, 7322.121345438528, 4536.228841097021, 4540.500544940054, 4540.977295113504, 4547.681662283675, 4553.408056952641, 3673.577538583097, 4617.746023968714, 4642.675012749075, 4649.511801260886, 4650.86047418578, 4428.4685837699035, 5489.34127904646, 5490.176473529003, 5490.176473529003, 5491.121420572769, 6593.406593406617, 6847.74732002295, 6852.109225800614, 6940.327973730049, 6954.65226738661, 1580.1151355241102, 1582.3907795498815, 1596.1540383596712, 1599.288316699081, 1604.4224079331432, 1008.5209525475341, 1014.8832884218261, 1031.9587216511256, 1033.6743925663393, 1035.8808736995343, 5516.862078447991, 6230.6573138476915, 6397.072424498515, 6406.647634380154, 6420.293767685551, 5772.3938986406665, 7105.857882842314, 7180.958760979629, 7182.8204294892, 7213.531120477152, 5913.76344946206, 5978.491828194565, 6469.482441404676, 6517.794208071522, 6530.444912182423, 3778.1876896467393, 3826.6747326477002, 3828.73198876076, 3828.9042773930873, 3842.731008829411, 7213.639318034077, 7540.886886696704, 7549.358304544176, 7558.395328373717, 7563.508371955805, 6695.363940425652, 6950.339717726808, 7388.74139405129, 7412.814679633052, 7488.101427828696, 7536.208698086732, 7552.093748750075, 7554.357879580188, 7556.962215188889, 7559.130699969464, 7215.494915355875, 7238.348548630648, 7238.963805180941, 7255.0, 7264.89102663471, 6774.356436138559, 7071.257517960746, 7086.326798954091, 7090.539114957512, 7093.929060709327, 5737.713114344183, 7191.316824901626, 7503.362214211853, 7536.924630753622, 7575.848483030419, 4711.764411779466, 4765.833195838268, 4777.163996300564, 4783.162946484421, 4785.330053792542, 6610.768623098168, 7038.049863268598, 7098.822529436806, 7113.359797618239, 7119.67961441726, 6615.239247486408, 6870.45036397097, 6871.0, 6874.6562671867205, 6875.828104297232, 6871.175458944758, 6900.2409734928115, 6910.136232970879, 6941.757038503628, 6966.198887127843, 6770.018347339706, 6771.3905748482875, 6774.017767423795, 6783.762568310085, 6796.93203067963, 6921.411680007054, 6923.307669233036, 6923.342282483156, 6924.480663950325, 6928.4803639726215, 6505.479561634963, 6739.59562426256, 6786.287439818945, 6789.388954994074, 6796.388325050769], "value": 5018.613322410747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.439683642014, 741.377243115783, 745.191467258025, 753.8341564855732, 799.2846402469789, 14753.0, 14809.25953702316, 15116.0, 15124.395024199019, 15127.319270632821, 14059.367328470218, 14169.362378692958, 14190.0, 14191.858081419208, 14196.93522985775, 747.6075060593205, 756.4666909828558, 903.0472851142059, 910.2945217456459, 932.6828878181417, 788.8146285622875, 930.585889279271, 934.434667026446, 934.5841100710187, 938.5635679409073, 988.5304480371838, 991.7322322972793, 994.9303548751591, 995.3082607587729, 996.2329006664863, 782.6478084861807, 958.4297343080856, 982.6413359123868, 984.3109823123771, 986.0, 721.1130309719023, 730.1238513783481, 733.5928559649392, 734.5592644413363, 738.9778306650809, 14892.0, 15004.0, 15013.399464021426, 15021.248937553079, 15062.246887655574, 12042.759144817055, 12395.876041239653, 12425.689357766038, 12464.875351246554, 12535.122541422104, 9800.607975680965, 9913.206943444578, 9917.801643967081, 9957.45234012129, 10253.231007674454, 3431.759776815624, 3462.9307413851584, 3504.3341765064556, 3505.509228707983, 3590.2101537661674, 75271.62364188144, 75391.86912196322, 75627.24372756257, 75757.86363204502, 75911.0, 9093.136152065543, 9268.165865072177, 9464.90535094654, 9544.713658590254, 9707.708768736808, 21436.356909292746, 21490.032948517353, 21493.355199344045, 21512.677309840365, 21548.35354939354, 7156.105486814148, 7189.90855245217, 7260.128784545888, 7281.235470275651, 7369.4472914531625, 3601.9639803602154, 3954.62431069048, 4028.274910516135, 4030.8962099183464, 4131.876043718693, 3515.7187425005936, 3561.2343346180696, 3565.5186549815444, 3567.6253993330847, 3571.08937221007, 493.39805437367073, 617.2284644194757, 626.8338890194102, 634.2199095113036, 649.6978904809287, 435.88449060998863, 558.6508432229856, 586.5923183387505, 606.7239406070228, 611.1230384398402, 7501.512401693982, 7712.445625665677, 7828.765137045898, 7833.882491762628, 8009.479383840032, 516.3493997563097, 543.7063985447893, 579.6377264209868, 582.9504492118217, 602.340437221242, 3696.0, 3784.848606055782, 3796.677282431024, 3805.771653700787, 3811.5235595550557, 72151.0, 73548.89676654854, 73638.63180684169, 82155.5892220535, 83088.58455707804, 66376.0, 70042.59914801676, 70630.0, 70982.0, 71850.0, 62951.0, 63781.0, 63855.680721596094, 65145.34854651488, 65639.67180164164, 8195.180481951757, 8207.876881846896, 8354.248117669438, 8354.45696029756, 8394.790130246793, 41837.37243941282, 42144.578554214066, 42278.577214227465, 43449.0, 46249.537504624524, 63347.0, 66455.0, 66574.0, 67421.66289168522, 68852.65573672099, 11228.101751859995, 11392.0, 11540.480678369326, 11853.229540079867, 11912.76174476523, 10180.287379883337, 11087.501062452047, 11611.303321800719, 11773.411329433666, 12113.273203607812, 11209.271397359145, 11331.376774277494, 11342.262752921033, 11342.716432089264, 11343.376114313793, 11472.541098355972, 11478.827817582576, 11514.539418423505, 11683.299002059903, 12480.313582753035, 10424.972389918717, 10576.84134737964, 10662.520186591777, 10702.625408110678, 11463.770724585294, 9407.576659050495, 9509.429434233969, 9580.66467673628, 9605.711828645151, 9643.662471813454, 7973.800654983672, 8880.934287885495, 9118.498482583256, 9612.01402166982, 9644.95177524108], "value": 6730.177980871146, "unit": "score"}], "name": "dromaeo_css", "value": 7396.960152192839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 109.0, 111.0, 110.0, 112.0, 116.0, 111.0, 112.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 118.0, 145.0, 159.0, 120.0, 148.0, 139.0, 121.0, 167.0, 113.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 186.0, 188.0, 187.0, 187.0, 188.0, 185.0, 180.0, 180.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 74.0, 123.0, 56.0, 58.0, 60.0, 58.0, 122.0, 56.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 135.0, 78.0, 78.0, 79.0, 121.0, 80.0, 80.0, 125.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 85.0, 88.0, 84.0, 89.0, 87.0, 87.0, 70.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 94.0, 93.0, 94.0, 92.0, 93.0, 93.0, 93.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 95.0, 126.0, 87.0, 85.0, 87.0, 84.0, 84.0], "value": 90.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 54.0, 53.0, 54.0, 64.0, 55.0, 52.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 72.0, 82.0, 105.0, 104.0, 85.0, 67.0, 68.0, 68.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 85.0, 84.0, 86.0, 83.0, 84.0, 83.0, 85.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 131.0, 133.0, 120.0, 121.0, 123.0, 128.0, 124.0, 128.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 129.0, 135.0, 141.0, 139.0, 129.0, 140.0, 138.0, 137.0, 139.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1424.1, "alertThreshold": 2.0}]} 13:07:25 INFO - Return code: 0 13:07:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:07:25 ERROR - # TBPL SUCCESS # 13:07:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:07:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:07:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:07:25 INFO - 2016-04-07 13:07:25.876 screenresolution[2295:24778] starting screenresolution argv=screenresolution get 13:07:25 INFO - 2016-04-07 13:07:25.878 screenresolution[2295:24778] Display 0: 1600x1200x32@60 13:07:25 INFO - 2016-04-07 13:07:25.885 screenresolution[2296:24781] starting screenresolution argv=screenresolution list 13:07:25 INFO - Available Modes on Display 0 13:07:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:07:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:07:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:07:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:07:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:07:26 INFO - Intel Iris: 13:07:26 INFO - Chipset Model: Intel Iris 13:07:26 INFO - Type: GPU 13:07:26 INFO - Bus: Built-In 13:07:26 INFO - VRAM (Dynamic, Max): 1536 MB 13:07:26 INFO - Vendor: Intel (0x8086) 13:07:26 INFO - Device ID: 0x0a2e 13:07:26 INFO - Revision ID: 0x0009 13:07:26 INFO - Displays: 13:07:26 INFO - Display: 13:07:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:07:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:07:26 INFO - Display Serial Number: 1600x1200 60 13:07:26 INFO - Main Display: Yes 13:07:26 INFO - Mirror: Off 13:07:26 INFO - Online: Yes 13:07:26 INFO - Rotation: Supported 13:07:26 INFO - Return code: 0 13:07:26 INFO - Running post-action listener: _resource_record_post_action 13:07:26 INFO - Running post-run listener: _resource_record_post_run 13:07:27 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 679936; Write bytes: 693805056; Read time: 8; Write time: 2007 13:07:27 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 377569792; Write bytes: 372508672; Read time: 28242; Write time: 727 13:07:27 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 679936; Write bytes: 298366976; Read time: 8; Write time: 1232 13:07:27 INFO - Running post-run listener: _upload_blobber_files 13:07:27 INFO - Blob upload gear active. 13:07:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:07:27 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 13:07:27 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'] 13:07:27 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 13:07:27 INFO - (blobuploader) - INFO - Open directory for files ... 13:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:28 INFO - (blobuploader) - INFO - Done attempting. 13:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:29 INFO - (blobuploader) - INFO - Done attempting. 13:07:29 INFO - (blobuploader) - INFO - Iteration through files over. 13:07:29 INFO - Return code: 0 13:07:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:07:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:07:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b466db851925a670ef27d99c80a4792569567391b766266293f5c8680ea169a694b5292e8f371b9c79837c44abb7c91a9ae97de49460a1a06bc531be2b147671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0f133c2168e27f7196507d7f04d334a50f7127947e187ea8ab61c747ee642348b6d11204bedbe6eb015728f38867c64883fcec1536b203be8f019bc91eea4e8"} 13:07:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:07:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:07:29 INFO - Contents: 13:07:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b466db851925a670ef27d99c80a4792569567391b766266293f5c8680ea169a694b5292e8f371b9c79837c44abb7c91a9ae97de49460a1a06bc531be2b147671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0f133c2168e27f7196507d7f04d334a50f7127947e187ea8ab61c747ee642348b6d11204bedbe6eb015728f38867c64883fcec1536b203be8f019bc91eea4e8"} 13:07:29 INFO - Running post-run listener: copy_logs_to_upload_dir 13:07:29 INFO - Copying logs to upload dir... 13:07:29 INFO - mkdir: /builds/slave/test/build/upload/logs 13:07:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.743826 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-07 13:07:29.864832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 13:07:29.868265) ========= 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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b466db851925a670ef27d99c80a4792569567391b766266293f5c8680ea169a694b5292e8f371b9c79837c44abb7c91a9ae97de49460a1a06bc531be2b147671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0f133c2168e27f7196507d7f04d334a50f7127947e187ea8ab61c747ee642348b6d11204bedbe6eb015728f38867c64883fcec1536b203be8f019bc91eea4e8"} build_url:https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/FHolCg0VQZuCecp5j7Og6g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b466db851925a670ef27d99c80a4792569567391b766266293f5c8680ea169a694b5292e8f371b9c79837c44abb7c91a9ae97de49460a1a06bc531be2b147671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0f133c2168e27f7196507d7f04d334a50f7127947e187ea8ab61c747ee642348b6d11204bedbe6eb015728f38867c64883fcec1536b203be8f019bc91eea4e8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 13:07:29.895305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 13:07:29.895590) ========= 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.Xl1q8R9LVm/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.RCzI3dQ9jZ/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005366 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 13:07:29.944454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 13:07:29.944745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 13:07:29.945099) ========= ========= Total master_lag: 5.37 =========