builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0017 starttime: 1448071477.68 results: success (0) buildid: 20151120144638 builduid: b10eb016d3974000aaa3c480f91b874d revision: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.681581) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.682131) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.682538) ========= 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.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005253 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.704296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.704682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.720924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.721357) ========= 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.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.004778 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.769468) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.769767) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.770125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:37.770412) ========= 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.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 --2015-11-20 18:04:37-- 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% 1.62G=0s 2015-11-20 18:04:38 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.238657 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:38.024153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:38.024730) ========= 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.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.025930 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:38.074523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 18:04:38.074893) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 2015-11-20 18:04:38,157 truncating revision to first 12 chars 2015-11-20 18:04:38,157 Setting DEBUG logging. 2015-11-20 18:04:38,157 attempt 1/10 2015-11-20 18:04:38,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/809ef65b4a96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 18:04:39,335 unpacking tar archive at: fx-team-809ef65b4a96/testing/mozharness/ program finished with exit code 0 elapsedTime=1.419712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 18:04:39.511856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:39.512399) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:39.525268) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:39.527043) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 18:04:39.527759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-20 18:04:39.528236) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:04:39 INFO - MultiFileLogger online at 20151120 18:04:39 in /builds/slave/test 18:04:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:04:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:39 INFO - {'append_to_log': False, 18:04:39 INFO - 'base_work_dir': '/builds/slave/test', 18:04:39 INFO - 'blob_upload_branch': 'Fx-Team', 18:04:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:39 INFO - 'branch': 'Fx-Team', 18:04:39 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:39 INFO - 'config_files': ('talos/mac_config.py',), 18:04:39 INFO - 'default_actions': ('clobber', 18:04:39 INFO - 'read-buildbot-config', 18:04:39 INFO - 'download-and-extract', 18:04:39 INFO - 'populate-webroot', 18:04:39 INFO - 'create-virtualenv', 18:04:39 INFO - 'install', 18:04:39 INFO - 'run-tests'), 18:04:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:39 INFO - 'download_minidump_stackwalk': True, 18:04:39 INFO - 'download_symbols': 'ondemand', 18:04:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:39 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:39 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:39 INFO - 'installer_path': 'installer.exe', 18:04:39 INFO - 'log_level': 'info', 18:04:39 INFO - 'log_name': 'talos', 18:04:39 INFO - 'log_to_console': True, 18:04:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:04:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:04:39 INFO - 'opt_config_files': (), 18:04:39 INFO - 'pip_index': False, 18:04:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:39 INFO - 'cmd': ('bash', 18:04:39 INFO - '-c', 18:04:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:39 INFO - 'enabled': True, 18:04:39 INFO - 'halt_on_failure': False, 18:04:39 INFO - 'name': 'check_screen_resolution'},), 18:04:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:39 INFO - 'cmd': ('bash', 18:04:39 INFO - '-c', 18:04:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:39 INFO - 'enabled': True, 18:04:39 INFO - 'halt_on_failure': False, 18:04:39 INFO - 'name': 'check_screen_resolution'},), 18:04:39 INFO - 'run_cmd_checks_enabled': True, 18:04:39 INFO - 'sps_profile': False, 18:04:39 INFO - 'sps_profile_interval': 0, 18:04:39 INFO - 'suite': 'dromaeojs', 18:04:39 INFO - 'system_bits': '64', 18:04:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:39 INFO - 'title': 't-yosemite-r7-0017', 18:04:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:39 INFO - 'use_talos_json': True, 18:04:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:39 INFO - 'work_dir': 'build'} 18:04:39 INFO - ##### 18:04:39 INFO - ##### Running clobber step. 18:04:39 INFO - ##### 18:04:39 INFO - Running pre-action listener: _resource_record_pre_action 18:04:39 INFO - Running main action method: clobber 18:04:39 INFO - rmtree: /builds/slave/test/build 18:04:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:41 INFO - Running post-action listener: _resource_record_post_action 18:04:41 INFO - ##### 18:04:41 INFO - ##### Running read-buildbot-config step. 18:04:41 INFO - ##### 18:04:41 INFO - Running pre-action listener: _resource_record_pre_action 18:04:41 INFO - Running main action method: read_buildbot_config 18:04:41 INFO - Using buildbot properties: 18:04:41 INFO - { 18:04:41 INFO - "properties": { 18:04:41 INFO - "buildnumber": 13, 18:04:41 INFO - "product": "firefox", 18:04:41 INFO - "script_repo_revision": "production", 18:04:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:04:41 INFO - "repository": "", 18:04:41 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:04:41 INFO - "buildid": "20151120144638", 18:04:41 INFO - "slavename": "t-yosemite-r7-0017", 18:04:41 INFO - "pgo_build": "False", 18:04:41 INFO - "basedir": "/builds/slave/test", 18:04:41 INFO - "project": "", 18:04:41 INFO - "platform": "yosemite_r7", 18:04:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:04:41 INFO - "slavebuilddir": "test", 18:04:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:04:41 INFO - "branch": "fx-team", 18:04:41 INFO - "repo_path": "integration/fx-team", 18:04:41 INFO - "stage_platform": "macosx64", 18:04:41 INFO - "builduid": "b10eb016d3974000aaa3c480f91b874d", 18:04:41 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 18:04:41 INFO - }, 18:04:41 INFO - "sourcestamp": { 18:04:41 INFO - "repository": "", 18:04:41 INFO - "hasPatch": false, 18:04:41 INFO - "project": "", 18:04:41 INFO - "branch": "fx-team-macosx64-talos", 18:04:41 INFO - "changes": [ 18:04:41 INFO - { 18:04:41 INFO - "category": null, 18:04:41 INFO - "files": [ 18:04:41 INFO - { 18:04:41 INFO - "url": null, 18:04:41 INFO - "name": "https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:04:41 INFO - } 18:04:41 INFO - ], 18:04:41 INFO - "repository": "", 18:04:41 INFO - "rev": "809ef65b4a96cfb02ef3acfdb664fa03394a0195", 18:04:41 INFO - "who": "kwierso@gmail.com", 18:04:41 INFO - "when": 1448066221, 18:04:41 INFO - "number": 6691432, 18:04:41 INFO - "comments": "Merge m-c to fx-team, a=merge", 18:04:41 INFO - "project": "", 18:04:41 INFO - "at": "Fri 20 Nov 2015 16:37:01", 18:04:41 INFO - "branch": "fx-team-macosx64-talos", 18:04:41 INFO - "revlink": "", 18:04:41 INFO - "properties": [ 18:04:41 INFO - [ 18:04:41 INFO - "buildid", 18:04:41 INFO - "20151120144638", 18:04:41 INFO - "Change" 18:04:41 INFO - ], 18:04:41 INFO - [ 18:04:41 INFO - "builduid", 18:04:41 INFO - "b10eb016d3974000aaa3c480f91b874d", 18:04:41 INFO - "Change" 18:04:41 INFO - ], 18:04:41 INFO - [ 18:04:41 INFO - "pgo_build", 18:04:41 INFO - "False", 18:04:41 INFO - "Change" 18:04:41 INFO - ] 18:04:41 INFO - ], 18:04:41 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 18:04:41 INFO - } 18:04:41 INFO - ], 18:04:41 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 18:04:41 INFO - } 18:04:41 INFO - } 18:04:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:04:41 INFO - Running post-action listener: _resource_record_post_action 18:04:41 INFO - ##### 18:04:41 INFO - ##### Running download-and-extract step. 18:04:41 INFO - ##### 18:04:41 INFO - Running pre-action listener: _resource_record_pre_action 18:04:41 INFO - Running main action method: download_and_extract 18:04:41 INFO - mkdir: /builds/slave/test/build/tests 18:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:41 INFO - https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/test_packages.json 18:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/test_packages.json 18:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:04:42 INFO - Downloaded 1149 bytes. 18:04:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:04:42 INFO - Using the following test package requirements: 18:04:42 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:04:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:04:42 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:04:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:04:42 INFO - u'jsshell-mac.zip'], 18:04:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:04:42 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:04:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:04:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:04:42 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:04:42 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:04:42 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:04:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:04:42 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:04:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:04:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:04:42 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:04:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:42 INFO - https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:04:43 INFO - Downloaded 17525338 bytes. 18:04:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:04:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:04:46 INFO - Return code: 0 18:04:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:04:46 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')]} 18:04:46 INFO - https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:04:47 INFO - Downloaded 17525338 bytes. 18:04:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:04:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:04:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:04:50 INFO - Return code: 0 18:04:50 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')]} 18:04:50 INFO - https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:04:51 INFO - Downloaded 11130997 bytes. 18:04:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 18:04:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:04:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:04:51 INFO - Return code: 0 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:51 INFO - https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 18:04:54 INFO - Downloaded 109637247 bytes. 18:04:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:04:54 INFO - mkdir: /builds/slave/test/properties 18:04:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:04:54 INFO - Writing to file /builds/slave/test/properties/build_url 18:04:54 INFO - Contents: 18:04:54 INFO - build_url:https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:04:54 INFO - Running post-action listener: _resource_record_post_action 18:04:54 INFO - Running post-action listener: set_extra_try_arguments 18:04:54 INFO - ##### 18:04:54 INFO - ##### Running populate-webroot step. 18:04:54 INFO - ##### 18:04:54 INFO - Running pre-action listener: _resource_record_pre_action 18:04:54 INFO - Running main action method: populate_webroot 18:04:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:04:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:04:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:04:54 INFO - '../fennec_ids.txt'], 18:04:54 INFO - 'tests': ['tcheck2']}, 18:04:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:04:54 INFO - '--tppagecycles', 18:04:54 INFO - '7'], 18:04:54 INFO - 'tests': ['tsvgm']}}, 18:04:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:04:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:04:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:04:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:04:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'tests': ['damp', 'tps']}, 18:04:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['damp', 'tps']}, 18:04:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:04:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:04:54 INFO - 'other': {'tests': ['a11yr', 18:04:54 INFO - 'ts_paint', 18:04:54 INFO - 'tpaint', 18:04:54 INFO - 'sessionrestore', 18:04:54 INFO - 'sessionrestore_no_auto_restore']}, 18:04:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['a11yr', 18:04:54 INFO - 'ts_paint', 18:04:54 INFO - 'tpaint', 18:04:54 INFO - 'sessionrestore', 18:04:54 INFO - 'sessionrestore_no_auto_restore']}, 18:04:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['a11yr', 18:04:54 INFO - 'ts_paint', 18:04:54 INFO - 'tpaint', 18:04:54 INFO - 'sessionrestore', 18:04:54 INFO - 'sessionrestore_no_auto_restore']}, 18:04:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['a11yr', 18:04:54 INFO - 'ts_paint', 18:04:54 INFO - 'tpaint', 18:04:54 INFO - 'sessionrestore', 18:04:54 INFO - 'sessionrestore_no_auto_restore']}, 18:04:54 INFO - 'other_l64': {'tests': ['a11yr', 18:04:54 INFO - 'ts_paint', 18:04:54 INFO - 'tpaint', 18:04:54 INFO - 'sessionrestore', 18:04:54 INFO - 'sessionrestore_no_auto_restore']}, 18:04:54 INFO - 'other_nol64': {'tests': ['a11yr', 18:04:54 INFO - 'ts_paint', 18:04:54 INFO - 'tpaint', 18:04:54 INFO - 'sessionrestore', 18:04:54 INFO - 'sessionrestore_no_auto_restore']}, 18:04:54 INFO - 'svgr': {'tests': ['tsvgx', 18:04:54 INFO - 'tsvgr_opacity', 18:04:54 INFO - 'tart', 18:04:54 INFO - 'tscrollx', 18:04:54 INFO - 'cart']}, 18:04:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['tsvgx', 18:04:54 INFO - 'tsvgr_opacity', 18:04:54 INFO - 'tart', 18:04:54 INFO - 'tscrollx', 18:04:54 INFO - 'cart']}, 18:04:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'tests': ['tp5o']}, 18:04:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'talos_options': ['--e10s'], 18:04:54 INFO - 'tests': ['tp5o']}, 18:04:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'talos_options': ['--xperf_path', 18:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:54 INFO - 'tests': ['tp5n']}, 18:04:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:54 INFO - 'talos_options': ['--e10s', 18:04:54 INFO - '--xperf_path', 18:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:54 INFO - 'tests': ['tp5n']}}, 18:04:54 INFO - 'talos.zip': {'path': '', 18:04:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:04:54 INFO - Running post-action listener: _resource_record_post_action 18:04:54 INFO - ##### 18:04:54 INFO - ##### Running create-virtualenv step. 18:04:54 INFO - ##### 18:04:54 INFO - Running pre-action listener: _resource_record_pre_action 18:04:54 INFO - Running main action method: create_virtualenv 18:04:54 INFO - Creating virtualenv /builds/slave/test/build/venv 18:04:54 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 18:04:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:04:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:04:54 INFO - Using real prefix '/tools/python27' 18:04:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:04:55 INFO - Installing distribute.............................................................................................................................................................................................done. 18:04:58 INFO - Installing pip.................done. 18:04:58 INFO - Return code: 0 18:04:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1084af490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c7e0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, '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.JARae7Q2um/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.w5UbhgSwUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:04:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:04:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:58 INFO - 'HOME': '/Users/cltbld', 18:04:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:58 INFO - 'LOGNAME': 'cltbld', 18:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:58 INFO - 'MOZ_NO_REMOTE': '1', 18:04:58 INFO - 'NO_EM_RESTART': '1', 18:04:58 INFO - 'PAGER': '/bin/cat', 18:04:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:58 INFO - 'PWD': '/builds/slave/test', 18:04:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:58 INFO - 'SHELL': '/bin/bash', 18:04:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:04:58 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:04:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:58 INFO - 'USER': 'cltbld', 18:04:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:58 INFO - 'XPC_FLAGS': '0x0', 18:04:58 INFO - 'XPC_SERVICE_NAME': '0', 18:04:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:58 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 18:04:58 INFO - Cleaning up... 18:04:58 INFO - Return code: 0 18:04:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1084af490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c7e0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, '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.JARae7Q2um/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.w5UbhgSwUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:04:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:04:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:58 INFO - 'HOME': '/Users/cltbld', 18:04:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:58 INFO - 'LOGNAME': 'cltbld', 18:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:58 INFO - 'MOZ_NO_REMOTE': '1', 18:04:58 INFO - 'NO_EM_RESTART': '1', 18:04:58 INFO - 'PAGER': '/bin/cat', 18:04:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:58 INFO - 'PWD': '/builds/slave/test', 18:04:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:58 INFO - 'SHELL': '/bin/bash', 18:04:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:04:58 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:04:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:58 INFO - 'USER': 'cltbld', 18:04:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:58 INFO - 'XPC_FLAGS': '0x0', 18:04:58 INFO - 'XPC_SERVICE_NAME': '0', 18:04:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:58 INFO - Downloading/unpacking psutil>=0.7.1 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:05:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:05:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:05:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:01 INFO - Installing collected packages: psutil 18:05:01 INFO - Running setup.py install for psutil 18:05:01 INFO - building 'psutil._psutil_osx' extension 18:05:01 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 18:05:02 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 18:05:02 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 18:05:02 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 18:05:02 INFO - building 'psutil._psutil_posix' extension 18:05:02 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 18:05:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:05:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:05:02 INFO - ^ 18:05:02 INFO - 1 warning generated. 18:05:02 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 18:05:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:02 INFO - Successfully installed psutil 18:05:02 INFO - Cleaning up... 18:05:02 INFO - Return code: 0 18:05:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:05:02 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')]} 18:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:02 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')]} 18:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1084af490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c7e0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, '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.JARae7Q2um/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.w5UbhgSwUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:02 INFO - 'HOME': '/Users/cltbld', 18:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:02 INFO - 'LOGNAME': 'cltbld', 18:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:02 INFO - 'MOZ_NO_REMOTE': '1', 18:05:02 INFO - 'NO_EM_RESTART': '1', 18:05:02 INFO - 'PAGER': '/bin/cat', 18:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:02 INFO - 'PWD': '/builds/slave/test', 18:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:02 INFO - 'SHELL': '/bin/bash', 18:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:05:02 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:02 INFO - 'USER': 'cltbld', 18:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:02 INFO - 'XPC_FLAGS': '0x0', 18:05:02 INFO - 'XPC_SERVICE_NAME': '0', 18:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:05:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:05:05 INFO - Installing collected packages: mozsystemmonitor 18:05:05 INFO - Running setup.py install for mozsystemmonitor 18:05:05 INFO - Successfully installed mozsystemmonitor 18:05:05 INFO - Cleaning up... 18:05:05 INFO - Return code: 0 18:05:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1084af490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c7e0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, '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.JARae7Q2um/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.w5UbhgSwUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:05 INFO - 'HOME': '/Users/cltbld', 18:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:05 INFO - 'LOGNAME': 'cltbld', 18:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:05 INFO - 'MOZ_NO_REMOTE': '1', 18:05:05 INFO - 'NO_EM_RESTART': '1', 18:05:05 INFO - 'PAGER': '/bin/cat', 18:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:05 INFO - 'PWD': '/builds/slave/test', 18:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:05 INFO - 'SHELL': '/bin/bash', 18:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:05:05 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:05 INFO - 'USER': 'cltbld', 18:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:05 INFO - 'XPC_FLAGS': '0x0', 18:05:05 INFO - 'XPC_SERVICE_NAME': '0', 18:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:05 INFO - Downloading/unpacking blobuploader==1.2.4 18:05:05 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 18:05:05 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 18:05:05 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 18:05:05 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 18:05:05 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 18:05:05 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 18:05:07 INFO - Downloading blobuploader-1.2.4.tar.gz 18:05:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:05:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:05:07 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 18:05:07 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 18:05:07 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 18:05: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 18:05: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 18:05: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 18:05:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:05:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05:09 INFO - Downloading docopt-0.6.1.tar.gz 18:05:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:05:09 INFO - Installing collected packages: blobuploader, requests, docopt 18:05:09 INFO - Running setup.py install for blobuploader 18:05:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:05:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:05:09 INFO - Running setup.py install for requests 18:05:09 INFO - Running setup.py install for docopt 18:05:09 INFO - Successfully installed blobuploader requests docopt 18:05:09 INFO - Cleaning up... 18:05:10 INFO - Return code: 0 18:05:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:10 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')]} 18:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:10 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')]} 18:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1084af490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c7e0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, '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.JARae7Q2um/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.w5UbhgSwUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 18:05:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:05:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:10 INFO - 'HOME': '/Users/cltbld', 18:05:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:10 INFO - 'LOGNAME': 'cltbld', 18:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:10 INFO - 'MOZ_NO_REMOTE': '1', 18:05:10 INFO - 'NO_EM_RESTART': '1', 18:05:10 INFO - 'PAGER': '/bin/cat', 18:05:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:10 INFO - 'PWD': '/builds/slave/test', 18:05:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:10 INFO - 'SHELL': '/bin/bash', 18:05:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:05:10 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:05:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:10 INFO - 'USER': 'cltbld', 18:05:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:10 INFO - 'XPC_FLAGS': '0x0', 18:05:10 INFO - 'XPC_SERVICE_NAME': '0', 18:05:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:10 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-RgcAn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:10 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-XuGoRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:10 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-kiWDLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:10 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-RHbWm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:10 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ACsl1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:10 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-jKsdMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:10 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-jId1Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-I9jdQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-gYwdbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-HR20A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Adhlza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Tyk5sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-I8U2tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-_FOU1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-I0G1MC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-LAhEJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:11 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-dtoCkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:05:12 INFO - Running setup.py install for manifestparser 18:05:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Running setup.py install for mozcrash 18:05:12 INFO - Running setup.py install for mozdebug 18:05:12 INFO - Running setup.py install for mozdevice 18:05:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Running setup.py install for mozfile 18:05:12 INFO - Running setup.py install for mozhttpd 18:05:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Running setup.py install for mozinfo 18:05:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Running setup.py install for mozInstall 18:05:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Running setup.py install for mozleak 18:05:13 INFO - Running setup.py install for mozlog 18:05:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Running setup.py install for moznetwork 18:05:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Running setup.py install for mozprocess 18:05:13 INFO - Running setup.py install for mozprofile 18:05:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Running setup.py install for mozrunner 18:05:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:05:14 INFO - Running setup.py install for mozscreenshot 18:05:14 INFO - Running setup.py install for moztest 18:05:14 INFO - Running setup.py install for mozversion 18:05:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:05:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:05:14 INFO - Cleaning up... 18:05:14 INFO - Return code: 0 18:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1084af490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c7e0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, '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.JARae7Q2um/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.w5UbhgSwUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:14 INFO - 'HOME': '/Users/cltbld', 18:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:14 INFO - 'LOGNAME': 'cltbld', 18:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:14 INFO - 'MOZ_NO_REMOTE': '1', 18:05:14 INFO - 'NO_EM_RESTART': '1', 18:05:14 INFO - 'PAGER': '/bin/cat', 18:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:14 INFO - 'PWD': '/builds/slave/test', 18:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:14 INFO - 'SHELL': '/bin/bash', 18:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:05:14 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:14 INFO - 'USER': 'cltbld', 18:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:14 INFO - 'XPC_FLAGS': '0x0', 18:05:14 INFO - 'XPC_SERVICE_NAME': '0', 18:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:14 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-X6M3dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:14 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)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:14 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-k6RjAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-lvAP7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:15 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-XPul3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-r7WNQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:15 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-75nWmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:15 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-WzLZio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:15 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-LRrEBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:15 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-SPYCGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:15 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-yTK14n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-MlSwpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:16 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)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-HmMZga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:16 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)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-RilZiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-6zwCMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:16 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)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-njUN3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:16 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)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-i09eFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:16 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)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-7pKJY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:16 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)) 18:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:05:16 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)) 18:05:16 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:05:16 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:05:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:18 INFO - Downloading blessings-1.5.1.tar.gz 18:05:18 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:18 INFO - Installing collected packages: blessings 18:05:18 INFO - Running setup.py install for blessings 18:05:19 INFO - Successfully installed blessings 18:05:19 INFO - Cleaning up... 18:05:19 INFO - Return code: 0 18:05:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:19 INFO - Reading from file tmpfile_stdout 18:05:19 INFO - Current package versions: 18:05:19 INFO - blessings == 1.5.1 18:05:19 INFO - blobuploader == 1.2.4 18:05:19 INFO - docopt == 0.6.1 18:05:19 INFO - manifestparser == 1.1 18:05:19 INFO - mozInstall == 1.12 18:05:19 INFO - mozcrash == 0.16 18:05:19 INFO - mozdebug == 0.1 18:05:19 INFO - mozdevice == 0.47 18:05:19 INFO - mozfile == 1.2 18:05:19 INFO - mozhttpd == 0.7 18:05:19 INFO - mozinfo == 0.9 18:05:19 INFO - mozleak == 0.1 18:05:19 INFO - mozlog == 3.0 18:05:19 INFO - moznetwork == 0.27 18:05:19 INFO - mozprocess == 0.22 18:05:19 INFO - mozprofile == 0.27 18:05:19 INFO - mozrunner == 6.11 18:05:19 INFO - mozscreenshot == 0.1 18:05:19 INFO - mozsystemmonitor == 0.0 18:05:19 INFO - moztest == 0.7 18:05:19 INFO - mozversion == 1.4 18:05:19 INFO - psutil == 3.1.1 18:05:19 INFO - requests == 1.2.3 18:05:19 INFO - wsgiref == 0.1.2 18:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:19 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')]} 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 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')]} 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1084af490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c7e0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, '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.JARae7Q2um/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.w5UbhgSwUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 18:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:19 INFO - 'HOME': '/Users/cltbld', 18:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:19 INFO - 'LOGNAME': 'cltbld', 18:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:19 INFO - 'MOZ_NO_REMOTE': '1', 18:05:19 INFO - 'NO_EM_RESTART': '1', 18:05:19 INFO - 'PAGER': '/bin/cat', 18:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:19 INFO - 'PWD': '/builds/slave/test', 18:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:19 INFO - 'SHELL': '/bin/bash', 18:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:05:19 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:19 INFO - 'USER': 'cltbld', 18:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:19 INFO - 'XPC_FLAGS': '0x0', 18:05:19 INFO - 'XPC_SERVICE_NAME': '0', 18:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:19 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 1)) 18:05:19 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 2)) 18:05:19 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 3)) 18:05:19 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 4)) 18:05:19 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 5)) 18:05:19 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 6)) 18:05:19 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 7)) 18:05:19 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 8)) 18:05:19 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:05:19 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 3)) 18:05:19 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:05:19 INFO - Cleaning up... 18:05:19 INFO - Return code: 0 18:05:19 INFO - Running post-action listener: _resource_record_post_action 18:05:19 INFO - Running post-action listener: _start_resource_monitoring 18:05:19 INFO - Starting resource monitoring. 18:05:19 INFO - ##### 18:05:19 INFO - ##### Running install step. 18:05:19 INFO - ##### 18:05:19 INFO - Running pre-action listener: _resource_record_pre_action 18:05:19 INFO - Running main action method: install 18:05:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:19 INFO - Reading from file tmpfile_stdout 18:05:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:05:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:05:20 INFO - Reading from file tmpfile_stdout 18:05:20 INFO - Output received: 18:05:20 INFO - Usage: mozinstall [options] installer 18:05:20 INFO - Options: 18:05:20 INFO - -h, --help show this help message and exit 18:05:20 INFO - -d DEST, --destination=DEST 18:05:20 INFO - Directory to install application into. [default: 18:05:20 INFO - "/builds/slave/test"] 18:05:20 INFO - --app=APP Application being installed. [default: firefox] 18:05:20 INFO - mkdir: /builds/slave/test/build/application 18:05:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:05:50 INFO - Reading from file tmpfile_stdout 18:05:50 INFO - Output received: 18:05:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:05:50 INFO - Running post-action listener: _resource_record_post_action 18:05:50 INFO - ##### 18:05:50 INFO - ##### Running run-tests step. 18:05:50 INFO - ##### 18:05:50 INFO - Running pre-action listener: _resource_record_pre_action 18:05:50 INFO - Running main action method: run_tests 18:05:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:05:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:05:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:05:50 INFO - 2015-11-20 18:05:50.650 screenresolution[1648:7702] starting screenresolution argv=screenresolution get 18:05:50 INFO - 2015-11-20 18:05:50.653 screenresolution[1648:7702] Display 0: 1600x1200x32@50 18:05:50 INFO - 2015-11-20 18:05:50.659 screenresolution[1649:7704] starting screenresolution argv=screenresolution list 18:05:50 INFO - Available Modes on Display 0 18:05:50 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 18:05:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:05:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:05:50 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 18:05:50 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 18:05:50 INFO - Graphics/Displays: 18:05:50 INFO - Intel Iris: 18:05:50 INFO - Chipset Model: Intel Iris 18:05:50 INFO - Type: GPU 18:05:50 INFO - Bus: Built-In 18:05:50 INFO - VRAM (Dynamic, Max): 1536 MB 18:05:50 INFO - Vendor: Intel (0x8086) 18:05:50 INFO - Device ID: 0x0a2e 18:05:50 INFO - Revision ID: 0x0009 18:05:50 INFO - Displays: 18:05:50 INFO - Display: 18:05:50 INFO - Resolution: 1600 x 1200 @ 50 Hz 18:05:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:05:50 INFO - Display Serial Number: 1600x1200 50 18:05:50 INFO - Main Display: Yes 18:05:50 INFO - Mirror: Off 18:05:50 INFO - Online: Yes 18:05:50 INFO - Rotation: Supported 18:05:50 INFO - Return code: 0 18:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:05:50 INFO - Python 2.7.3 18:05:50 INFO - Return code: 0 18:05:50 INFO - grabbing minidump binary from tooltool 18:05:50 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')]} 18:05:50 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 0x1083d39f0>, '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 0x108132db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:05:50 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 18:05:50 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 18:05:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:05:50 INFO - Return code: 0 18:05:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:05:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:05:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:05:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:05:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost'] in /builds/slave/test/build 18:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0017 --webServer localhost 18:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JARae7Q2um/Render', 18:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:50 INFO - 'HOME': '/Users/cltbld', 18:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:50 INFO - 'LOGNAME': 'cltbld', 18:05:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:50 INFO - 'MOZ_NO_REMOTE': '1', 18:05:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:50 INFO - 'NO_EM_RESTART': '1', 18:05:50 INFO - 'PAGER': '/bin/cat', 18:05:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:50 INFO - 'PWD': '/builds/slave/test', 18:05:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:50 INFO - 'SHELL': '/bin/bash', 18:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w5UbhgSwUY/Listeners', 18:05:50 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 18:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:50 INFO - 'USER': 'cltbld', 18:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:50 INFO - 'XPC_FLAGS': '0x0', 18:05:50 INFO - 'XPC_SERVICE_NAME': '0', 18:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost'] with output_timeout 3600 18:05:51 INFO - mozversion INFO | application_buildid: 20151120144638 18:05:51 INFO - mozversion INFO | application_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 18:05:51 INFO - mozversion INFO | application_display_name: Nightly 18:05:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:05:51 INFO - mozversion INFO | application_name: Firefox 18:05:51 INFO - mozversion INFO | application_remotingname: firefox 18:05:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:05:51 INFO - mozversion INFO | application_vendor: Mozilla 18:05:51 INFO - mozversion INFO | application_version: 45.0a1 18:05:51 INFO - mozversion INFO | platform_buildid: 20151120144638 18:05:51 INFO - mozversion INFO | platform_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 18:05:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:05:51 INFO - mozversion INFO | platform_version: 45.0a1 18:05:51 INFO - 2015-11-20 18:05:51,205 DEBUG : using testdate: 1448071551 18:05:51 INFO - 2015-11-20 18:05:51,205 DEBUG : actual date: 1448071551 18:05:51 INFO - 2015-11-20 18:05:51,550 INFO : starting webserver on 'localhost:49268' 18:05:51 INFO - 2015-11-20 18:05:51,551 INFO : Starting test suite t-yosemite-r7-0017 18:05:51 INFO - 2015-11-20 18:05:51,551 INFO : Starting test dromaeo_css 18:05:51 INFO - 2015-11-20 18:05:51,551 DEBUG : operating with platform_type : mac_ 18:05:51 INFO - 2015-11-20 18:05:51,552 INFO : Initialising browser for dromaeo_css test... 18:05:51 INFO - 2015-11-20 18:05:51,565 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmphA1uFV/profile http://localhost:49268/getInfo.html 18:05:53 INFO - 2015-11-20 18:05:53,844 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:05:53 INFO - 2015-11-20 18:05:53,844 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:05:53 INFO - 2015-11-20 18:05:53,844 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:05:53 INFO - 2015-11-20 18:05:53,844 DEBUG : BROWSER_OUTPUT: __metrics 18:05:53 INFO - 2015-11-20 18:05:53,860 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:05:54 INFO - 2015-11-20 18:05:54,485 INFO : Browser initialized. 18:05:54 INFO - 2015-11-20 18:05:54,485 INFO : Running cycle 1/1 for dromaeo_css test... 18:05:54 INFO - 2015-11-20 18:05:54,485 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmphA1uFV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:06:06 INFO - 2015-11-20 18:06:06,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 226123776 18:06:06 INFO - 2015-11-20 18:06:06,353 DEBUG : BROWSER_OUTPUT: 18:06:57 INFO - 2015-11-20 18:06:57,453 DEBUG : BROWSER_OUTPUT: 1448071617453 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] 18:09:09 INFO - 2015-11-20 18:09:09,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 18:09:10 INFO - 2015-11-20 18:09:10,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 362467328 18:09:10 INFO - 2015-11-20 18:09:10,702 DEBUG : BROWSER_OUTPUT: 18:12:13 INFO - 2015-11-20 18:12:13,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 18:12:13 INFO - 2015-11-20 18:12:13,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 359186432 18:12:13 INFO - 2015-11-20 18:12:13,894 DEBUG : BROWSER_OUTPUT: 18:15:15 INFO - 2015-11-20 18:15:15,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 18:15:16 INFO - 2015-11-20 18:15:16,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 336261120 18:15:16 INFO - 2015-11-20 18:15:16,519 DEBUG : BROWSER_OUTPUT: 18:18:18 INFO - 2015-11-20 18:18:18,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 18:18:19 INFO - 2015-11-20 18:18:19,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 324575232 18:18:19 INFO - 2015-11-20 18:18:19,063 DEBUG : BROWSER_OUTPUT: 18:21:21 INFO - 2015-11-20 18:21:21,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 18:21:22 INFO - 2015-11-20 18:21:22,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 321044480 18:21:22 INFO - 2015-11-20 18:21:22,551 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 18:24:25 INFO - 2015-11-20 18:24:25,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 378564608 18:24:25 INFO - 2015-11-20 18:24:25,360 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,361 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:24:25 INFO - 2015-11-20 18:24:25,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:24:25 INFO - 2015-11-20 18:24:25,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:24:25 INFO - 2015-11-20 18:24:25,361 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:24:25 INFO - 2015-11-20 18:24:25,362 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3363.9663603363965;3441.7590768646205;3477.6348483409247;3556.8577256909707;3594.209273959728;5575.414581468938;5702.54379649628;6049.969750151254;6066.120412540185;6077.756889724411;5902.88194236115;5975.402459754023;6013.398660133985;6054.697265136748;6055.485283750875;5283.735813209334;5329.25390445338;5375.199044585991;5375.731213439332;5527.50252477277;5426.430224826396;5519.337679478468;5527.060399732055;5551.8889622207535;5558.138488534263;4617.861464156081;5490.780368785244;5593.440655934414;5632.549396048326;5641.915371269434;5284.6564973277;5402.810901618424;5413.431589683105;5415.783368665248;5417.187421886709;5270.8155214567305;5307.336582927134;5315.946840531584;5328.387235467932;5333.333333333333;5865.677387743673;5873;5880.353161152269;5902.852428689317;5908.822735317947;6283.151774510428;6290.308066112724;6300.3384644612115;6305.085762564402;6314.052892066181;6335.3981371769605;6357.904631430532;6382.170317858649;6415.5829871058695;6426.871462570769;6178.66017369049;6195.16365290689;6196.47329976948;6227.439530442282;6229.813105606839;5720.313562372458;5786.94213057864;6561.442277406379;6645.102911106938;6645.202575690948;6187.783427580103;6196.00863861789;6308.27454842699;6312.715927783261;6314.873702525923;6454.515911306671;6455.7417703292285;6466.741330346827;6471.385218404244;6473.320301368382;6322.241331040304;6326.114343991845;6338.397852204033;6355.3326900674765;6360.427561519486;5585.916211256835;6023.608465449732;6214.782482613087;6219.875602487925;6365.3316401778075;4337.262665346899;5061.468545802712;5076.568491678248;5091.974540127276;5097.286379906816;4561.429821272341;4605.838795642137;4638.165130276515;4642.117997580449;4649.95350046502;6065.272167339859;6118.60229085108;6121;6132.601380910227;6145.84635384119;6252.656103914328;6376.904346434807;6385.776497822647;6392.680365981682;6478.352164783578;6061.818145455643;6064.36324185963;6074.635521868702;6078.3921607838865;6080.726367313481;5607.859803504945;5614.887702246014;5618.410066942994;5618.747156377973;5620.690862002629;6184.8763024738355;6242.906356404657;6308.432241098323;6339.397757213057;6339.96830015847;5334.306540149756;6367.363263673596;6368.299487056513;6402.6158430494315;6406.359364063743;6406.167198264196;6445.162128923397;6455.2576453708425;6462.903056454063;6469.159009328757;6138.478229350555;6384.6169229846355;6397.584157029778;6406.935930640634;6409.615423074631;6305.96847015762;6353.428191462791;6365.172527571386;6488.513361497812;6500.739970401131;5050.49495050492;6249.312575616769;6266.905996410149;6278.560500764903;6464.804011257932;6125.296497837281;6136.926037943253;6247.969085100907;6248.4376406123665;6254.8123556293385;6100.369238099132;6179.351168127461;6192.442680158807;6217.875642487215;6247.468965138014;6251.906221406592;6258.749650013949;6264.123022776906;6271.62370257786;6299.716512756845;6093.238345206849;6287.74849006053;6293.244810622755;6299.559030867796;6301.558890877594 18:24:25 INFO - 2015-11-20 18:24:25,366 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.4318411143653;583.9094940284252;604.3473049106964;616.9049936362958;628.9308176100628;28465;41196;41545.79227103868;41615.79192104043;41869.27849689768;41214.55749048784;43928.56071439285;43969.34045989313;44202;44391.112177756426;8694.739157825245;8842.5136617486;9138.268938484922;9911.207103431709;9917.404955702681;8695.652173913037;12049.939750301237;12094.758104837898;12096.93951530241;12118.636440906786;11704;11798.58704945327;11799.233049851731;11806.527738890478;11899;8882.689105881327;9009.729708108767;11793.469293881753;11885.881141188607;11901.583444579484;8740.8688869667;8853.867191992125;8859.468431894107;11653.242539235007;11840.171188016842;39108.82673519799;39423.802880985415;39449.60550394488;39472.802635986925;39532.60467395318;3470.444728843398;3666.5050218220467;3668.523091998023;3736.196717705679;4132.91734165318;28579.857100714573;28816.135515934347;28978.710212898022;29196.70803291961;29508;2723.360010397555;2758.889644414221;2775.9444811103663;2777.1529683446543;2795.2872017635577;485290.6180320162;487065;487757;488408;488682;64995.67502162554;65398;65415.34584654093;65446;65526.67236663786;70093.64953175304;70334.64832675803;70434.2956570438;70619.64690176517;70629.2937070633;16375.672486550202;16931.492055238363;16967.49097527076;16968.321267149422;16983.150842457828;12772.297523636104;12851.293178875065;12851.357432128543;12869;12885.96912247018;19823.702644460343;19826.206951721768;20309.492262693257;20353.389398318075;20396.694049589267;8634.78413039679;8681.741147533572;8708.521031343336;8709.259712924346;8723.476591404537;953.8998405167496;979.9906096720389;1042.3224903812581;1045.5451878432755;1143.302196238585;30174;30187.396252075276;30226.24434389158;30467.205750224708;30657.386852263277;856.4005196362571;950.8716323296405;1037.444966942682;1064.2762921213648;1074.2856000759407;14245.572632821031;14272.714545709028;14485.710285794225;14550.563483095524;14588.781168282485;419308.90345548076;424678;425022;425746;425999.66003059875;53366;53387;53654.92690146175;53685.46314536805;53920.921581568145;1429.9142051476945;1442.08427648444;1450.245872146478;1456.739919969219;1457.4243173946443;28002.719972800012;28319.43361132807;28576.27169344694;28660.713392866637;28680.996165134122;50277;50357.49642503675;50563;50612.98774024425;50661.74669126631;508829;513781;513999;514058;514079;28038.018669346475;28306.2923426916;28405.43189136247;30902;31314.686853131177;40723;43134;43306.35040474332;43786;44649.33026004677;36157.638423615426;36206.637933620324;37052.44421333628;37241.0689732748;37311.2537749238;35866.82066589651;36330.63669363378;36576;36696.63303366932;36700.81649591735;31281;31772.682273177896;37030.8148459256;37144.88565343044;37982.81008594939;29977.400451991274;32377.67622323841;32493.025209243762;32556.51165232571;32603.836980814944;24184.188183589013;25224;25303.74696253014;25897;25953.610695839954 18:24:25 INFO - 2015-11-20 18:24:25,366 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.81728227245236;363.8599139331358;367.6893025393542;369.2891184469895;369.64144779563816;14562.635934101627;15747.212639368043;20035.59928801423;21071.47321316966;21771.346859594236;12094.758104837898;12153.027757779379;12184.964278036356;14641.780373294408;17288.740668889975;3959.0894094358314;5038.697678139305;5191.688498690071;5204.843854684346;5213.687178769286;4049.392591111342;4075.6331930126285;5717.228174196472;5899.587028907957;5912.5861189716525;5801.970990145043;5830.591858569902;5861.0915308127305;5882.529397648199;6386.521010924176;6399.328070552595;6436.485081193493;6441.42027217548;6448.161738973903;6448.580842245263;5487.149491828733;5611.102223644198;5660.3490598581275;5660.716964151776;5661.207430959669;25184.622230666555;25363.746362536323;25589.48821023588;25777;25871.482570348675;2003.7395138631884;2049.0164720933885;2193.309107631091;2361.374235827507;2427.757224277576;10256.435896025716;10688.198385121146;10839.783204335949;13895.207350384902;14983.700325993528;1660.7259802132633;1695.8812883098187;1724.129314696083;1734.5316764473648;1794.8564114870778;98059;104618;105384.47307763489;105696.94303056948;108100.56843463024;10855.837162442569;11013.2841365311;11062.889371106186;11090.130290893641;11225.270357426742;13028.153170044106;13055.543055992996;13061.085723999418;13089;13098.083134180515;8462.534560599226;8470.32237421017;8487.533185674723;8501.107383724744;8538.786530336667;8600.397972142015;8600.8709869352;8605.26855217301;8686.652533898574;8705.47767133974;3985.0834308109297;4340.739555626673;4352.107817897323;4407.625351845129;4411.492678341968;1570.3012159588873;1755.4821327708357;1775.6892543804784;1792.6325103353781;1819.3814103204709;397.75339289640607;902.2601466797295;902.6389444222232;974.3277138774223;980.7253968888723;10229.43738094412;11567;11708.473118709679;11723.941380293043;11954.880451195551;426.889008857693;429.7979949423766;431.9784010799447;437.61489888898205;457.2227213736661;5762.683052432073;6190.566660333823;6230.408111229426;6233.065040244;11216.607418740305;757690;773387;773554;775591;786847;109104;114251.42874285576;116786.41606791911;119415;119815.40092299483;1184.9822252666218;1212.9878701213051;1230.0528592983353;1236.567201479475;1241.7081985733346;18401;18401.631967360845;18562.907185463988;19081.713774293676;19135.330263440712;51293.743531283595;52189.47810521998;52273.7386313066;52490.475095248556;53083.469165307855;68687;68856;69298.65350673214;69960;70326.64836675784;8454.577271136295;9803.852942205729;9883.950580247052;10025.849612255675;10038.698839034842;11789.233699809485;12086.214396064228;16214.35142594283;20217.2923947667;20605.793942060387;14969.101853888802;15934.68130637404;16018.599535011717;16312.592185195464;16514.42199523011;15204.543863684106;15459.304331304893;15491.147986860831;15498.147601882005;16552.089635070188;12446.43991020388;15311.540653780405;15992.520224393287;16296.42962496307;16672.749543784023;9540.618375264912;9652.710418687451;9785.951070244602;9943.552540135566;9944.801103978025;9822.950885245527;12347.333110030031;14042.438302468196;15907.284172212047;15997 18:24:25 INFO - 2015-11-20 18:24:25,369 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.4320150339115;1567.0441030971106;1572.9056256624604;1897.3738666240138;1915.205189846214;7559.58422286774;7976.720814771485;7976.720814771485;8465.91534084659;8626.827463450727;8339.54132522711;8476.957615211932;8506.787330316745;8521.020082690493;8534.87197692035;2148.742150941889;2367.810575153992;2387.164492427645;2388.295452841416;2392.497575509145;2192.5286063496346;2196.7144271244715;2197.3517812245427;2371.6561098640686;2419.661247425353;2368.3960590049514;2369.2418426103654;2374.157174203159;2376.3227480168157;2376.8098552115875;2302.0906741836966;2365.207655435431;2367.5028244068767;2368.7039120109985;2371.5968285391523;2136.9145234190614;2189.321310393767;2189.4745261137373;2342.227065068523;2389.7968672662846;7297.45269104814;8294.958525207396;8449.957750211272;8462.4076314658;8470.110638383005;5058.140116180258;5117;5119.206522988943;5123.948760512384;5144.717040562768;3441.896743097686;3517.771344862576;3563.893083207508;3574.070741607175;3584.318979393907;992.925530585209;995.4873240281261;1014.3609525998647;1028.686250693538;1030.7680771826354;11193.66419007431;11207.887921120766;11209.215354925158;11209.551617935354;11222.102231821435;4283.464566929134;4558.680892337571;4746.905061898812;4747.169245382044;4748.762561871893;9709.757256068655;9712.17446517054;9723.805523889483;9730.513474326255;9733.075357840993;5186.273921650972;5202.985417843484;5205.375354957429;5246.134387826042;5259.947400525945;4726.480087190406;4736.692115012514;4743.928841067387;4781.713097214179;4782.426108866958;3446.9831399737136;3788;3822.48396466479;3830.7893065881085;3870.6129387061633;1103.332483847277;1107.3466654673782;1213.1923434083153;1294.643972907458;1297.9545715900088;1053.3627155570769;1059.586761163147;1060.0406631998055;1241.9815751084025;1357.9524716634871;7866.370690344873;7912.683492660229;7923.841523169504;7984.121746607869;7992.880106798402;496.97266650333853;511.0366958283662;513.9871503212374;515.644205498205;515.7498613172609;5834.504067154255;5978.940210597925;6094.116353128771;6175.073738939195;6180.6291622502795;8583.785405364915;8635.654573817103;8639.611217495229;8654.913450865537;9009.459432434074;9964.302498825158;9999.050090241415;10269.332493387907;10271.178305735522;10287.485625718684;7840.764777056697;7942;7960.960195198987;8040.316573091236;8061.596920154087;7763.844723105393;7802.336801371947;7803.063632364153;7879.448438609243;7880.093789214085;8881.111888811325;9096.1813436791;9136.360454768102;9214.769630759285;9214.907850921405;8181.813637022718;8384.161583841567;9398.34211605181;9479.763005924908;9558.28312876551;7293.270672932665;7331.523450975669;7349.448791340564;7399.18608953004;7404.851902962018;7978.760637180894;8039.638216280398;8044.195580442143;8047.1550487198;8050.27547520726;7389.224131466333;7486.8876966844455;7513.4740568159705;7630.694772209272;7634.694612215671;7465.58939258346;7473.40212782987;7515.511491753237;7516.24837516244;7561.584112873845;7515.286047825448;7560.8487830244185;7564.583947882919;7571.583562904093;7604.049493813273;6798.694058767268;6812;6879.449644028566;6880.724771009303;6896.827579310357;7011.859762804614;7084.36240738336;7085.787426377217;7086.043384143075;7091.539049961736 18:24:25 INFO - 2015-11-20 18:24:25,370 DEBUG : BROWSER_OUTPUT: |4;prototype.html;263.71255331688457;326.4091993491779;328.29416753978944;331.4547569248586;338.33854813838946;6473.643949582777;6694.230163531195;6765.221999470063;6767.120274364332;6793.116894803675;5216.8695782605455;6610.206775186973;6621.073049773036;6642.236142843574;6646.833829154273;4641.25739881619;4769.236922092466;4820.349252850855;4878.341423907771;4907.852764417074;4765.737884416356;4809.374781278429;4859.125357435661;4873.293372460991;4929.162042452774;4795.424549054101;4795.760211989386;4805.8558243252755;4810.855674329776;4821.276808478721;3709.758865673736;4672.929906051412;4709.458412282597;4744.383230180089;4789.80840766369;4041.373587094005;4057.6145266199665;4082.2856000200145;4099.733517321394;4109.589041095896;6141.416565426277;6213.906791398133;6237;6250.281217659936;6253.405926436982;5498.780048798043;5633.492985631313;5650.0959846424375;5656.123300888369;5660.716964151776;6971.163460384735;7007.334303241184;7008.26413226614;7023.157221133446;7045.189803172599;4565.794539245742;4570.817167313304;4574.176648203322;4575.725456472623;4577.450705915311;6629.635370054645;6780.186377634715;7317.743878964211;7431.996680448125;7438.442116841205;4472.798724057425;4622.306654001926;4623.676342655982;4639.280911458729;4641.976790116028;4708.788104535304;4713.717176969393;4721.220998535203;4729.337892695025;4729.71621702692;5601.5238704710555;5604.019296623156;5618.381977982419;5627.240322556402;5628.577856660767;6846.486513511507;7067.929320706727;7069.010338552606;7080.716771329089;7116.750913717995;1618.902865828054;1637.525117715873;1642.1624971264741;1645.2020769926576;1652.6612044531082;1037.5849660136007;1042.1766804224728;1045.0907710292095;1046.3094357723867;1066.8559744434558;6475.967620161869;6494.1557597512965;6525.967370163119;6527.118838956775;6547.738090476328;7230.566166030055;7235.819104522324;7236.529625574426;7248.818779530448;7266.418686505067;6351.809445716543;6499.09012738217;6510.73957041713;6519.771807986698;6527.15147030883;3711.46183803347;3785.5268091488565;3795.4686343911876;3801.7148713846573;3882.2623701496627;7371.852562948711;7381.446391520657;7406.777796666109;7410.888836667455;7412;7389.445791565654;7573.318401343906;7613.809654758565;7618.009658744439;7627.961860190663;7393.519421237603;7416.258374162649;7418.221086785918;7420.146683131509;7424.071991001125;7322.63386830667;7324.4140468763435;7324.487285889936;7333.413326933939;7339.1926888043345;7056.717731290691;7217.7473788417155;7227.566346019255;7233.348998590152;7246.818829529304;7458.627068646654;7482.363999059923;7485;7488.101427828696;7490.250974902466;4114.670826333946;4456.665750068693;4609.585137337655;4657.394538709946;4669.719816811003;7181.389581885598;7380.261973802577;7389.334959853639;7413.703451862081;7471.738489152854;5800.24596802413;7069.540479868792;7126.928730712627;7136.536125151849;7138.357547820721;7089.361957423856;7105.32499412555;7106;7117.572945623279;7119.6084215368655;6685.832854178684;6923.5499692519825;6933.0293758874805;6943.340382663639;6946.583205007716;7119.893201601876;7122.608256545733;7138.571685698875;7141.714331426685;7146.821329466597;6666.899996500153;6816.863662726817;6950.443964482931;6952.617606031717;6959.060526828814 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: |5;yui.html;749.2844333661353;749.5952185819658;802.3941923847494;828.0560161415985;845.1759534453904;14974.700505989873;15387.69224615507;15426.305816238268;15441.613959651;15444.150571718552;11783.116266280042;14051.367688454018;14158.929205353985;14194.645133871658;14283.857161428383;741.1587847792754;757.8029712274794;759.2597217712741;759.4190444310108;936.3398803843309;944.3436811416069;946.4936259101382;960.5437417226831;961.6057416459253;962.6438217859402;1000.3597697473623;1012.2610494339137;1014.4268488304122;1016.8423894296359;1018.1345856022359;776.1423626892288;783.3380793229712;784.5880912520944;986.1026465916053;1000.7948370584013;747.4468893019126;747.6299231880254;749.741339237962;750.8535835512077;753.2994315286782;14831.703365932728;15070.397184112622;15079.54761357161;15086.471973480986;15087.321070551852;12283.324417157142;12338.321392323418;12737.617871463779;12955.611331660066;13166.670833229151;10169.54237059334;10232.488375581192;10243.334183278062;10248.692539223835;10261.640842570474;3504.229069604683;3521.2605352875926;3541.2386336937425;3541.8937431876825;3549.3078849624335;73696;74351.62824185898;74352.25647743561;75113;82379;9451.684337337396;9459.337846350827;9464.668736594185;9485.288603354638;9509.191718703987;21201.78798212029;21353;21409.67885481719;21441.46396340104;21479.570408591742;7259.165196002422;7348.63256837156;7522.962385188149;7557.886631700529;7657.1959944205055;3886.028492876781;3901.551321597996;4000.8399664013696;4026.375911733686;4120.423140760296;3582.1223800169128;3628.909277268089;3632.0919770057485;3636.890893273206;3643.9635603644156;621.5369549685513;631.2298995225817;633.2780630081711;655.017473789316;655.9114519539896;482.312704396234;491.6263639633904;495.89090400111917;509.05570167339795;529.9083887192396;8310.750677479686;8312.750617481484;8467.093704428144;8594.766193055782;8701.390902636755;502.6632156455184;511.2790964739699;521.5254118751917;566.9256758442727;572.8596493859031;3891.3968334908136;3932.4297976793778;4017.055991841915;4071.9389209161886;4119.464469618931;92356.07643923609;101809.49095254624;103678.48160759298;103784;103831;54596;77608.05979850549;77711;78209;80572.19427805647;69888;72735.99999999894;72753.6362318185;75167;75487.62256188794;7697.88453173214;8332.666693332441;8635.525046122524;8672.913270867462;8681.305495560213;39345.01637458972;46221;48659.51340486691;50738.49261507485;50973.74513127559;69576.30423695901;70726;72127.63936180285;72237.27762722305;72660.63669681617;10864.945675271572;11043.558257669603;11083.944580277048;11220.102391808472;11613.825792613286;11905.404729763304;12025.158238923541;12358.320292384005;12616.306103164414;12788.744225115632;11148.944255278671;11242.66272011841;11276;11600.361980091177;11875.228110172811;11334.841066679724;11395.202335836411;11397.941170636928;11591.362475063952;12055.276683399024;9556.331056825955;10821.134309255398;11243.718907027063;11540.596079137189;12188.75622487563;9594.232461402931;9761.511924403609;9823.803523929624;9961.252906032221;10171.491425428847;8882.86675699878;8920.330975177018;9097.77255568616;9727.367721098106;9744.951275243578 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1100 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: __startTimestamp1448072665360__endTimestamp 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:24:25 INFO - 2015-11-20 18:24:25,374 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:24:25 INFO - 2015-11-20 18:24:25,375 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,375 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5907.09 Median:6179.35 stddev:650.20 (10.5%) stddev-sans-first:620.83 18:24:25 INFO - 2015-11-20 18:24:25,375 DEBUG : BROWSER_OUTPUT: Values: 3364.0 3441.8 3477.6 3556.9 3594.2 5575.4 5702.5 6050.0 6066.1 6077.8 5902.9 5975.4 6013.4 6054.7 6055.5 5283.7 5329.3 5375.2 5375.7 5527.5 5426.4 5519.3 5527.1 5551.9 5558.1 4617.9 5490.8 5593.4 5632.5 5641.9 5284.7 5402.8 5413.4 5415.8 5417.2 5270.8 5307.3 5315.9 5328.4 5333.3 5865.7 5873.0 5880.4 5902.9 5908.8 6283.2 6290.3 6300.3 6305.1 6314.1 6335.4 6357.9 6382.2 6415.6 6426.9 6178.7 6195.2 6196.5 6227.4 6229.8 5720.3 5786.9 6561.4 6645.1 6645.2 6187.8 6196.0 6308.3 6312.7 6314.9 6454.5 6455.7 6466.7 6471.4 6473.3 6322.2 6326.1 6338.4 6355.3 6360.4 5585.9 6023.6 6214.8 6219.9 6365.3 4337.3 5061.5 5076.6 5092.0 5097.3 4561.4 4605.8 4638.2 4642.1 4650.0 6065.3 6118.6 6121.0 6132.6 6145.8 6252.7 6376.9 6385.8 6392.7 6478.4 6061.8 6064.4 6074.6 6078.4 6080.7 5607.9 5614.9 5618.4 5618.7 5620.7 6184.9 6242.9 6308.4 6339.4 6340.0 5334.3 6367.4 6368.3 6402.6 6406.4 6406.2 6445.2 6455.3 6462.9 6469.2 6138.5 6384.6 6397.6 6406.9 6409.6 6306.0 6353.4 6365.2 6488.5 6500.7 5050.5 6249.3 6266.9 6278.6 6464.8 6125.3 6136.9 6248.0 6248.4 6254.8 6100.4 6179.4 6192.4 6217.9 6247.5 6251.9 6258.7 6264.1 6271.6 6299.7 6093.2 6287.7 6293.2 6299.6 6301.6 18:24:25 INFO - 2015-11-20 18:24:25,375 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,375 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62470.05 Median:20182.58 stddev:126448.24 (626.5%) stddev-sans-first:126717.47 18:24:25 INFO - 2015-11-20 18:24:25,376 DEBUG : BROWSER_OUTPUT: Values: 541.4 583.9 604.3 616.9 628.9 28465.0 41196.0 41545.8 41615.8 41869.3 41214.6 43928.6 43969.3 44202.0 44391.1 8694.7 8842.5 9138.3 9911.2 9917.4 8695.7 12049.9 12094.8 12096.9 12118.6 11704.0 11798.6 11799.2 11806.5 11899.0 8882.7 9009.7 11793.5 11885.9 11901.6 8740.9 8853.9 8859.5 11653.2 11840.2 39108.8 39423.8 39449.6 39472.8 39532.6 3470.4 3666.5 3668.5 3736.2 4132.9 28579.9 28816.1 28978.7 29196.7 29508.0 2723.4 2758.9 2775.9 2777.2 2795.3 485290.6 487065.0 487757.0 488408.0 488682.0 64995.7 65398.0 65415.3 65446.0 65526.7 70093.6 70334.6 70434.3 70619.6 70629.3 16375.7 16931.5 16967.5 16968.3 16983.2 12772.3 12851.3 12851.4 12869.0 12886.0 19823.7 19826.2 20309.5 20353.4 20396.7 8634.8 8681.7 8708.5 8709.3 8723.5 953.9 980.0 1042.3 1045.5 1143.3 30174.0 30187.4 30226.2 30467.2 30657.4 856.4 950.9 1037.4 1064.3 1074.3 14245.6 14272.7 14485.7 14550.6 14588.8 419308.9 424678.0 425022.0 425746.0 425999.7 53366.0 53387.0 53654.9 53685.5 53920.9 1429.9 1442.1 1450.2 1456.7 1457.4 28002.7 28319.4 28576.3 28660.7 28681.0 50277.0 50357.5 50563.0 50613.0 50661.7 508829.0 513781.0 513999.0 514058.0 514079.0 28038.0 28306.3 28405.4 30902.0 31314.7 40723.0 43134.0 43306.4 43786.0 44649.3 36157.6 36206.6 37052.4 37241.1 37311.3 35866.8 36330.6 36576.0 36696.6 36700.8 31281.0 31772.7 37030.8 37144.9 37982.8 29977.4 32377.7 32493.0 32556.5 32603.8 24184.2 25224.0 25303.7 25897.0 25953.6 18:24:25 INFO - 2015-11-20 18:24:25,376 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,376 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38914.40 Median:13806.19 stddev:127234.42 (921.6%) stddev-sans-first:127558.41 18:24:25 INFO - 2015-11-20 18:24:25,377 DEBUG : BROWSER_OUTPUT: Values: 361.8 363.9 367.7 369.3 369.6 14562.6 15747.2 20035.6 21071.5 21771.3 12094.8 12153.0 12185.0 14641.8 17288.7 3959.1 5038.7 5191.7 5204.8 5213.7 4049.4 4075.6 5717.2 5899.6 5912.6 5802.0 5830.6 5861.1 5882.5 6386.5 6399.3 6436.5 6441.4 6448.2 6448.6 5487.1 5611.1 5660.3 5660.7 5661.2 25184.6 25363.7 25589.5 25777.0 25871.5 2003.7 2049.0 2193.3 2361.4 2427.8 10256.4 10688.2 10839.8 13895.2 14983.7 1660.7 1695.9 1724.1 1734.5 1794.9 98059.0 104618.0 105384.5 105696.9 108100.6 10855.8 11013.3 11062.9 11090.1 11225.3 13028.2 13055.5 13061.1 13089.0 13098.1 8462.5 8470.3 8487.5 8501.1 8538.8 8600.4 8600.9 8605.3 8686.7 8705.5 3985.1 4340.7 4352.1 4407.6 4411.5 1570.3 1755.5 1775.7 1792.6 1819.4 397.8 902.3 902.6 974.3 980.7 10229.4 11567.0 11708.5 11723.9 11954.9 426.9 429.8 432.0 437.6 457.2 5762.7 6190.6 6230.4 6233.1 11216.6 757690.0 773387.0 773554.0 775591.0 786847.0 109104.0 114251.4 116786.4 119415.0 119815.4 1185.0 1213.0 1230.1 1236.6 1241.7 18401.0 18401.6 18562.9 19081.7 19135.3 51293.7 52189.5 52273.7 52490.5 53083.5 68687.0 68856.0 69298.7 69960.0 70326.6 8454.6 9803.9 9884.0 10025.8 10038.7 11789.2 12086.2 16214.4 20217.3 20605.8 14969.1 15934.7 16018.6 16312.6 16514.4 15204.5 15459.3 15491.1 15498.1 16552.1 12446.4 15311.5 15992.5 16296.4 16672.7 9540.6 9652.7 9786.0 9943.6 9944.8 9823.0 12347.3 14042.4 15907.3 15997.0 18:24:25 INFO - 2015-11-20 18:24:25,377 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,377 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5792.39 Median:6489.66 stddev:3031.46 (46.7%) stddev-sans-first:3022.00 18:24:25 INFO - 2015-11-20 18:24:25,378 DEBUG : BROWSER_OUTPUT: Values: 1402.4 1567.0 1572.9 1897.4 1915.2 7559.6 7976.7 7976.7 8465.9 8626.8 8339.5 8477.0 8506.8 8521.0 8534.9 2148.7 2367.8 2387.2 2388.3 2392.5 2192.5 2196.7 2197.4 2371.7 2419.7 2368.4 2369.2 2374.2 2376.3 2376.8 2302.1 2365.2 2367.5 2368.7 2371.6 2136.9 2189.3 2189.5 2342.2 2389.8 7297.5 8295.0 8450.0 8462.4 8470.1 5058.1 5117.0 5119.2 5123.9 5144.7 3441.9 3517.8 3563.9 3574.1 3584.3 992.9 995.5 1014.4 1028.7 1030.8 11193.7 11207.9 11209.2 11209.6 11222.1 4283.5 4558.7 4746.9 4747.2 4748.8 9709.8 9712.2 9723.8 9730.5 9733.1 5186.3 5203.0 5205.4 5246.1 5259.9 4726.5 4736.7 4743.9 4781.7 4782.4 3447.0 3788.0 3822.5 3830.8 3870.6 1103.3 1107.3 1213.2 1294.6 1298.0 1053.4 1059.6 1060.0 1242.0 1358.0 7866.4 7912.7 7923.8 7984.1 7992.9 497.0 511.0 514.0 515.6 515.7 5834.5 5978.9 6094.1 6175.1 6180.6 8583.8 8635.7 8639.6 8654.9 9009.5 9964.3 9999.1 10269.3 10271.2 10287.5 7840.8 7942.0 7961.0 8040.3 8061.6 7763.8 7802.3 7803.1 7879.4 7880.1 8881.1 9096.2 9136.4 9214.8 9214.9 8181.8 8384.2 9398.3 9479.8 9558.3 7293.3 7331.5 7349.4 7399.2 7404.9 7978.8 8039.6 8044.2 8047.2 8050.3 7389.2 7486.9 7513.5 7630.7 7634.7 7465.6 7473.4 7515.5 7516.2 7561.6 7515.3 7560.8 7564.6 7571.6 7604.0 6798.7 6812.0 6879.4 6880.7 6896.8 7011.9 7084.4 7085.8 7086.0 7091.5 18:24:25 INFO - 2015-11-20 18:24:25,378 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,378 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5743.41 Median:6527.14 stddev:1846.55 (28.3%) stddev-sans-first:1805.34 18:24:25 INFO - 2015-11-20 18:24:25,379 DEBUG : BROWSER_OUTPUT: Values: 263.7 326.4 328.3 331.5 338.3 6473.6 6694.2 6765.2 6767.1 6793.1 5216.9 6610.2 6621.1 6642.2 6646.8 4641.3 4769.2 4820.3 4878.3 4907.9 4765.7 4809.4 4859.1 4873.3 4929.2 4795.4 4795.8 4805.9 4810.9 4821.3 3709.8 4672.9 4709.5 4744.4 4789.8 4041.4 4057.6 4082.3 4099.7 4109.6 6141.4 6213.9 6237.0 6250.3 6253.4 5498.8 5633.5 5650.1 5656.1 5660.7 6971.2 7007.3 7008.3 7023.2 7045.2 4565.8 4570.8 4574.2 4575.7 4577.5 6629.6 6780.2 7317.7 7432.0 7438.4 4472.8 4622.3 4623.7 4639.3 4642.0 4708.8 4713.7 4721.2 4729.3 4729.7 5601.5 5604.0 5618.4 5627.2 5628.6 6846.5 7067.9 7069.0 7080.7 7116.8 1618.9 1637.5 1642.2 1645.2 1652.7 1037.6 1042.2 1045.1 1046.3 1066.9 6476.0 6494.2 6526.0 6527.1 6547.7 7230.6 7235.8 7236.5 7248.8 7266.4 6351.8 6499.1 6510.7 6519.8 6527.2 3711.5 3785.5 3795.5 3801.7 3882.3 7371.9 7381.4 7406.8 7410.9 7412.0 7389.4 7573.3 7613.8 7618.0 7628.0 7393.5 7416.3 7418.2 7420.1 7424.1 7322.6 7324.4 7324.5 7333.4 7339.2 7056.7 7217.7 7227.6 7233.3 7246.8 7458.6 7482.4 7485.0 7488.1 7490.3 4114.7 4456.7 4609.6 4657.4 4669.7 7181.4 7380.3 7389.3 7413.7 7471.7 5800.2 7069.5 7126.9 7136.5 7138.4 7089.4 7105.3 7106.0 7117.6 7119.6 6685.8 6923.5 6933.0 6943.3 6946.6 7119.9 7122.6 7138.6 7141.7 7146.8 6666.9 6816.9 6950.4 6952.6 6959.1 18:24:25 INFO - 2015-11-20 18:24:25,380 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,380 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18431.91 Median:499.28 stddev:26219.45 (5251.5%) stddev-sans-first:26259.38 18:24:25 INFO - 2015-11-20 18:24:25,381 DEBUG : BROWSER_OUTPUT: Values: 749.3 749.6 802.4 828.1 845.2 14974.7 15387.7 15426.3 15441.6 15444.2 11783.1 14051.4 14158.9 14194.6 14283.9 741.2 757.8 759.3 759.4 936.3 944.3 946.5 960.5 961.6 962.6 1000.4 1012.3 1014.4 1016.8 1018.1 776.1 783.3 784.6 986.1 1000.8 747.4 747.6 749.7 750.9 753.3 14831.7 15070.4 15079.5 15086.5 15087.3 12283.3 12338.3 12737.6 12955.6 13166.7 10169.5 10232.5 10243.3 10248.7 10261.6 3504.2 3521.3 3541.2 3541.9 3549.3 73696.0 74351.6 74352.3 75113.0 82379.0 9451.7 9459.3 9464.7 9485.3 9509.2 21201.8 21353.0 21409.7 21441.5 21479.6 7259.2 7348.6 7523.0 7557.9 7657.2 3886.0 3901.6 4000.8 4026.4 4120.4 3582.1 3628.9 3632.1 3636.9 3644.0 621.5 631.2 633.3 655.0 655.9 482.3 491.6 495.9 509.1 529.9 8310.8 8312.8 8467.1 8594.8 8701.4 502.7 511.3 521.5 566.9 572.9 3891.4 3932.4 4017.1 4071.9 4119.5 92356.1 101809.5 103678.5 103784.0 103831.0 54596.0 77608.1 77711.0 78209.0 80572.2 69888.0 72736.0 72753.6 75167.0 75487.6 7697.9 8332.7 8635.5 8672.9 8681.3 39345.0 46221.0 48659.5 50738.5 50973.7 69576.3 70726.0 72127.6 72237.3 72660.6 10864.9 11043.6 11083.9 11220.1 11613.8 11905.4 12025.2 12358.3 12616.3 12788.7 11148.9 11242.7 11276.0 11600.4 11875.2 11334.8 11395.2 11397.9 11591.4 12055.3 9556.3 10821.1 11243.7 11540.6 12188.8 9594.2 9761.5 9823.8 9961.3 10171.5 8882.9 8920.3 9097.8 9727.4 9745.0 18:24:25 INFO - 2015-11-20 18:24:25,381 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:24:25 INFO - 2015-11-20 18:24:25,381 DEBUG : BROWSER_OUTPUT: 18:24:25 INFO - 2015-11-20 18:24:25,820 INFO : Browser exited with error code: 0 18:24:25 INFO - 2015-11-20 18:24:25,845 INFO : Completed test dromaeo_css (00:18:34) 18:24:25 INFO - 2015-11-20 18:24:25,845 INFO : Starting test kraken 18:24:25 INFO - 2015-11-20 18:24:25,845 DEBUG : operating with platform_type : mac_ 18:24:25 INFO - 2015-11-20 18:24:25,845 INFO : Initialising browser for kraken test... 18:24:25 INFO - 2015-11-20 18:24:25,857 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpawRvMR/profile http://localhost:49268/getInfo.html 18:24:27 INFO - 2015-11-20 18:24:27,730 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:24:27 INFO - 2015-11-20 18:24:27,731 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:24:27 INFO - 2015-11-20 18:24:27,731 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:24:27 INFO - 2015-11-20 18:24:27,731 DEBUG : BROWSER_OUTPUT: __metrics 18:24:27 INFO - 2015-11-20 18:24:27,747 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:24:28 INFO - 2015-11-20 18:24:28,424 INFO : Browser initialized. 18:24:28 INFO - 2015-11-20 18:24:28,425 INFO : Running cycle 1/1 for kraken test... 18:24:28 INFO - 2015-11-20 18:24:28,425 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpawRvMR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:24:40 INFO - 2015-11-20 18:24:40,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 228655104 18:24:40 INFO - 2015-11-20 18:24:40,322 DEBUG : BROWSER_OUTPUT: 18:24:42 INFO - 2015-11-20 18:24:42,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 18:24:43 INFO - 2015-11-20 18:24:43,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 277454848 18:24:43 INFO - 2015-11-20 18:24:43,563 DEBUG : BROWSER_OUTPUT: 18:24:46 INFO - 2015-11-20 18:24:46,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 18:24:46 INFO - 2015-11-20 18:24:46,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 291561472 18:24:46 INFO - 2015-11-20 18:24:46,652 DEBUG : BROWSER_OUTPUT: 18:24:49 INFO - 2015-11-20 18:24:49,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 18:24:50 INFO - 2015-11-20 18:24:50,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 278634496 18:24:50 INFO - 2015-11-20 18:24:50,564 DEBUG : BROWSER_OUTPUT: 18:24:52 INFO - 2015-11-20 18:24:52,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 18:24:53 INFO - 2015-11-20 18:24:53,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 280752128 18:24:53 INFO - 2015-11-20 18:24:53,145 DEBUG : BROWSER_OUTPUT: 18:24:55 INFO - 2015-11-20 18:24:55,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:24:55 INFO - 2015-11-20 18:24:55,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 281702400 18:24:55 INFO - 2015-11-20 18:24:55,828 DEBUG : BROWSER_OUTPUT: 18:24:58 INFO - 2015-11-20 18:24:58,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 18:24:59 INFO - 2015-11-20 18:24:59,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 280993792 18:24:59 INFO - 2015-11-20 18:24:59,099 DEBUG : BROWSER_OUTPUT: 18:25:01 INFO - 2015-11-20 18:25:01,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 18:25:02 INFO - 2015-11-20 18:25:02,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 282062848 18:25:02 INFO - 2015-11-20 18:25:02,460 DEBUG : BROWSER_OUTPUT: 18:25:05 INFO - 2015-11-20 18:25:05,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 18:25:05 INFO - 2015-11-20 18:25:05,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 283262976 18:25:05 INFO - 2015-11-20 18:25:05,716 DEBUG : BROWSER_OUTPUT: 18:25:07 INFO - 2015-11-20 18:25:07,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:25:07 INFO - 2015-11-20 18:25:07,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 315158528 18:25:07 INFO - 2015-11-20 18:25:07,802 DEBUG : BROWSER_OUTPUT: 18:25:09 INFO - 2015-11-20 18:25:09,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:25:10 INFO - 2015-11-20 18:25:10,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 316182528 18:25:10 INFO - 2015-11-20 18:25:10,184 DEBUG : BROWSER_OUTPUT: 18:25:12 INFO - 2015-11-20 18:25:12,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:25:12 INFO - 2015-11-20 18:25:12,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 323309568 18:25:12 INFO - 2015-11-20 18:25:12,776 DEBUG : BROWSER_OUTPUT: 18:25:15 INFO - 2015-11-20 18:25:15,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:25:15 INFO - 2015-11-20 18:25:15,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 324378624 18:25:15 INFO - 2015-11-20 18:25:15,907 DEBUG : BROWSER_OUTPUT: 18:25:18 INFO - 2015-11-20 18:25:18,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:25:18 INFO - 2015-11-20 18:25:18,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 325734400 18:25:18 INFO - 2015-11-20 18:25:18,973 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 18:25:20 INFO - 2015-11-20 18:25:20,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 384049152 18:25:20 INFO - 2015-11-20 18:25:20,856 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,856 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |0;ai-astar;101;109;109;108;108;110;120;161;161;120 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;118;152;152;117;139;138;116;152;116 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |2;audio-dft;196;262;196;183;186;184;185;183;179;185 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |3;audio-fft;62;68;74;82;78;81;79;92;75;54 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;85;85;138;108;111;74;105;73;75;107 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;86;92;86;86;85;87;85;85;84 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;93;93;94;95;93;95;93;93;93 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;86;86;85;86;83;83;86;87;86 18:25:20 INFO - 2015-11-20 18:25:20,857 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;54;55;55;55;55;56;65;53;53 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;66;64;64;64;66;65;66;66;65 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;81;81;82;82;81;80;81;81;81 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;136;116;105;140;120;120;120;112;123 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;121;132;134;132;146;169;166;132;120 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;64;64;63;64;64;64;64;65 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1035 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: __startTimestamp1448072720851__endTimestamp 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,858 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.70 Median:115.00 stddev:21.98 (19.1%) stddev-sans-first:22.13 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: Values: 101.0 109.0 109.0 108.0 108.0 110.0 120.0 161.0 161.0 120.0 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:134.50 Median:142.00 stddev:16.07 (11.3%) stddev-sans-first:16.59 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: Values: 145.0 118.0 152.0 152.0 117.0 139.0 138.0 116.0 152.0 116.0 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:193.90 Median:185.50 stddev:24.55 (13.2%) stddev-sans-first:26.03 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: Values: 196.0 262.0 196.0 183.0 186.0 184.0 185.0 183.0 179.0 185.0 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:74.50 Median:78.50 stddev:10.83 (13.8%) stddev-sans-first:10.51 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: Values: 62.0 68.0 74.0 82.0 78.0 81.0 79.0 92.0 75.0 54.0 18:25:20 INFO - 2015-11-20 18:25:20,859 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:96.10 Median:73.50 stddev:21.16 (28.8%) stddev-sans-first:22.06 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 138.0 108.0 111.0 74.0 105.0 73.0 75.0 107.0 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.00 stddev:2.20 (2.6%) stddev-sans-first:2.33 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 92.0 86.0 86.0 85.0 87.0 85.0 85.0 84.0 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.60 Median:93.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 93.0 94.0 95.0 93.0 95.0 93.0 93.0 93.0 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.41 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 86.0 85.0 86.0 83.0 83.0 86.0 87.0 86.0 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.43 (6.2%) stddev-sans-first:3.64 18:25:20 INFO - 2015-11-20 18:25:20,860 DEBUG : BROWSER_OUTPUT: Values: 56.0 54.0 55.0 55.0 55.0 55.0 56.0 65.0 53.0 53.0 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:0.93 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 64.0 64.0 64.0 66.0 65.0 66.0 66.0 65.0 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 81.0 82.0 82.0 81.0 80.0 81.0 81.0 81.0 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:121.50 stddev:10.94 (9.0%) stddev-sans-first:10.92 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: Values: 133.0 136.0 116.0 105.0 140.0 120.0 120.0 120.0 112.0 123.0 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:134.00 stddev:16.86 (12.6%) stddev-sans-first:17.80 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: Values: 134.0 121.0 132.0 134.0 132.0 146.0 169.0 166.0 132.0 120.0 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 18:25:20 INFO - 2015-11-20 18:25:20,861 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 65.0 18:25:20 INFO - 2015-11-20 18:25:20,862 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:25:20 INFO - 2015-11-20 18:25:20,862 DEBUG : BROWSER_OUTPUT: 18:25:21 INFO - 2015-11-20 18:25:21,491 INFO : Browser exited with error code: 0 18:25:21 INFO - 2015-11-20 18:25:21,536 INFO : Completed test kraken (00:00:55) 18:25:21 INFO - 2015-11-20 18:25:21,537 INFO : Starting test v8_7 18:25:21 INFO - 2015-11-20 18:25:21,537 DEBUG : operating with platform_type : mac_ 18:25:21 INFO - 2015-11-20 18:25:21,537 INFO : Initialising browser for v8_7 test... 18:25:21 INFO - 2015-11-20 18:25:21,549 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpIAGw4P/profile http://localhost:49268/getInfo.html 18:25:23 INFO - 2015-11-20 18:25:23,394 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:25:23 INFO - 2015-11-20 18:25:23,396 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:25:23 INFO - 2015-11-20 18:25:23,396 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:25:23 INFO - 2015-11-20 18:25:23,396 DEBUG : BROWSER_OUTPUT: __metrics 18:25:23 INFO - 2015-11-20 18:25:23,413 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:25:24 INFO - 2015-11-20 18:25:24,034 INFO : Browser initialized. 18:25:24 INFO - 2015-11-20 18:25:24,034 INFO : Running cycle 1/1 for v8_7 test... 18:25:24 INFO - 2015-11-20 18:25:24,034 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpIAGw4P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:25:35 INFO - 2015-11-20 18:25:35,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 226107392 18:25:35 INFO - 2015-11-20 18:25:35,800 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 18:25:57 INFO - 2015-11-20 18:25:57,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 742146048 18:25:57 INFO - 2015-11-20 18:25:57,538 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,539 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:25:57 INFO - 2015-11-20 18:25:57,539 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:25:57 INFO - 2015-11-20 18:25:57,540 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:25:57 INFO - 2015-11-20 18:25:57,540 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:25:57 INFO - 2015-11-20 18:25:57,540 DEBUG : BROWSER_OUTPUT: |0;Richards;147.29709824716454 18:25:57 INFO - 2015-11-20 18:25:57,540 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.8234158893535 18:25:57 INFO - 2015-11-20 18:25:57,540 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 18:25:57 INFO - 2015-11-20 18:25:57,540 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4731.132075471698 18:25:57 INFO - 2015-11-20 18:25:57,540 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1697.792869269949 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: |5;Earley;934.5794392523364 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: |7;RegExp;27513.513513513513 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: |8;Splay;627.3525721455458 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: __startTimestamp1448072757538__endTimestamp 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,541 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.30 Median:147.30 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: Values: 147.3 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.82 Median:160.82 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: Values: 160.8 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: Values: 280.5 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4731.13 Median:4731.13 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: Values: 4731.1 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1697.79 Median:1697.79 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,542 DEBUG : BROWSER_OUTPUT: Values: 1697.8 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:934.58 Median:934.58 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: Values: 934.6 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: Values: 12370.4 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27513.51 Median:27513.51 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: Values: 27513.5 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:627.35 Median:627.35 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: Values: 627.4 18:25:57 INFO - 2015-11-20 18:25:57,543 DEBUG : BROWSER_OUTPUT: 18:25:57 INFO - 2015-11-20 18:25:57,544 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 18:25:57 INFO - 2015-11-20 18:25:57,544 DEBUG : BROWSER_OUTPUT: Values: 4509.0 18:25:57 INFO - 2015-11-20 18:25:57,544 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:25:57 INFO - 2015-11-20 18:25:57,544 DEBUG : BROWSER_OUTPUT: 18:25:58 INFO - 2015-11-20 18:25:58,179 INFO : Browser exited with error code: 0 18:25:58 INFO - 2015-11-20 18:25:58,197 INFO : Completed test v8_7 (00:00:36) 18:25:58 INFO - 2015-11-20 18:25:58,523 INFO : Completed test suite (00:20:06) 18:25:58 INFO - 2015-11-20 18:25:58,523 DEBUG : Working with test: dromaeo_css 18:25:58 INFO - 2015-11-20 18:25:58,523 DEBUG : Generating results file: dromaeo_css 18:25:58 INFO - 2015-11-20 18:25:58,524 DEBUG : Working with test: kraken 18:25:58 INFO - 2015-11-20 18:25:58,524 DEBUG : Generating results file: kraken 18:25:58 INFO - 2015-11-20 18:25:58,525 INFO : javascript benchmark 18:25:58 INFO - 2015-11-20 18:25:58,525 DEBUG : Working with test: v8_7 18:25:58 INFO - 2015-11-20 18:25:58,525 DEBUG : Generating results file: v8_7 18:25:58 INFO - 2015-11-20 18:25:58,525 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:25:58 INFO - 2015-11-20 18:25:58,669 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 18:25:58 INFO - 2015-11-20 18:25:58,669 DEBUG : process_Request line: dromaeo_css 7515.48 graph.html#tests=[[72,64,59]] 18:25:58 INFO - 2015-11-20 18:25:58,670 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:25:58 INFO - 2015-11-20 18:25:58,704 DEBUG : process_Request line: kraken 1412.00 graph.html#tests=[[232,64,59]] 18:25:58 INFO - 2015-11-20 18:25:58,705 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:25:58 INFO - 2015-11-20 18:25:58,735 DEBUG : process_Request line: v8_7 20477.70 graph.html#tests=[[230,64,59]] 18:25:58 INFO - 2015-11-20 18:25:58,736 INFO : javascript benchmark 18:25:58 INFO - 2015-11-20 18:25:58,738 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3363.9663603363965, 3441.7590768646205, 3477.6348483409247, 3556.8577256909707, 3594.209273959728, 5575.414581468938, 5702.54379649628, 6049.969750151254, 6066.120412540185, 6077.756889724411, 5902.88194236115, 5975.402459754023, 6013.398660133985, 6054.697265136748, 6055.485283750875, 5283.735813209334, 5329.25390445338, 5375.199044585991, 5375.731213439332, 5527.50252477277, 5426.430224826396, 5519.337679478468, 5527.060399732055, 5551.8889622207535, 5558.138488534263, 4617.861464156081, 5490.780368785244, 5593.440655934414, 5632.549396048326, 5641.915371269434, 5284.6564973277, 5402.810901618424, 5413.431589683105, 5415.783368665248, 5417.187421886709, 5270.8155214567305, 5307.336582927134, 5315.946840531584, 5328.387235467932, 5333.333333333333, 5865.677387743673, 5873.0, 5880.353161152269, 5902.852428689317, 5908.822735317947, 6283.151774510428, 6290.308066112724, 6300.3384644612115, 6305.085762564402, 6314.052892066181, 6335.3981371769605, 6357.904631430532, 6382.170317858649, 6415.5829871058695, 6426.871462570769, 6178.66017369049, 6195.16365290689, 6196.47329976948, 6227.439530442282, 6229.813105606839, 5720.313562372458, 5786.94213057864, 6561.442277406379, 6645.102911106938, 6645.202575690948, 6187.783427580103, 6196.00863861789, 6308.27454842699, 6312.715927783261, 6314.873702525923, 6454.515911306671, 6455.7417703292285, 6466.741330346827, 6471.385218404244, 6473.320301368382, 6322.241331040304, 6326.114343991845, 6338.397852204033, 6355.3326900674765, 6360.427561519486, 5585.916211256835, 6023.608465449732, 6214.782482613087, 6219.875602487925, 6365.3316401778075, 4337.262665346899, 5061.468545802712, 5076.568491678248, 5091.974540127276, 5097.286379906816, 4561.429821272341, 4605.838795642137, 4638.165130276515, 4642.117997580449, 4649.95350046502, 6065.272167339859, 6118.60229085108, 6121.0, 6132.601380910227, 6145.84635384119, 6252.656103914328, 6376.904346434807, 6385.776497822647, 6392.680365981682, 6478.352164783578, 6061.818145455643, 6064.36324185963, 6074.635521868702, 6078.3921607838865, 6080.726367313481, 5607.859803504945, 5614.887702246014, 5618.410066942994, 5618.747156377973, 5620.690862002629, 6184.8763024738355, 6242.906356404657, 6308.432241098323, 6339.397757213057, 6339.96830015847, 5334.306540149756, 6367.363263673596, 6368.299487056513, 6402.6158430494315, 6406.359364063743, 6406.167198264196, 6445.162128923397, 6455.2576453708425, 6462.903056454063, 6469.159009328757, 6138.478229350555, 6384.6169229846355, 6397.584157029778, 6406.935930640634, 6409.615423074631, 6305.96847015762, 6353.428191462791, 6365.172527571386, 6488.513361497812, 6500.739970401131, 5050.49495050492, 6249.312575616769, 6266.905996410149, 6278.560500764903, 6464.804011257932, 6125.296497837281, 6136.926037943253, 6247.969085100907, 6248.4376406123665, 6254.8123556293385, 6100.369238099132, 6179.351168127461, 6192.442680158807, 6217.875642487215, 6247.468965138014, 6251.906221406592, 6258.749650013949, 6264.123022776906, 6271.62370257786, 6299.716512756845, 6093.238345206849, 6287.74849006053, 6293.244810622755, 6299.559030867796, 6301.558890877594], "unit": "ms", "name": "dojo.html", "value": 5867.4286834141485}, {"lowerIsBetter": false, "replicates": [541.4318411143653, 583.9094940284252, 604.3473049106964, 616.9049936362958, 628.9308176100628, 28465.0, 41196.0, 41545.79227103868, 41615.79192104043, 41869.27849689768, 41214.55749048784, 43928.56071439285, 43969.34045989313, 44202.0, 44391.112177756426, 8694.739157825245, 8842.5136617486, 9138.268938484922, 9911.207103431709, 9917.404955702681, 8695.652173913037, 12049.939750301237, 12094.758104837898, 12096.93951530241, 12118.636440906786, 11704.0, 11798.58704945327, 11799.233049851731, 11806.527738890478, 11899.0, 8882.689105881327, 9009.729708108767, 11793.469293881753, 11885.881141188607, 11901.583444579484, 8740.8688869667, 8853.867191992125, 8859.468431894107, 11653.242539235007, 11840.171188016842, 39108.82673519799, 39423.802880985415, 39449.60550394488, 39472.802635986925, 39532.60467395318, 3470.444728843398, 3666.5050218220467, 3668.523091998023, 3736.196717705679, 4132.91734165318, 28579.857100714573, 28816.135515934347, 28978.710212898022, 29196.70803291961, 29508.0, 2723.360010397555, 2758.889644414221, 2775.9444811103663, 2777.1529683446543, 2795.2872017635577, 485290.6180320162, 487065.0, 487757.0, 488408.0, 488682.0, 64995.67502162554, 65398.0, 65415.34584654093, 65446.0, 65526.67236663786, 70093.64953175304, 70334.64832675803, 70434.2956570438, 70619.64690176517, 70629.2937070633, 16375.672486550202, 16931.492055238363, 16967.49097527076, 16968.321267149422, 16983.150842457828, 12772.297523636104, 12851.293178875065, 12851.357432128543, 12869.0, 12885.96912247018, 19823.702644460343, 19826.206951721768, 20309.492262693257, 20353.389398318075, 20396.694049589267, 8634.78413039679, 8681.741147533572, 8708.521031343336, 8709.259712924346, 8723.476591404537, 953.8998405167496, 979.9906096720389, 1042.3224903812581, 1045.5451878432755, 1143.302196238585, 30174.0, 30187.396252075276, 30226.24434389158, 30467.205750224708, 30657.386852263277, 856.4005196362571, 950.8716323296405, 1037.444966942682, 1064.2762921213648, 1074.2856000759407, 14245.572632821031, 14272.714545709028, 14485.710285794225, 14550.563483095524, 14588.781168282485, 419308.90345548076, 424678.0, 425022.0, 425746.0, 425999.66003059875, 53366.0, 53387.0, 53654.92690146175, 53685.46314536805, 53920.921581568145, 1429.9142051476945, 1442.08427648444, 1450.245872146478, 1456.739919969219, 1457.4243173946443, 28002.719972800012, 28319.43361132807, 28576.27169344694, 28660.713392866637, 28680.996165134122, 50277.0, 50357.49642503675, 50563.0, 50612.98774024425, 50661.74669126631, 508829.0, 513781.0, 513999.0, 514058.0, 514079.0, 28038.018669346475, 28306.2923426916, 28405.43189136247, 30902.0, 31314.686853131177, 40723.0, 43134.0, 43306.35040474332, 43786.0, 44649.33026004677, 36157.638423615426, 36206.637933620324, 37052.44421333628, 37241.0689732748, 37311.2537749238, 35866.82066589651, 36330.63669363378, 36576.0, 36696.63303366932, 36700.81649591735, 31281.0, 31772.682273177896, 37030.8148459256, 37144.88565343044, 37982.81008594939, 29977.400451991274, 32377.67622323841, 32493.025209243762, 32556.51165232571, 32603.836980814944, 24184.188183589013, 25224.0, 25303.74696253014, 25897.0, 25953.610695839954], "unit": "ms", "name": "ext.html", "value": 20023.96823107621}, {"lowerIsBetter": false, "replicates": [361.81728227245236, 363.8599139331358, 367.6893025393542, 369.2891184469895, 369.64144779563816, 14562.635934101627, 15747.212639368043, 20035.59928801423, 21071.47321316966, 21771.346859594236, 12094.758104837898, 12153.027757779379, 12184.964278036356, 14641.780373294408, 17288.740668889975, 3959.0894094358314, 5038.697678139305, 5191.688498690071, 5204.843854684346, 5213.687178769286, 4049.392591111342, 4075.6331930126285, 5717.228174196472, 5899.587028907957, 5912.5861189716525, 5801.970990145043, 5830.591858569902, 5861.0915308127305, 5882.529397648199, 6386.521010924176, 6399.328070552595, 6436.485081193493, 6441.42027217548, 6448.161738973903, 6448.580842245263, 5487.149491828733, 5611.102223644198, 5660.3490598581275, 5660.716964151776, 5661.207430959669, 25184.622230666555, 25363.746362536323, 25589.48821023588, 25777.0, 25871.482570348675, 2003.7395138631884, 2049.0164720933885, 2193.309107631091, 2361.374235827507, 2427.757224277576, 10256.435896025716, 10688.198385121146, 10839.783204335949, 13895.207350384902, 14983.700325993528, 1660.7259802132633, 1695.8812883098187, 1724.129314696083, 1734.5316764473648, 1794.8564114870778, 98059.0, 104618.0, 105384.47307763489, 105696.94303056948, 108100.56843463024, 10855.837162442569, 11013.2841365311, 11062.889371106186, 11090.130290893641, 11225.270357426742, 13028.153170044106, 13055.543055992996, 13061.085723999418, 13089.0, 13098.083134180515, 8462.534560599226, 8470.32237421017, 8487.533185674723, 8501.107383724744, 8538.786530336667, 8600.397972142015, 8600.8709869352, 8605.26855217301, 8686.652533898574, 8705.47767133974, 3985.0834308109297, 4340.739555626673, 4352.107817897323, 4407.625351845129, 4411.492678341968, 1570.3012159588873, 1755.4821327708357, 1775.6892543804784, 1792.6325103353781, 1819.3814103204709, 397.75339289640607, 902.2601466797295, 902.6389444222232, 974.3277138774223, 980.7253968888723, 10229.43738094412, 11567.0, 11708.473118709679, 11723.941380293043, 11954.880451195551, 426.889008857693, 429.7979949423766, 431.9784010799447, 437.61489888898205, 457.2227213736661, 5762.683052432073, 6190.566660333823, 6230.408111229426, 6233.065040244, 11216.607418740305, 757690.0, 773387.0, 773554.0, 775591.0, 786847.0, 109104.0, 114251.42874285576, 116786.41606791911, 119415.0, 119815.40092299483, 1184.9822252666218, 1212.9878701213051, 1230.0528592983353, 1236.567201479475, 1241.7081985733346, 18401.0, 18401.631967360845, 18562.907185463988, 19081.713774293676, 19135.330263440712, 51293.743531283595, 52189.47810521998, 52273.7386313066, 52490.475095248556, 53083.469165307855, 68687.0, 68856.0, 69298.65350673214, 69960.0, 70326.64836675784, 8454.577271136295, 9803.852942205729, 9883.950580247052, 10025.849612255675, 10038.698839034842, 11789.233699809485, 12086.214396064228, 16214.35142594283, 20217.2923947667, 20605.793942060387, 14969.101853888802, 15934.68130637404, 16018.599535011717, 16312.592185195464, 16514.42199523011, 15204.543863684106, 15459.304331304893, 15491.147986860831, 15498.147601882005, 16552.089635070188, 12446.43991020388, 15311.540653780405, 15992.520224393287, 16296.42962496307, 16672.749543784023, 9540.618375264912, 9652.710418687451, 9785.951070244602, 9943.552540135566, 9944.801103978025, 9822.950885245527, 12347.333110030031, 14042.438302468196, 15907.284172212047, 15997.0], "unit": "ms", "name": "jquery.html", "value": 9345.043980261373}, {"lowerIsBetter": false, "replicates": [1402.4320150339115, 1567.0441030971106, 1572.9056256624604, 1897.3738666240138, 1915.205189846214, 7559.58422286774, 7976.720814771485, 7976.720814771485, 8465.91534084659, 8626.827463450727, 8339.54132522711, 8476.957615211932, 8506.787330316745, 8521.020082690493, 8534.87197692035, 2148.742150941889, 2367.810575153992, 2387.164492427645, 2388.295452841416, 2392.497575509145, 2192.5286063496346, 2196.7144271244715, 2197.3517812245427, 2371.6561098640686, 2419.661247425353, 2368.3960590049514, 2369.2418426103654, 2374.157174203159, 2376.3227480168157, 2376.8098552115875, 2302.0906741836966, 2365.207655435431, 2367.5028244068767, 2368.7039120109985, 2371.5968285391523, 2136.9145234190614, 2189.321310393767, 2189.4745261137373, 2342.227065068523, 2389.7968672662846, 7297.45269104814, 8294.958525207396, 8449.957750211272, 8462.4076314658, 8470.110638383005, 5058.140116180258, 5117.0, 5119.206522988943, 5123.948760512384, 5144.717040562768, 3441.896743097686, 3517.771344862576, 3563.893083207508, 3574.070741607175, 3584.318979393907, 992.925530585209, 995.4873240281261, 1014.3609525998647, 1028.686250693538, 1030.7680771826354, 11193.66419007431, 11207.887921120766, 11209.215354925158, 11209.551617935354, 11222.102231821435, 4283.464566929134, 4558.680892337571, 4746.905061898812, 4747.169245382044, 4748.762561871893, 9709.757256068655, 9712.17446517054, 9723.805523889483, 9730.513474326255, 9733.075357840993, 5186.273921650972, 5202.985417843484, 5205.375354957429, 5246.134387826042, 5259.947400525945, 4726.480087190406, 4736.692115012514, 4743.928841067387, 4781.713097214179, 4782.426108866958, 3446.9831399737136, 3788.0, 3822.48396466479, 3830.7893065881085, 3870.6129387061633, 1103.332483847277, 1107.3466654673782, 1213.1923434083153, 1294.643972907458, 1297.9545715900088, 1053.3627155570769, 1059.586761163147, 1060.0406631998055, 1241.9815751084025, 1357.9524716634871, 7866.370690344873, 7912.683492660229, 7923.841523169504, 7984.121746607869, 7992.880106798402, 496.97266650333853, 511.0366958283662, 513.9871503212374, 515.644205498205, 515.7498613172609, 5834.504067154255, 5978.940210597925, 6094.116353128771, 6175.073738939195, 6180.6291622502795, 8583.785405364915, 8635.654573817103, 8639.611217495229, 8654.913450865537, 9009.459432434074, 9964.302498825158, 9999.050090241415, 10269.332493387907, 10271.178305735522, 10287.485625718684, 7840.764777056697, 7942.0, 7960.960195198987, 8040.316573091236, 8061.596920154087, 7763.844723105393, 7802.336801371947, 7803.063632364153, 7879.448438609243, 7880.093789214085, 8881.111888811325, 9096.1813436791, 9136.360454768102, 9214.769630759285, 9214.907850921405, 8181.813637022718, 8384.161583841567, 9398.34211605181, 9479.763005924908, 9558.28312876551, 7293.270672932665, 7331.523450975669, 7349.448791340564, 7399.18608953004, 7404.851902962018, 7978.760637180894, 8039.638216280398, 8044.195580442143, 8047.1550487198, 8050.27547520726, 7389.224131466333, 7486.8876966844455, 7513.4740568159705, 7630.694772209272, 7634.694612215671, 7465.58939258346, 7473.40212782987, 7515.511491753237, 7516.24837516244, 7561.584112873845, 7515.286047825448, 7560.8487830244185, 7564.583947882919, 7571.583562904093, 7604.049493813273, 6798.694058767268, 6812.0, 6879.449644028566, 6880.724771009303, 6896.827579310357, 7011.859762804614, 7084.36240738336, 7085.787426377217, 7086.043384143075, 7091.539049961736], "unit": "ms", "name": "mootools.html", "value": 4644.499902316289}, {"lowerIsBetter": false, "replicates": [263.71255331688457, 326.4091993491779, 328.29416753978944, 331.4547569248586, 338.33854813838946, 6473.643949582777, 6694.230163531195, 6765.221999470063, 6767.120274364332, 6793.116894803675, 5216.8695782605455, 6610.206775186973, 6621.073049773036, 6642.236142843574, 6646.833829154273, 4641.25739881619, 4769.236922092466, 4820.349252850855, 4878.341423907771, 4907.852764417074, 4765.737884416356, 4809.374781278429, 4859.125357435661, 4873.293372460991, 4929.162042452774, 4795.424549054101, 4795.760211989386, 4805.8558243252755, 4810.855674329776, 4821.276808478721, 3709.758865673736, 4672.929906051412, 4709.458412282597, 4744.383230180089, 4789.80840766369, 4041.373587094005, 4057.6145266199665, 4082.2856000200145, 4099.733517321394, 4109.589041095896, 6141.416565426277, 6213.906791398133, 6237.0, 6250.281217659936, 6253.405926436982, 5498.780048798043, 5633.492985631313, 5650.0959846424375, 5656.123300888369, 5660.716964151776, 6971.163460384735, 7007.334303241184, 7008.26413226614, 7023.157221133446, 7045.189803172599, 4565.794539245742, 4570.817167313304, 4574.176648203322, 4575.725456472623, 4577.450705915311, 6629.635370054645, 6780.186377634715, 7317.743878964211, 7431.996680448125, 7438.442116841205, 4472.798724057425, 4622.306654001926, 4623.676342655982, 4639.280911458729, 4641.976790116028, 4708.788104535304, 4713.717176969393, 4721.220998535203, 4729.337892695025, 4729.71621702692, 5601.5238704710555, 5604.019296623156, 5618.381977982419, 5627.240322556402, 5628.577856660767, 6846.486513511507, 7067.929320706727, 7069.010338552606, 7080.716771329089, 7116.750913717995, 1618.902865828054, 1637.525117715873, 1642.1624971264741, 1645.2020769926576, 1652.6612044531082, 1037.5849660136007, 1042.1766804224728, 1045.0907710292095, 1046.3094357723867, 1066.8559744434558, 6475.967620161869, 6494.1557597512965, 6525.967370163119, 6527.118838956775, 6547.738090476328, 7230.566166030055, 7235.819104522324, 7236.529625574426, 7248.818779530448, 7266.418686505067, 6351.809445716543, 6499.09012738217, 6510.73957041713, 6519.771807986698, 6527.15147030883, 3711.46183803347, 3785.5268091488565, 3795.4686343911876, 3801.7148713846573, 3882.2623701496627, 7371.852562948711, 7381.446391520657, 7406.777796666109, 7410.888836667455, 7412.0, 7389.445791565654, 7573.318401343906, 7613.809654758565, 7618.009658744439, 7627.961860190663, 7393.519421237603, 7416.258374162649, 7418.221086785918, 7420.146683131509, 7424.071991001125, 7322.63386830667, 7324.4140468763435, 7324.487285889936, 7333.413326933939, 7339.1926888043345, 7056.717731290691, 7217.7473788417155, 7227.566346019255, 7233.348998590152, 7246.818829529304, 7458.627068646654, 7482.363999059923, 7485.0, 7488.101427828696, 7490.250974902466, 4114.670826333946, 4456.665750068693, 4609.585137337655, 4657.394538709946, 4669.719816811003, 7181.389581885598, 7380.261973802577, 7389.334959853639, 7413.703451862081, 7471.738489152854, 5800.24596802413, 7069.540479868792, 7126.928730712627, 7136.536125151849, 7138.357547820721, 7089.361957423856, 7105.32499412555, 7106.0, 7117.572945623279, 7119.6084215368655, 6685.832854178684, 6923.5499692519825, 6933.0293758874805, 6943.340382663639, 6946.583205007716, 7119.893201601876, 7122.608256545733, 7138.571685698875, 7141.714331426685, 7146.821329466597, 6666.899996500153, 6816.863662726817, 6950.443964482931, 6952.617606031717, 6959.060526828814], "unit": "ms", "name": "prototype.html", "value": 5119.582669737552}, {"lowerIsBetter": false, "replicates": [749.2844333661353, 749.5952185819658, 802.3941923847494, 828.0560161415985, 845.1759534453904, 14974.700505989873, 15387.69224615507, 15426.305816238268, 15441.613959651, 15444.150571718552, 11783.116266280042, 14051.367688454018, 14158.929205353985, 14194.645133871658, 14283.857161428383, 741.1587847792754, 757.8029712274794, 759.2597217712741, 759.4190444310108, 936.3398803843309, 944.3436811416069, 946.4936259101382, 960.5437417226831, 961.6057416459253, 962.6438217859402, 1000.3597697473623, 1012.2610494339137, 1014.4268488304122, 1016.8423894296359, 1018.1345856022359, 776.1423626892288, 783.3380793229712, 784.5880912520944, 986.1026465916053, 1000.7948370584013, 747.4468893019126, 747.6299231880254, 749.741339237962, 750.8535835512077, 753.2994315286782, 14831.703365932728, 15070.397184112622, 15079.54761357161, 15086.471973480986, 15087.321070551852, 12283.324417157142, 12338.321392323418, 12737.617871463779, 12955.611331660066, 13166.670833229151, 10169.54237059334, 10232.488375581192, 10243.334183278062, 10248.692539223835, 10261.640842570474, 3504.229069604683, 3521.2605352875926, 3541.2386336937425, 3541.8937431876825, 3549.3078849624335, 73696.0, 74351.62824185898, 74352.25647743561, 75113.0, 82379.0, 9451.684337337396, 9459.337846350827, 9464.668736594185, 9485.288603354638, 9509.191718703987, 21201.78798212029, 21353.0, 21409.67885481719, 21441.46396340104, 21479.570408591742, 7259.165196002422, 7348.63256837156, 7522.962385188149, 7557.886631700529, 7657.1959944205055, 3886.028492876781, 3901.551321597996, 4000.8399664013696, 4026.375911733686, 4120.423140760296, 3582.1223800169128, 3628.909277268089, 3632.0919770057485, 3636.890893273206, 3643.9635603644156, 621.5369549685513, 631.2298995225817, 633.2780630081711, 655.017473789316, 655.9114519539896, 482.312704396234, 491.6263639633904, 495.89090400111917, 509.05570167339795, 529.9083887192396, 8310.750677479686, 8312.750617481484, 8467.093704428144, 8594.766193055782, 8701.390902636755, 502.6632156455184, 511.2790964739699, 521.5254118751917, 566.9256758442727, 572.8596493859031, 3891.3968334908136, 3932.4297976793778, 4017.055991841915, 4071.9389209161886, 4119.464469618931, 92356.07643923609, 101809.49095254624, 103678.48160759298, 103784.0, 103831.0, 54596.0, 77608.05979850549, 77711.0, 78209.0, 80572.19427805647, 69888.0, 72735.99999999894, 72753.6362318185, 75167.0, 75487.62256188794, 7697.88453173214, 8332.666693332441, 8635.525046122524, 8672.913270867462, 8681.305495560213, 39345.01637458972, 46221.0, 48659.51340486691, 50738.49261507485, 50973.74513127559, 69576.30423695901, 70726.0, 72127.63936180285, 72237.27762722305, 72660.63669681617, 10864.945675271572, 11043.558257669603, 11083.944580277048, 11220.102391808472, 11613.825792613286, 11905.404729763304, 12025.158238923541, 12358.320292384005, 12616.306103164414, 12788.744225115632, 11148.944255278671, 11242.66272011841, 11276.0, 11600.361980091177, 11875.228110172811, 11334.841066679724, 11395.202335836411, 11397.941170636928, 11591.362475063952, 12055.276683399024, 9556.331056825955, 10821.134309255398, 11243.718907027063, 11540.596079137189, 12188.75622487563, 9594.232461402931, 9761.511924403609, 9823.803523929624, 9961.252906032221, 10171.491425428847, 8882.86675699878, 8920.330975177018, 9097.77255568616, 9727.367721098106, 9744.951275243578], "unit": "ms", "name": "yui.html", "value": 6901.615462725708}], "name": "dromaeo_css", "value": 7515.479905608388}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [101.0, 109.0, 109.0, 108.0, 108.0, 110.0, 120.0, 161.0, 161.0, 120.0], "unit": "ms", "name": "ai-astar", "value": 120.7}, {"lowerIsBetter": true, "replicates": [145.0, 118.0, 152.0, 152.0, 117.0, 139.0, 138.0, 116.0, 152.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 134.5}, {"lowerIsBetter": true, "replicates": [196.0, 262.0, 196.0, 183.0, 186.0, 184.0, 185.0, 183.0, 179.0, 185.0], "unit": "ms", "name": "audio-dft", "value": 193.9}, {"lowerIsBetter": true, "replicates": [62.0, 68.0, 74.0, 82.0, 78.0, 81.0, 79.0, 92.0, 75.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 74.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 138.0, 108.0, 111.0, 74.0, 105.0, 73.0, 75.0, 107.0], "unit": "ms", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 92.0, 86.0, 86.0, 85.0, 87.0, 85.0, 85.0, 84.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 93.0, 94.0, 95.0, 93.0, 95.0, 93.0, 93.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.6}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 86.0, 85.0, 86.0, 83.0, 83.0, 86.0, 87.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 55.0, 55.0, 55.0, 55.0, 56.0, 65.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 64.0, 64.0, 64.0, 66.0, 65.0, 66.0, 66.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 82.0, 82.0, 81.0, 80.0, 81.0, 81.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.1}, {"lowerIsBetter": true, "replicates": [133.0, 136.0, 116.0, 105.0, 140.0, 120.0, 120.0, 120.0, 112.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [134.0, 121.0, 132.0, 134.0, 132.0, 146.0, 169.0, 166.0, 132.0, 120.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1412.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.29709824716454], "unit": "score", "name": "Richards", "value": 239.66527799999997}, {"lowerIsBetter": false, "replicates": [160.8234158893535], "unit": "score", "name": "DeltaBlue", "value": 411.121724}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [4731.132075471698], "unit": "score", "name": "Decrypt", "value": 56.26158723828514}, {"lowerIsBetter": false, "replicates": [1697.792869269949], "unit": "score", "name": "RayTrace", "value": 435.85352100000017}, {"lowerIsBetter": false, "replicates": [934.5794392523364], "unit": "score", "name": "Earley", "value": 713.1154100000002}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [27513.513513513513], "unit": "score", "name": "RegExp", "value": 33.11045677799608}, {"lowerIsBetter": false, "replicates": [627.3525721455458], "unit": "score", "name": "Splay", "value": 129.89665399999998}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 20477.69618257215}]} 18:25:58 INFO - RETURN: dromaeo_css: 7515.48 18:25:58 INFO - RETURN: kraken: 1412.00 18:25:58 INFO - RETURN: v8_7: 20477.70 18:25:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20477.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1412.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7515.48"}}} 18:25:58 INFO - Return code: 0 18:25:58 INFO - # TBPL SUCCESS # 18:25:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:25:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:25:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:25:58 INFO - 2015-11-20 18:25:58.822 screenresolution[1677:10068] starting screenresolution argv=screenresolution get 18:25:58 INFO - 2015-11-20 18:25:58.824 screenresolution[1677:10068] Display 0: 1600x1200x32@50 18:25:58 INFO - 2015-11-20 18:25:58.830 screenresolution[1678:10071] starting screenresolution argv=screenresolution list 18:25:58 INFO - Available Modes on Display 0 18:25:58 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 18:25:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:25:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:25:58 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 18:25:58 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 18:25:59 INFO - Graphics/Displays: 18:25:59 INFO - Intel Iris: 18:25:59 INFO - Chipset Model: Intel Iris 18:25:59 INFO - Type: GPU 18:25:59 INFO - Bus: Built-In 18:25:59 INFO - VRAM (Dynamic, Max): 1536 MB 18:25:59 INFO - Vendor: Intel (0x8086) 18:25:59 INFO - Device ID: 0x0a2e 18:25:59 INFO - Revision ID: 0x0009 18:25:59 INFO - Displays: 18:25:59 INFO - Display: 18:25:59 INFO - Resolution: 1600 x 1200 @ 50 Hz 18:25:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:25:59 INFO - Display Serial Number: 1600x1200 50 18:25:59 INFO - Main Display: Yes 18:25:59 INFO - Mirror: Off 18:25:59 INFO - Online: Yes 18:25:59 INFO - Rotation: Supported 18:25:59 INFO - Return code: 0 18:25:59 INFO - Running post-action listener: _resource_record_post_action 18:25:59 INFO - Running post-run listener: _resource_record_post_run 18:26:00 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 33578496; Write bytes: 689138176; Read time: 347; Write time: 2377 18:26:00 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334576128; Write bytes: 336709632; Read time: 26250; Write time: 602 18:26:00 INFO - run-tests - Wall time: 1208s; CPU: 52.0%; Read bytes: 32652800; Write bytes: 341824000; Read time: 333; Write time: 1741 18:26:00 INFO - Running post-run listener: _upload_blobber_files 18:26:00 INFO - Blob upload gear active. 18:26:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:26:00 INFO - Copying logs to upload dir... 18:26:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.614272 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-20 18:26:00.174628) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:26:00.177823) ========= 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.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 build_url:https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009372 build_url: 'https://queue.taskcluster.net/v1/task/cE6jIppeQRi087Qy_8Fj_Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:26:00.200704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:26:00.201048) ========= 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.JARae7Q2um/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.w5UbhgSwUY/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.004985 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:26:00.250631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 18:26:00.250938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 18:26:00.251330) ========= ========= Total master_lag: 0.21 =========