builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0004 starttime: 1448011300.94 results: success (0) buildid: 20151119234736 builduid: 4a8c5385308e49598f014d9370b9a4c5 revision: e4fab7d5c909ebac90258fe86a32faa97ce3b6bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:40.938234) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:40.938703) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:40.939022) ========= 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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.005750 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:40.995374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:40.995720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.128055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.131434) ========= 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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.005233 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.191110) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.191461) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.191898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.192182) ========= 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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 01:21:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|: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.41G=0s 2015-11-20 01:21:41 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.350032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.353426) ========= 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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.019793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:41.402568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 01:21:41.402934) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4fab7d5c909ebac90258fe86a32faa97ce3b6bf --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 e4fab7d5c909ebac90258fe86a32faa97ce3b6bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 01:21:41,478 truncating revision to first 12 chars 2015-11-20 01:21:41,478 Setting DEBUG logging. 2015-11-20 01:21:41,478 attempt 1/10 2015-11-20 01:21:41,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4fab7d5c909?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 01:21:42,585 unpacking tar archive at: fx-team-e4fab7d5c909/testing/mozharness/ program finished with exit code 0 elapsedTime=1.352950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 01:21:42.773213) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:42.773929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:42.785858) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:42.786237) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 01:21:42.786702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2015-11-20 01:21:42.787001) ========= /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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:21:42 INFO - MultiFileLogger online at 20151120 01:21:42 in /builds/slave/test 01:21:42 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 01:21:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:21:42 INFO - {'append_to_log': False, 01:21:42 INFO - 'base_work_dir': '/builds/slave/test', 01:21:42 INFO - 'blob_upload_branch': 'Fx-Team', 01:21:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:21:42 INFO - 'branch': 'Fx-Team', 01:21:42 INFO - 'buildbot_json_path': 'buildprops.json', 01:21:42 INFO - 'config_files': ('talos/mac_config.py',), 01:21:42 INFO - 'default_actions': ('clobber', 01:21:42 INFO - 'read-buildbot-config', 01:21:42 INFO - 'download-and-extract', 01:21:42 INFO - 'populate-webroot', 01:21:42 INFO - 'create-virtualenv', 01:21:42 INFO - 'install', 01:21:42 INFO - 'run-tests'), 01:21:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:21:42 INFO - 'download_minidump_stackwalk': True, 01:21:42 INFO - 'download_symbols': 'ondemand', 01:21:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:21:42 INFO - 'tooltool.py': '/tools/tooltool.py', 01:21:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:21:42 INFO - '/tools/misc-python/virtualenv.py')}, 01:21:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:21:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:21:42 INFO - 'installer_path': 'installer.exe', 01:21:42 INFO - 'log_level': 'info', 01:21:42 INFO - 'log_name': 'talos', 01:21:42 INFO - 'log_to_console': True, 01:21:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:21:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:21:42 INFO - 'opt_config_files': (), 01:21:42 INFO - 'pip_index': False, 01:21:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:21:42 INFO - 'cmd': ('bash', 01:21:42 INFO - '-c', 01:21:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:21:42 INFO - 'enabled': True, 01:21:42 INFO - 'halt_on_failure': False, 01:21:42 INFO - 'name': 'check_screen_resolution'},), 01:21:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:21:42 INFO - 'cmd': ('bash', 01:21:42 INFO - '-c', 01:21:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:21:42 INFO - 'enabled': True, 01:21:42 INFO - 'halt_on_failure': False, 01:21:42 INFO - 'name': 'check_screen_resolution'},), 01:21:42 INFO - 'run_cmd_checks_enabled': True, 01:21:42 INFO - 'sps_profile': False, 01:21:42 INFO - 'sps_profile_interval': 0, 01:21:42 INFO - 'suite': 'dromaeojs', 01:21:42 INFO - 'system_bits': '64', 01:21:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:21:42 INFO - 'title': 't-yosemite-r7-0004', 01:21:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:21:42 INFO - 'use_talos_json': True, 01:21:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:21:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:21:42 INFO - 'work_dir': 'build'} 01:21:42 INFO - ##### 01:21:42 INFO - ##### Running clobber step. 01:21:42 INFO - ##### 01:21:42 INFO - Running pre-action listener: _resource_record_pre_action 01:21:42 INFO - Running main action method: clobber 01:21:42 INFO - rmtree: /builds/slave/test/build 01:21:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:21:45 INFO - Running post-action listener: _resource_record_post_action 01:21:45 INFO - ##### 01:21:45 INFO - ##### Running read-buildbot-config step. 01:21:45 INFO - ##### 01:21:45 INFO - Running pre-action listener: _resource_record_pre_action 01:21:45 INFO - Running main action method: read_buildbot_config 01:21:45 INFO - Using buildbot properties: 01:21:45 INFO - { 01:21:45 INFO - "properties": { 01:21:45 INFO - "buildnumber": 3, 01:21:45 INFO - "product": "firefox", 01:21:45 INFO - "script_repo_revision": "production", 01:21:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:21:45 INFO - "repository": "", 01:21:45 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:21:45 INFO - "buildid": "20151119234736", 01:21:45 INFO - "slavename": "t-yosemite-r7-0004", 01:21:45 INFO - "pgo_build": "False", 01:21:45 INFO - "basedir": "/builds/slave/test", 01:21:45 INFO - "project": "", 01:21:45 INFO - "platform": "yosemite_r7", 01:21:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:21:45 INFO - "slavebuilddir": "test", 01:21:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:21:45 INFO - "branch": "fx-team", 01:21:45 INFO - "repo_path": "integration/fx-team", 01:21:45 INFO - "stage_platform": "macosx64", 01:21:45 INFO - "builduid": "4a8c5385308e49598f014d9370b9a4c5", 01:21:45 INFO - "revision": "e4fab7d5c909ebac90258fe86a32faa97ce3b6bf" 01:21:45 INFO - }, 01:21:45 INFO - "sourcestamp": { 01:21:45 INFO - "repository": "", 01:21:45 INFO - "hasPatch": false, 01:21:45 INFO - "project": "", 01:21:45 INFO - "branch": "fx-team-macosx64-talos", 01:21:45 INFO - "changes": [ 01:21:45 INFO - { 01:21:45 INFO - "category": null, 01:21:45 INFO - "files": [ 01:21:45 INFO - { 01:21:45 INFO - "url": null, 01:21:45 INFO - "name": "https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 01:21:45 INFO - } 01:21:45 INFO - ], 01:21:45 INFO - "repository": "", 01:21:45 INFO - "rev": "e4fab7d5c909ebac90258fe86a32faa97ce3b6bf", 01:21:45 INFO - "who": "cbook@mozilla.com", 01:21:45 INFO - "when": 1448011269, 01:21:45 INFO - "number": 6687603, 01:21:45 INFO - "comments": "Bug 1224196 - Applies word wrap fix to toolbar-group in devtools. r=ntim", 01:21:45 INFO - "project": "", 01:21:45 INFO - "at": "Fri 20 Nov 2015 01:21:09", 01:21:45 INFO - "branch": "fx-team-macosx64-talos", 01:21:45 INFO - "revlink": "", 01:21:45 INFO - "properties": [ 01:21:45 INFO - [ 01:21:45 INFO - "buildid", 01:21:45 INFO - "20151119234736", 01:21:45 INFO - "Change" 01:21:45 INFO - ], 01:21:45 INFO - [ 01:21:45 INFO - "builduid", 01:21:45 INFO - "4a8c5385308e49598f014d9370b9a4c5", 01:21:45 INFO - "Change" 01:21:45 INFO - ], 01:21:45 INFO - [ 01:21:45 INFO - "pgo_build", 01:21:45 INFO - "False", 01:21:45 INFO - "Change" 01:21:45 INFO - ] 01:21:45 INFO - ], 01:21:45 INFO - "revision": "e4fab7d5c909ebac90258fe86a32faa97ce3b6bf" 01:21:45 INFO - } 01:21:45 INFO - ], 01:21:45 INFO - "revision": "e4fab7d5c909ebac90258fe86a32faa97ce3b6bf" 01:21:45 INFO - } 01:21:45 INFO - } 01:21:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 01:21:45 INFO - Running post-action listener: _resource_record_post_action 01:21:45 INFO - ##### 01:21:45 INFO - ##### Running download-and-extract step. 01:21:45 INFO - ##### 01:21:45 INFO - Running pre-action listener: _resource_record_pre_action 01:21:45 INFO - Running main action method: download_and_extract 01:21:45 INFO - mkdir: /builds/slave/test/build/tests 01:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:45 INFO - https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/test_packages.json 01:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/test_packages.json 01:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:22:00 INFO - Downloaded 1149 bytes. 01:22:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:22:00 INFO - Using the following test package requirements: 01:22:00 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:22:00 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:22:00 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 01:22:00 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:22:00 INFO - u'jsshell-mac.zip'], 01:22:00 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:22:00 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 01:22:00 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:22:00 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:22:00 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 01:22:00 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:22:00 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 01:22:00 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:22:00 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 01:22:00 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:22:00 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:22:00 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 01:22:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:00 INFO - https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:22:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:22:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:22:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/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 01:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/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 01:22:20 INFO - Downloaded 17525140 bytes. 01:22:20 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 01:22:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:22:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:22:22 INFO - Return code: 0 01:22:22 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 01:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:22 INFO - https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:22:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:22:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:22:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/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 01:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/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 01:22:24 INFO - Downloaded 17525140 bytes. 01:22:24 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 01:22:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:22:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:22:27 INFO - Return code: 0 01:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:27 INFO - https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/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 01:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/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 01:22:28 INFO - Downloaded 11130997 bytes. 01:22:28 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 01:22:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:22:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 01:22:28 INFO - Return code: 0 01:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:28 INFO - https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 01:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/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 01:23:05 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg: The read operation timed out 01:23:05 INFO - retry: attempt #1 caught exception: The read operation timed out 01:23:05 INFO - retry: Failed, sleeping 30 seconds before retrying 01:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #2 01:23:38 INFO - Downloaded 109414766 bytes. 01:23:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:23:38 INFO - mkdir: /builds/slave/test/properties 01:23:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:23:38 INFO - Writing to file /builds/slave/test/properties/build_url 01:23:38 INFO - Contents: 01:23:38 INFO - build_url:https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:23:38 INFO - Running post-action listener: _resource_record_post_action 01:23:38 INFO - Running post-action listener: set_extra_try_arguments 01:23:38 INFO - ##### 01:23:38 INFO - ##### Running populate-webroot step. 01:23:38 INFO - ##### 01:23:38 INFO - Running pre-action listener: _resource_record_pre_action 01:23:38 INFO - Running main action method: populate_webroot 01:23:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:23:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:23:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:23:38 INFO - '../fennec_ids.txt'], 01:23:38 INFO - 'tests': ['tcheck2']}, 01:23:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:23:38 INFO - '--tppagecycles', 01:23:38 INFO - '7'], 01:23:38 INFO - 'tests': ['tsvgm']}}, 01:23:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:23:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:23:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:23:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:23:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:23:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:23:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'tests': ['damp', 'tps']}, 01:23:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['damp', 'tps']}, 01:23:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:23:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:23:38 INFO - 'other': {'tests': ['a11yr', 01:23:38 INFO - 'ts_paint', 01:23:38 INFO - 'tpaint', 01:23:38 INFO - 'sessionrestore', 01:23:38 INFO - 'sessionrestore_no_auto_restore']}, 01:23:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['a11yr', 01:23:38 INFO - 'ts_paint', 01:23:38 INFO - 'tpaint', 01:23:38 INFO - 'sessionrestore', 01:23:38 INFO - 'sessionrestore_no_auto_restore']}, 01:23:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['a11yr', 01:23:38 INFO - 'ts_paint', 01:23:38 INFO - 'tpaint', 01:23:38 INFO - 'sessionrestore', 01:23:38 INFO - 'sessionrestore_no_auto_restore']}, 01:23:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['a11yr', 01:23:38 INFO - 'ts_paint', 01:23:38 INFO - 'tpaint', 01:23:38 INFO - 'sessionrestore', 01:23:38 INFO - 'sessionrestore_no_auto_restore']}, 01:23:38 INFO - 'other_l64': {'tests': ['a11yr', 01:23:38 INFO - 'ts_paint', 01:23:38 INFO - 'tpaint', 01:23:38 INFO - 'sessionrestore', 01:23:38 INFO - 'sessionrestore_no_auto_restore']}, 01:23:38 INFO - 'other_nol64': {'tests': ['a11yr', 01:23:38 INFO - 'ts_paint', 01:23:38 INFO - 'tpaint', 01:23:38 INFO - 'sessionrestore', 01:23:38 INFO - 'sessionrestore_no_auto_restore']}, 01:23:38 INFO - 'svgr': {'tests': ['tsvgx', 01:23:38 INFO - 'tsvgr_opacity', 01:23:38 INFO - 'tart', 01:23:38 INFO - 'tscrollx', 01:23:38 INFO - 'cart']}, 01:23:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['tsvgx', 01:23:38 INFO - 'tsvgr_opacity', 01:23:38 INFO - 'tart', 01:23:38 INFO - 'tscrollx', 01:23:38 INFO - 'cart']}, 01:23:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'tests': ['tp5o']}, 01:23:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'talos_options': ['--e10s'], 01:23:38 INFO - 'tests': ['tp5o']}, 01:23:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'talos_options': ['--xperf_path', 01:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:23:38 INFO - 'tests': ['tp5n']}, 01:23:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:38 INFO - 'talos_options': ['--e10s', 01:23:38 INFO - '--xperf_path', 01:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:23:38 INFO - 'tests': ['tp5n']}}, 01:23:38 INFO - 'talos.zip': {'path': '', 01:23:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:23:38 INFO - Running post-action listener: _resource_record_post_action 01:23:38 INFO - ##### 01:23:38 INFO - ##### Running create-virtualenv step. 01:23:38 INFO - ##### 01:23:38 INFO - Running pre-action listener: _resource_record_pre_action 01:23:38 INFO - Running main action method: create_virtualenv 01:23:38 INFO - Creating virtualenv /builds/slave/test/build/venv 01:23:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:23:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:23:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:23:38 INFO - Using real prefix '/tools/python27' 01:23:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:23:39 INFO - Installing distribute.............................................................................................................................................................................................done. 01:23:42 INFO - Installing pip.................done. 01:23:42 INFO - Return code: 0 01:23:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:42 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 0x10b5fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09b68a550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, '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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:23:42 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 01:23:42 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 01:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:23:42 INFO - 'HOME': '/Users/cltbld', 01:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:23:42 INFO - 'LOGNAME': 'cltbld', 01:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:42 INFO - 'MOZ_NO_REMOTE': '1', 01:23:42 INFO - 'NO_EM_RESTART': '1', 01:23:42 INFO - 'PAGER': '/bin/cat', 01:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:42 INFO - 'PWD': '/builds/slave/test', 01:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:23:42 INFO - 'SHELL': '/bin/bash', 01:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:23:42 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:23:42 INFO - 'USER': 'cltbld', 01:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:42 INFO - 'XPC_FLAGS': '0x0', 01:23:42 INFO - 'XPC_SERVICE_NAME': '0', 01:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:23:42 INFO - Cleaning up... 01:23:42 INFO - Return code: 0 01:23:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:42 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 0x10b5fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09b68a550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, '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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:23:42 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 01:23:42 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 01:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:23:42 INFO - 'HOME': '/Users/cltbld', 01:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:23:42 INFO - 'LOGNAME': 'cltbld', 01:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:42 INFO - 'MOZ_NO_REMOTE': '1', 01:23:42 INFO - 'NO_EM_RESTART': '1', 01:23:42 INFO - 'PAGER': '/bin/cat', 01:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:42 INFO - 'PWD': '/builds/slave/test', 01:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:23:42 INFO - 'SHELL': '/bin/bash', 01:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:23:42 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:23:42 INFO - 'USER': 'cltbld', 01:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:42 INFO - 'XPC_FLAGS': '0x0', 01:23:42 INFO - 'XPC_SERVICE_NAME': '0', 01:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:42 INFO - Downloading/unpacking psutil>=0.7.1 01:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:45 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:23:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:23:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:23:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:23:45 INFO - Installing collected packages: psutil 01:23:45 INFO - Running setup.py install for psutil 01:23:45 INFO - building 'psutil._psutil_osx' extension 01:23:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:23:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:23:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:23:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:23:46 INFO - building 'psutil._psutil_posix' extension 01:23:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:23:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:23:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:23:46 INFO - ^ 01:23:46 INFO - 1 warning generated. 01:23:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:23:46 INFO - Successfully installed psutil 01:23:46 INFO - Cleaning up... 01:23:46 INFO - Return code: 0 01:23:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:23: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')]} 01:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23: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')]} 01:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:46 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 0x10b5fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09b68a550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, '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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:23:46 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 01:23:46 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 01:23:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:23:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:23:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:23:46 INFO - 'HOME': '/Users/cltbld', 01:23:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:23:46 INFO - 'LOGNAME': 'cltbld', 01:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:46 INFO - 'MOZ_NO_REMOTE': '1', 01:23:46 INFO - 'NO_EM_RESTART': '1', 01:23:46 INFO - 'PAGER': '/bin/cat', 01:23:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:46 INFO - 'PWD': '/builds/slave/test', 01:23:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:23:46 INFO - 'SHELL': '/bin/bash', 01:23:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:23:46 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:23:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:23:46 INFO - 'USER': 'cltbld', 01:23:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:23:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:46 INFO - 'XPC_FLAGS': '0x0', 01:23:46 INFO - 'XPC_SERVICE_NAME': '0', 01:23:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:23:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:23:49 INFO - Installing collected packages: mozsystemmonitor 01:23:49 INFO - Running setup.py install for mozsystemmonitor 01:23:49 INFO - Successfully installed mozsystemmonitor 01:23:49 INFO - Cleaning up... 01:23:49 INFO - Return code: 0 01:23:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:49 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 0x10b5fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09b68a550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, '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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:23:49 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 01:23:49 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 01:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:23:49 INFO - 'HOME': '/Users/cltbld', 01:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:23:49 INFO - 'LOGNAME': 'cltbld', 01:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:49 INFO - 'MOZ_NO_REMOTE': '1', 01:23:49 INFO - 'NO_EM_RESTART': '1', 01:23:49 INFO - 'PAGER': '/bin/cat', 01:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:49 INFO - 'PWD': '/builds/slave/test', 01:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:23:49 INFO - 'SHELL': '/bin/bash', 01:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:23:49 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:23:49 INFO - 'USER': 'cltbld', 01:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:49 INFO - 'XPC_FLAGS': '0x0', 01:23:49 INFO - 'XPC_SERVICE_NAME': '0', 01:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:51 INFO - Downloading blobuploader-1.2.4.tar.gz 01:23:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:23:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:23:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:52 INFO - Downloading docopt-0.6.1.tar.gz 01:23:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:23:52 INFO - Installing collected packages: blobuploader, requests, docopt 01:23:52 INFO - Running setup.py install for blobuploader 01:23:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:23:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:23:52 INFO - Running setup.py install for requests 01:23:53 INFO - Running setup.py install for docopt 01:23:53 INFO - Successfully installed blobuploader requests docopt 01:23:53 INFO - Cleaning up... 01:23:53 INFO - Return code: 0 01:23:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:53 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 0x10b5fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09b68a550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, '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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:23:53 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 01:23:53 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 01:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:23:53 INFO - 'HOME': '/Users/cltbld', 01:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:23:53 INFO - 'LOGNAME': 'cltbld', 01:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:53 INFO - 'MOZ_NO_REMOTE': '1', 01:23:53 INFO - 'NO_EM_RESTART': '1', 01:23:53 INFO - 'PAGER': '/bin/cat', 01:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:53 INFO - 'PWD': '/builds/slave/test', 01:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:23:53 INFO - 'SHELL': '/bin/bash', 01:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:23:53 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:23:53 INFO - 'USER': 'cltbld', 01:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:53 INFO - 'XPC_FLAGS': '0x0', 01:23:53 INFO - 'XPC_SERVICE_NAME': '0', 01:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:23:53 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-JhsXsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-A1RfW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-2IQk3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-3PJHGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-I4Zu6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-zNBdXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-xOej5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-OoIdTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-5jifOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:23:54 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Htew6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:23:55 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-T7n63V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:23:55 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-t0zy7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:23:55 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-f3IEBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:23:55 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-0_XURR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:23:55 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-8OxrlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:23:55 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-yEGygo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:23:55 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-s6wUmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:23:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:23:55 INFO - Running setup.py install for manifestparser 01:23:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:23:55 INFO - Running setup.py install for mozcrash 01:23:56 INFO - Running setup.py install for mozdebug 01:23:56 INFO - Running setup.py install for mozdevice 01:23:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Running setup.py install for mozfile 01:23:56 INFO - Running setup.py install for mozhttpd 01:23:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Running setup.py install for mozinfo 01:23:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Running setup.py install for mozInstall 01:23:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:23:56 INFO - Running setup.py install for mozleak 01:23:57 INFO - Running setup.py install for mozlog 01:23:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:23:57 INFO - Running setup.py install for moznetwork 01:23:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:23:57 INFO - Running setup.py install for mozprocess 01:23:57 INFO - Running setup.py install for mozprofile 01:23:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:23:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:23:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:23:57 INFO - Running setup.py install for mozrunner 01:23:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:23:57 INFO - Running setup.py install for mozscreenshot 01:23:58 INFO - Running setup.py install for moztest 01:23:58 INFO - Running setup.py install for mozversion 01:23:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:23:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:23:58 INFO - Cleaning up... 01:23:58 INFO - Return code: 0 01:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:23: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')]} 01:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23: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')]} 01:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23: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', '-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 0x10b5fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09b68a550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, '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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:23:58 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 01:23:58 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 01:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:23:58 INFO - 'HOME': '/Users/cltbld', 01:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:23:58 INFO - 'LOGNAME': 'cltbld', 01:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:58 INFO - 'MOZ_NO_REMOTE': '1', 01:23:58 INFO - 'NO_EM_RESTART': '1', 01:23:58 INFO - 'PAGER': '/bin/cat', 01:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:58 INFO - 'PWD': '/builds/slave/test', 01:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:23:58 INFO - 'SHELL': '/bin/bash', 01:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:23:58 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:23:58 INFO - 'USER': 'cltbld', 01:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:58 INFO - 'XPC_FLAGS': '0x0', 01:23:58 INFO - 'XPC_SERVICE_NAME': '0', 01:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:23:58 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-M3VBHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:23:58 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-fdGKkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:23:58 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-mm7nVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:23:58 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-qq4rZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:23:59 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)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-DcngRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-tJ83wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-7NFUwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-KEShR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-cRHhbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-4b5rLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:23:59 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)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-eVQfmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-GgICFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-DhSz_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:23:59 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)) 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:23:59 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-gk3TZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:00 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-yKvhkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:00 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-uu3fld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:00 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-UPLL__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:24:00 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)) 01:24:00 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)) 01:24:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:02 INFO - Downloading blessings-1.5.1.tar.gz 01:24:02 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 01:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:24:02 INFO - Installing collected packages: blessings 01:24:02 INFO - Running setup.py install for blessings 01:24:02 INFO - Successfully installed blessings 01:24:02 INFO - Cleaning up... 01:24:02 INFO - Return code: 0 01:24:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:03 INFO - Reading from file tmpfile_stdout 01:24:03 INFO - Current package versions: 01:24:03 INFO - blessings == 1.5.1 01:24:03 INFO - blobuploader == 1.2.4 01:24:03 INFO - docopt == 0.6.1 01:24:03 INFO - manifestparser == 1.1 01:24:03 INFO - mozInstall == 1.12 01:24:03 INFO - mozcrash == 0.16 01:24:03 INFO - mozdebug == 0.1 01:24:03 INFO - mozdevice == 0.47 01:24:03 INFO - mozfile == 1.2 01:24:03 INFO - mozhttpd == 0.7 01:24:03 INFO - mozinfo == 0.9 01:24:03 INFO - mozleak == 0.1 01:24:03 INFO - mozlog == 3.0 01:24:03 INFO - moznetwork == 0.27 01:24:03 INFO - mozprocess == 0.22 01:24:03 INFO - mozprofile == 0.27 01:24:03 INFO - mozrunner == 6.11 01:24:03 INFO - mozscreenshot == 0.1 01:24:03 INFO - mozsystemmonitor == 0.0 01:24:03 INFO - moztest == 0.7 01:24:03 INFO - mozversion == 1.4 01:24:03 INFO - psutil == 3.1.1 01:24:03 INFO - requests == 1.2.3 01:24:03 INFO - wsgiref == 0.1.2 01:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:03 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 0x10b5fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09b68a550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, '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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:03 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 01:24:03 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 01:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:03 INFO - 'HOME': '/Users/cltbld', 01:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:03 INFO - 'LOGNAME': 'cltbld', 01:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:03 INFO - 'MOZ_NO_REMOTE': '1', 01:24:03 INFO - 'NO_EM_RESTART': '1', 01:24:03 INFO - 'PAGER': '/bin/cat', 01:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:03 INFO - 'PWD': '/builds/slave/test', 01:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:03 INFO - 'SHELL': '/bin/bash', 01:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:24:03 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:03 INFO - 'USER': 'cltbld', 01:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:03 INFO - 'XPC_FLAGS': '0x0', 01:24:03 INFO - 'XPC_SERVICE_NAME': '0', 01:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 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)) 01:24:03 INFO - Cleaning up... 01:24:03 INFO - Return code: 0 01:24:03 INFO - Running post-action listener: _resource_record_post_action 01:24:03 INFO - Running post-action listener: _start_resource_monitoring 01:24:03 INFO - Starting resource monitoring. 01:24:03 INFO - ##### 01:24:03 INFO - ##### Running install step. 01:24:03 INFO - ##### 01:24:03 INFO - Running pre-action listener: _resource_record_pre_action 01:24:03 INFO - Running main action method: install 01:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:03 INFO - Reading from file tmpfile_stdout 01:24:03 INFO - Detecting whether we're running mozinstall >=1.0... 01:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:24:03 INFO - Reading from file tmpfile_stdout 01:24:03 INFO - Output received: 01:24:03 INFO - Usage: mozinstall [options] installer 01:24:03 INFO - Options: 01:24:03 INFO - -h, --help show this help message and exit 01:24:03 INFO - -d DEST, --destination=DEST 01:24:03 INFO - Directory to install application into. [default: 01:24:03 INFO - "/builds/slave/test"] 01:24:03 INFO - --app=APP Application being installed. [default: firefox] 01:24:03 INFO - mkdir: /builds/slave/test/build/application 01:24:03 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'] 01:24:03 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 01:24:34 INFO - Reading from file tmpfile_stdout 01:24:34 INFO - Output received: 01:24:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:24:34 INFO - Running post-action listener: _resource_record_post_action 01:24:34 INFO - ##### 01:24:34 INFO - ##### Running run-tests step. 01:24:34 INFO - ##### 01:24:34 INFO - Running pre-action listener: _resource_record_pre_action 01:24:34 INFO - Running main action method: run_tests 01:24:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:24:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:24:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:24:34 INFO - 2015-11-20 01:24:34.127 screenresolution[2829:85919] starting screenresolution argv=screenresolution get 01:24:34 INFO - 2015-11-20 01:24:34.130 screenresolution[2829:85919] Display 0: 1600x1200x32@60 01:24:34 INFO - 2015-11-20 01:24:34.136 screenresolution[2830:85921] starting screenresolution argv=screenresolution list 01:24:34 INFO - Available Modes on Display 0 01:24:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:24:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:24:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:24:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:24:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:24:34 INFO - Intel Iris: 01:24:34 INFO - Chipset Model: Intel Iris 01:24:34 INFO - Type: GPU 01:24:34 INFO - Bus: Built-In 01:24:34 INFO - VRAM (Dynamic, Max): 1536 MB 01:24:34 INFO - Vendor: Intel (0x8086) 01:24:34 INFO - Device ID: 0x0a2e 01:24:34 INFO - Revision ID: 0x0009 01:24:34 INFO - Displays: 01:24:34 INFO - Display: 01:24:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:24:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:24:34 INFO - Display Serial Number: 1600x1200 60 01:24:34 INFO - Main Display: Yes 01:24:34 INFO - Mirror: Off 01:24:34 INFO - Online: Yes 01:24:34 INFO - Rotation: Supported 01:24:34 INFO - Return code: 0 01:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:24:34 INFO - Python 2.7.3 01:24:34 INFO - Return code: 0 01:24:34 INFO - grabbing minidump binary from tooltool 01:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5229f0>, '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 0x10b281db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5158c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:24:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:24:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:24:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:24:34 INFO - Return code: 0 01:24:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:24:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:24:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:24:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:24:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:24:34 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/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--webServer', 'localhost'] in /builds/slave/test/build 01:24:34 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/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0004 --webServer localhost 01:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lucCKBy3Zb/Render', 01:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:34 INFO - 'HOME': '/Users/cltbld', 01:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:34 INFO - 'LOGNAME': 'cltbld', 01:24:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:24:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:34 INFO - 'MOZ_NO_REMOTE': '1', 01:24:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:24:34 INFO - 'NO_EM_RESTART': '1', 01:24:34 INFO - 'PAGER': '/bin/cat', 01:24:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:34 INFO - 'PWD': '/builds/slave/test', 01:24:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:34 INFO - 'SHELL': '/bin/bash', 01:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEoO8k0w8l/Listeners', 01:24:34 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 01:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:34 INFO - 'USER': 'cltbld', 01:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:34 INFO - 'XPC_FLAGS': '0x0', 01:24:34 INFO - 'XPC_SERVICE_NAME': '0', 01:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:34 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/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--webServer', 'localhost'] with output_timeout 3600 01:24:34 INFO - mozversion INFO | application_buildid: 20151119234736 01:24:34 INFO - mozversion INFO | application_changeset: e4fab7d5c909ebac90258fe86a32faa97ce3b6bf 01:24:34 INFO - mozversion INFO | application_display_name: Nightly 01:24:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:24:34 INFO - mozversion INFO | application_name: Firefox 01:24:34 INFO - mozversion INFO | application_remotingname: firefox 01:24:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:24:34 INFO - mozversion INFO | application_vendor: Mozilla 01:24:34 INFO - mozversion INFO | application_version: 45.0a1 01:24:34 INFO - mozversion INFO | platform_buildid: 20151119234736 01:24:34 INFO - mozversion INFO | platform_changeset: e4fab7d5c909ebac90258fe86a32faa97ce3b6bf 01:24:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:24:34 INFO - mozversion INFO | platform_version: 45.0a1 01:24:34 INFO - 2015-11-20 01:24:34,668 DEBUG : using testdate: 1448011474 01:24:34 INFO - 2015-11-20 01:24:34,668 DEBUG : actual date: 1448011474 01:24:35 INFO - 2015-11-20 01:24:35,154 INFO : starting webserver on 'localhost:60687' 01:24:35 INFO - 2015-11-20 01:24:35,155 INFO : Starting test suite t-yosemite-r7-0004 01:24:35 INFO - 2015-11-20 01:24:35,155 INFO : Starting test dromaeo_css 01:24:35 INFO - 2015-11-20 01:24:35,155 DEBUG : operating with platform_type : mac_ 01:24:35 INFO - 2015-11-20 01:24:35,156 INFO : Initialising browser for dromaeo_css test... 01:24:35 INFO - 2015-11-20 01:24:35,168 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpUgJSpd/profile http://localhost:60687/getInfo.html 01:24:37 INFO - 2015-11-20 01:24:37,238 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:24:37 INFO - 2015-11-20 01:24:37,238 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:24:37 INFO - 2015-11-20 01:24:37,238 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:24:37 INFO - 2015-11-20 01:24:37,238 DEBUG : BROWSER_OUTPUT: __metrics 01:24:37 INFO - 2015-11-20 01:24:37,247 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: console.error: 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: Stack: 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 01:24:37 INFO - 2015-11-20 01:24:37,507 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 01:24:37 INFO - 2015-11-20 01:24:37,508 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 01:24:37 INFO - 2015-11-20 01:24:37,508 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 01:24:37 INFO - 2015-11-20 01:24:37,508 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 01:24:37 INFO - 2015-11-20 01:24:37,508 DEBUG : BROWSER_OUTPUT: 01:24:37 INFO - 2015-11-20 01:24:37,890 INFO : Browser initialized. 01:24:37 INFO - 2015-11-20 01:24:37,891 INFO : Running cycle 1/1 for dromaeo_css test... 01:24:37 INFO - 2015-11-20 01:24:37,891 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpUgJSpd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:24:49 INFO - 2015-11-20 01:24:49,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 224624640 01:24:49 INFO - 2015-11-20 01:24:49,738 DEBUG : BROWSER_OUTPUT: 01:25:40 INFO - 2015-11-20 01:25:40,737 DEBUG : BROWSER_OUTPUT: 1448011540729 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:27:52 INFO - 2015-11-20 01:27:52,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60687/tests/dromaeo/cssquery-ext.html) 01:27:54 INFO - 2015-11-20 01:27:54,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 381206528 01:27:54 INFO - 2015-11-20 01:27:54,014 DEBUG : BROWSER_OUTPUT: 01:30:56 INFO - 2015-11-20 01:30:56,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/dromaeo/cssquery-ext.html (next: http://localhost:60687/tests/dromaeo/cssquery-jquery.html) 01:30:57 INFO - 2015-11-20 01:30:57,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 363618304 01:30:57 INFO - 2015-11-20 01:30:57,364 DEBUG : BROWSER_OUTPUT: 01:33:59 INFO - 2015-11-20 01:33:59,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60687/tests/dromaeo/cssquery-mootools.html) 01:34:00 INFO - 2015-11-20 01:34:00,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 359759872 01:34:00 INFO - 2015-11-20 01:34:00,063 DEBUG : BROWSER_OUTPUT: 01:37:02 INFO - 2015-11-20 01:37:02,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60687/tests/dromaeo/cssquery-prototype.html) 01:37:02 INFO - 2015-11-20 01:37:02,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 329396224 01:37:02 INFO - 2015-11-20 01:37:02,599 DEBUG : BROWSER_OUTPUT: 01:40:05 INFO - 2015-11-20 01:40:05,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60687/tests/dromaeo/cssquery-yui.html) 01:40:06 INFO - 2015-11-20 01:40:06,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 330383360 01:40:06 INFO - 2015-11-20 01:40:06,127 DEBUG : BROWSER_OUTPUT: 01:43:08 INFO - 2015-11-20 01:43:08,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/dromaeo/cssquery-yui.html (next: http://localhost:60687/tests/dromaeo/cssquery-dojo.html) 01:43:09 INFO - 2015-11-20 01:43:09,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 363663360 01:43:09 INFO - 2015-11-20 01:43:09,004 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,004 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:43:09 INFO - 2015-11-20 01:43:09,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:43:09 INFO - 2015-11-20 01:43:09,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:43:09 INFO - 2015-11-20 01:43:09,005 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:43:09 INFO - 2015-11-20 01:43:09,007 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3444.7416443766715;3479.8608055677773;3519.2081781599127;3527.5766907971047;3549.1304630365566;5712.542996560275;5860.941390586093;6020.307664618565;6076.361981991888;6081.78713745019;5961.135635332874;5971.223740913686;5979.222701048869;6047.092936059593;6124.969375153118;5392;5442.619016668835;5443.564514838823;5472.398036216013;5477.75350109246;5527.364353099385;5575.916361254584;5582.581306402016;5587.944120558783;5616.66300022;5282.788688452457;5398.946010539884;5414.998225328327;5519.254900588429;5543.279373681416;5443.183522471661;5463;5466.180072989044;5467.589930755209;5480.862978425532;5262.131748261532;5375.193720941851;5416.268803711488;5417.945820541783;5438.619296649196;5919.348871624118;5958.910616340759;5960.552958528127;5963.701814909237;6020.458158765732;6323.004199064561;6347.555671103025;6364.586301890362;6370.108184854124;6376.39424254695;6176.96911515444;6244.781432649881;6309.558330916838;6313.621182729005;6419.486441084702;6089.573729838913;6105.481034112106;6108.816735497942;6119.258838874149;6123.877522449615;6396.168498095218;6425.228972523327;6491.253505846794;6496.967515162394;6505.349465053551;6289.591176573508;6298.559100862987;6302.842428939313;6305.180326557518;6313.273973493107;5806.216160818235;5889.880922624688;6424.775132870327;6425.004124360731;6442.259140198843;6154.076888466766;6245.313015568284;6256.937430625636;6259.311475737665;6272.905906411407;6253.405926436982;6300.1494798202575;6303.873922521616;6318.905216421757;6324.747010119544;4957.90084198314;5061.670991385548;5108.923366149511;5119.87200319995;5171.4052883918075;4588.105319462673;4631.606313463326;4664.813407463731;4670.813167473331;4676.859694209179;6008.429199226067;6016.458518733335;6022.45797878193;6022.819315420545;6028.246469191351;6284.937150628527;6298.307186209513;6303.495720342362;6307.432331090224;6307.968460157762;5930.851728706817;5993.400659934059;5999.910001349983;6005.3394126646035;6026.126211699367;5452.263944367539;5566.832995010156;5575.275214222125;5586.441355864381;5597.8600534986135;6410.967945160244;6426.550141490051;6465.127207826883;6492.993585994179;6590.505712071518;6411.3909178627955;6416.839579010375;6442.162518872517;6444.967775161094;6447;6564.770233041821;6565.310642382481;6589.110470086477;6589.242237142598;6589.7364105435245;6179.258488981351;6185.257769067741;6277.18396608438;6285.182926219562;6300.338464461165;6359.682015899279;6375.107484952017;6396.520260980538;6399.6800159992745;6404.199475065617;6283.685815709105;6293.685315734287;6296.0555916612875;6303.653299068412;6322.0516922462;6118.923762351665;6139.6009259398;6218.22272215973;6235.095911092957;6264.248290205204;6225.750969961151;6248.218972628421;6270.184875966095;6297.464715499051;6299.149614801943;6186.19579454668;6342.587731797418;6343.873122537616;6353.3011368748475;6362.681865906594;5178.8964220716125;5980.28236611592;6082.817515474543;6115.541334400027;6125.908111378422 01:43:09 INFO - 2015-11-20 01:43:09,008 DEBUG : BROWSER_OUTPUT: |1;ext.html;539.935207775067;550.1939658400443;621.1459243540133;639.7760783725697;661.3948237362813;32095.518567221512;32598.348033039325;32674.67325326746;32709.836450817744;41599.96000099999;44162.89592760183;44552.88617784549;44755;44759.552404475944;44779.55220447794;9618.903810961889;9791.951040244825;9796.412215267106;9798.314118011742;9819.705408837746;8793.428427152214;8896.688615898445;8920.375573709844;9597.66408175714;11802.173847830656;11633.243839150471;11715.179937404386;11742.823857642143;11742.882571174265;11753.706157346092;11654.8251776223;11709.297442153498;11709.824352634718;11710.648680539598;11717.53129874804;8720.651173953098;8832.381733278673;8834.983976842617;8841.955790221007;8848.424852384574;43023;43037.78481107606;43433;43585.56414435847;43745.562544374465;3307.4873394623874;3408.1820363112924;3425.9143521411916;3868.8065596720335;3920.157166209279;28273;28989.855050724822;29096.418071638447;29475.852620736758;29653.406931861457;2853.7003614620376;2857.7428031477057;2889.479893619148;2926.9121926342245;3004.8948286809855;386641.06679466704;427961;508554;509533;511821;64389.03416448757;64803.67598161979;64854.02718959219;65002.67498662476;65009.34990650127;68646.65676671684;69055.96416053764;69057;69123;69134;16377.344906203618;16778.916105419637;16933.407330743365;17002.829971700372;17009.404670836462;12850.678733031562;12898.097133200587;12916.41876115577;12926.159799612995;12927.28899910495;19474.805251947582;20055.699164512545;20100.899495502428;20113.899430502755;20157.899210503852;8179.304759095544;9435.528223588793;9705.854412183822;9709.621142820055;9720.368176068674;989.9010098990043;997.436448406648;1013.9695809125737;1054.330500132406;1132.818749000156;29832.40335193284;30339.69660303413;30380.24049398783;30601.540976885364;30822.229444263623;944.6835310171169;1083.7724077943562;1090.2749671468544;1124.4827379405401;1136.2216881436243;14281.500147494788;14641.414343426357;14672.75281601076;15252.466163684217;15958.28472866122;537425;540432;541305.293473538;543523;545611.2719436378;59239;59460;59535.404645952985;59638.210853674456;59794;1299.311364976564;1319.129374612751;1361.686812033218;1475.5942115917994;1475.7196132734746;23335.41661458477;23919.641205382282;30094.84952575223;30310.393792124476;30549.389012220076;55970;56158.71920640371;56337.71831140818;56362;56400;481194;484444;548346;628822;631266;29996.250093747833;30184.09447716572;30293.242668933453;30405.543916841707;30437.695623043484;42535.57464425316;43012.924676882074;43020.35469468023;43353.783231083646;44235.89410264769;30375.696243037288;36213.27573448569;36573.817130914176;36654.26691466102;37605;29059.854700726362;35884;35952.64047359493;36563.72026979043;37559;35389;35606;35657.82171089128;36007.45988810118;36097.45853812143;30871.2282192938;33227.83386083054;33276.1680957978;33359;33452.665473344954;24605.50788984246;24747.50504989854;24875;24876.62685059762;24939.501209975337 01:43:09 INFO - 2015-11-20 01:43:09,011 DEBUG : BROWSER_OUTPUT: |2;jquery.html;299.78115975338005;355.38873138202297;357.11257525050246;358.65927368999456;360.6015353034896;16220.756688649679;16582.83417165828;19756.802431975677;20275.797242027576;21218.89390553047;17864.732029019542;21133.57732845346;21506.354809355704;21588.028538715756;21635.026423810927;5622.775088996435;5925.703714814264;5936;5938.287405511344;5947.345791962881;4234.640055595278;4343.9565604344025;5917.023691090986;5964.015937370329;5971.104334349839;6199.380061993787;6311.589746666475;6370.649614271213;6376.330485299047;6384.648844313584;6222.688865556704;6352.333005034474;6452.4192822645955;6453.322401147859;6461.386168314003;5585.273914391144;5611.915821262684;5612.07400778871;5615.5507559395555;5626.352969408488;26092.73907260922;26331.473370532673;26591.46817063648;26634.467310653872;26828.865855670792;1961.4704029911986;2135.3060255416895;2280.897359618821;2309.90760369585;2392.784649381564;9303.162715355582;9551.283653725928;9726.610935562569;9743.756406089833;15299.311530981133;1726.7064599018197;1730.0917018565228;1730.1003478191396;1760.8327208915132;1787.928482860684;87345;101685.49157254166;104644;108719;109042;10569.894301057046;10601.575936962436;10644.414557199429;10675;10854.837177442345;12665.430055647517;12689.428975696115;12691.619251422471;12695.746085078246;12710.809337859939;8331.583420828934;8405.360954613914;8409.537475438787;8467.661293548312;8471.025832029396;8553.802467654534;8580.785480363042;8627.784305392415;8666.393352465393;8683.739487815375;3884.106655469258;4195.244855925963;4231.788410579458;4248.87253382399;4303.225419424533;1653.2147230065864;1697.73685078813;1738.8435040846384;1747.8339557741995;1785.1074462768615;396.4251834839494;396.7242766277467;416.90202802341423;974.8058628180422;986.5264672957021;11282.492287847066;11664.500510948094;11857.347845868388;11944;12042.337671428155;394.6783371552233;426.34768803730344;435.4904761429072;443.2553310438494;445.03427562190126;5936.7031648417405;6049.122877182784;6085.421884920926;6095.756169753249;6109.75560977556;761001;765653;774964;780643;782450;129312;132157;132703;132884;133597.3320133393;476.62108623643593;481.5978657820689;481.66283601478403;482.83100914680284;483.0869656349432;10906.182036347147;11006.95433933775;11039.944800275947;11096.500657470271;11108.944455277671;50527.74736126296;51237.74381128071;51340;51372.74313628408;51590.22614660708;71113;74512.62743686247;76484.3515648453;76846;77831;9595.90404095978;9664.613415463302;9937.602495900082;9940.850887236553;9943.751406214902;11756.70608234801;11891.989180919718;11904.880951190724;11918.986886114777;11958.880411195776;14943.701125977203;16161.515154545383;16219.675606488041;16538.751918720987;16671.91664041672;15808.76286855675;15918.60203494922;16105;16137.354505819636;16744.41394551185;13220.140690855063;14522.854771452572;16489.91755041217;16572;17151;9764.951175244078;9878.753031174278;9992.150667193078;10033.49832508357;10200.234982376203;16200.351985920432;16286.918565407097;16711.498655040366;16752.832471675614;16799.91600041992 01:43:09 INFO - 2015-11-20 01:43:09,013 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1555.1679851279564;1614.790077289952;1658.361530810638;1906.4852489827747;2022.7876073012324;7193.71225150994;7442.441816863737;7873.212678732131;8573.271271941892;8584.527850968194;8259.463134896228;8394.958025209866;8430;8467.195616416431;8492.108328625498;2380.155044959045;2401.855888646678;2404.663347131403;2406.2660888429023;2406.651035599837;2421.285720712394;2440.3777036855668;2441.5849305618;2447.204658485999;2448.51029794041;2139.60417322795;2346.8617720405673;2372.039324073753;2399.172285561487;2401.363638635763;2335.556244313575;2340.8361414700976;2351.95296094078;2352.447174913885;2399.0283935006178;2384.260879127476;2405.0740464920955;2416.794572461343;2420.5037967216854;2422.8304018718695;7613.695452181906;8361.456505327134;8422.705205317785;8424.241818236327;8432.578371081421;4717.150912835688;4851.490593487668;5141.126008578551;5240.554552863011;5253.9474605253845;3514.0687717754818;3579.516765236686;3633.6729694327373;3654.8355324010217;3655.9268814623824;1043.0664555223034;1064.1539975719322;1075.7687097274045;1076.9192310576739;1081.2429801572446;11217.971147790133;11287.830682539769;11299.435028248638;11305.830412543819;11354;4717.481077081518;4724.716517008922;4776.832810851603;4789.808407663724;4792.305115758265;9897.950510247403;9906.55420506079;9925.851112233322;9931.106200441995;9936.304458687822;5258.158694608845;5293.311869456946;5296.973515132399;5297.390800058042;5298.576113910878;4773.355596994431;4815.061063092663;4815.686980346266;4819.734914579662;4839.540243676845;3704.5554533456157;3803.6497043549143;3804.410316400962;3806.657400833938;3837.501124853751;1222.10175520992;1250.7748605251143;1254.9372531373576;1258.5657948007922;1259.4332550352194;1227.7053507158396;1355.5594431809702;1371.5885234429632;1394.065975796219;1418.326295009862;7726.459147859596;7941;8030.638621262057;8060.798480038046;8062.435629505878;504.29902435614525;510.6553076673231;518.225253246399;518.5747686896708;519.7297405349198;5280.181571856291;5977.940220597825;6062.181605483292;6227.252729672468;6238.469730072904;9532.237421006303;10268.58925642966;10370.11853992404;10385.792284154426;10419.583216671399;10070.59717611302;10250.282480226462;10284.640037598798;10301.896981030244;10314.43270620123;7907.881381779278;7941.761747147595;7948.364130869517;8033.879491807627;8050.59747012647;7784.5718485481575;7879.212078792304;7899.328557072483;7919.485233459806;7935.642896069575;9215.907840921505;9307.06929307064;9310.255179585753;9347.859782103138;9372.297077719062;9094.772630684285;9351.812963740824;9459.337846350689;9464.479453630116;9565.952170239383;7400.148982867039;7408.777736667908;7413.629318534159;7454.701811927463;7456.813579660552;8091.797705057185;8138.633761480629;8143.877841832259;8164.183581641788;8168.632411541376;7504.024476817979;7597.506162099446;7667.961660191663;7718.035245594301;7761.107472640719;6692.933070669231;7206.315400036988;7425.591592462466;7435.293647103516;7588.772336829904;7553.584552849646;7595.08858936909;7595.962020189863;7598.164201937672;7608.505447145918;6726.966365168339;6871.072405225231;6928.930710692828;6934.341237582422;6961.443084553122;7016.894746578703;7049.224585295716;7050.189228238613;7053.612051337226;7062.858742825218 01:43:09 INFO - 2015-11-20 01:43:09,016 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.07054190139087;317.5078628126403;326.80228461780615;328.1517277836792;328.2417615308636;6551.574147680403;6603.306652801459;6628.536002479828;6715.213186527585;6740.831479213022;5401.78392864286;6671.49963752718;6682;6684.632345221011;6715.127033485653;4106.240345536085;4712.952870471303;4830.73430961297;4850.951490485085;4959.181735013718;4832.130216561018;4857.465678775332;4929.679570827902;4937.77779999899;4950.257461380804;4834.323194752737;4841.3464182335465;4878.512148785111;4898.681585696918;4899.583535399477;4618.838340658078;4735.455422626407;4752.382190315237;4768.785404656799;4908.607311415096;4166.937495937564;4178.979105104486;4183.811728472226;4200.726952748092;4228.851990180359;6348.619082855043;6361.713722882481;6370.649614271213;6381.712822922979;6413.551051426402;5693.615729886124;5791.478766910998;5826.504747096502;5837.35789063207;5847.181394604716;7113.110861142357;7128.821779455503;7144.785656430316;7150.1777295611155;7160;4340.91318173638;4471.217536931056;4534.659900507475;4735.83424580138;4746.121967436035;6060.454559089703;7302.160251571084;7546.509476883985;7551.358134558569;7557.886631700529;4799.328094066834;4823.831165909176;4827.468978412372;4834.444038935497;4842.757862106881;4899.314096026559;4905.435874874435;4922.803087876517;4924.03981223658;4932.8766780830765;5835.795747148914;5836.8540786479825;5849.707514624251;5850.063989761703;5856.472917437451;6843.657817109125;7161.928380716126;7162.46281528877;7171.605561694157;7187.101612298463;1677.2117104960648;1703.6252024554578;1703.7444383342597;1706.1128213329248;1707.1549582956516;1095.3209010413436;1100.3947828694186;1115.4478533126155;1123.5618108937522;1123.6685177872548;6610.4050635443045;6647;6662.133922590032;6667.099941507931;6675.332466753286;6073.75704971805;7342.632868356561;7377.81555461107;7415.740449084256;7418.703251869865;6425.518086143465;6435.581687190412;6666.200055993215;6670.933290667128;6673.232578253563;3833.2525157594;3870.632289932452;3870.6709929656295;3870.9225815483533;3874.3026255273758;7609.086909570887;7629.19893411195;7785.5985922533355;7792.727254546064;7798.454108212371;7564.773056808304;7799.883001754978;7802.336801371834;7806.648700808477;7826.530408175528;7774.533527988338;7774.92225077742;7777.455578109591;7782.571958542335;7792.844143117106;7487.737929172453;7492.9625351875075;7494.437917156344;7502.36229920441;7525.285097915689;6133.631982080911;7030.824229394101;7378.225286344857;7383.520071195355;7389.926100739139;7722.961385193263;7723.34351580122;7731.072271327476;7731.7680469586;7750.573718445539;4830.855074347775;4832.275158726219;4837.443693975238;4837.927431088607;4840.322354870392;6048.455638992512;6368.554201205871;7150.928490715026;7204.027456293334;7479.588622625808;7163.892541611985;7180.60506672138;7181.964090179516;7193.748218812317;7205.135383753983;6915.481338899502;7157.1769246537315;7167.3549380556;7172.282771722786;7173.175084865307;6990.126234220723;7003.404710599656;7007.964960175166;7008.018877357072;7017.298270173146;7152.141742990666;7164.498485105993;7164.605946672983;7166.677499512639;7170.103737032871;5676.2337084493065;6822.351876571718;6999.51003429755;7017.087778588751;7045.471589630695 01:43:09 INFO - 2015-11-20 01:43:09,017 DEBUG : BROWSER_OUTPUT: |5;yui.html;695.9304069593042;726.1975517053652;732.6373445144653;819.6516480495787;828.8881001064856;14629.561113166608;15024.699506009887;15077.472288469906;15093.92453037736;15098.924505377472;11921.046316294698;13767.449302027906;13789.655258618539;13947.930260348685;13952.93023534881;761.3262262897348;770.2413123073768;772.2007722007695;949.2453499467922;977.0717818072824;960.255801753643;962.3023308101606;975.8438649816031;978.3591747405461;981.4258658684678;1010.5604062232916;1025.2720568396448;1026.1482969135636;1026.712520494263;1027.2706378471257;792.809725665839;802.3941923847516;803.4335793265734;809.805646644801;1012.2762225009117;607.9937703101374;751.1812124784012;758.5789886612928;768.0859776865512;768.5081547809407;14592.781108283385;14777;14787;14791.038582492103;14804.555863324009;12195.573154939624;12262.141650084497;12438.502459901592;12505.624831255076;12564.497420103186;9949.452780097092;10080.092791648713;10088.848667269996;10094.545745441474;10097.495125243708;3510.613832478425;3555.3600351936643;3564.518789963348;3565.144365352323;3568.4290513517712;78156.60921695412;78305.60847195728;79478.60260698717;79956;80126.59936700338;9457.763555911157;9515.619375224913;9597.136257736836;9719.266391836552;9739.464329461805;20619.896900515403;20646.690299645517;20669.689954650694;20674.62241842177;20713.68929466059;7325.304096110861;7507.474476786572;7510.324070833652;7669.3864490841715;7686.308232259012;3964.5044369453817;3972.2651309507833;4071.267171909085;4137.482814648169;4164.167166566699;3460.186856088817;3507.228409749851;3507.7369197310304;3512.7892326459983;3514.4376899695926;574.8160588611604;575.6459777236969;600.9579329446897;613.929398119213;624.2976651267325;558.8854284871592;594.2868557730654;607.3926073926074;611.8894207014255;618.4495798739126;8517.06312305646;8691.782705432415;8692.478451292942;8692.550445625693;8802.911970880337;545.2285016701402;610.5970059760537;616.1989413762092;624.6595605395071;646.2632598837329;3880.2239552089695;4112.773797441169;4155.210510003089;4164.708470407042;4254.404383386328;108681.45659271652;108727.45636271927;108950;110840.4457977721;111476.44261778801;89477.10522894817;90454;90500.09499905049;91100.5444972771;91961;65933.01100483496;71383.57232855314;77347;77565;78323;8239.546824924686;8294.253517183482;8415.53714545706;8417.789555260922;8522.36082293818;54218.186727199914;54377.72811135919;54426.727866360416;54993;55326.17010744922;66065.33934660784;72411.82764517074;73874.63062684653;74849;79651.40697186139;10171.64399246023;10952.945235273774;11118.722031949266;11203;11330.660080197607;11923.523059077539;12030.879691202976;12043.75912481763;12092.637220883387;12095.516179353079;11442.141839361915;11484.94257528707;11509.482073306888;11514.94242528782;11540.480678369326;11414;11427.257228280136;11432.885671143182;11487.712807179887;11500.194986351209;11199.496022678835;11201.271917325348;11238.51606002142;11244.775104497701;11299.717507062389;9799.363041402286;9820.607175712892;10176.643817466353;10288.942211557569;10338.844917326396;9910.950445247727;10027.560313149042;10102.040306170902;10102.646407375707;10171.338862973884 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1141 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: __startTimestamp1448012589003__endTimestamp 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5930.11 Median:6125.91 stddev:624.44 (10.2%) stddev-sans-first:595.14 01:43:09 INFO - 2015-11-20 01:43:09,018 DEBUG : BROWSER_OUTPUT: Values: 3444.7 3479.9 3519.2 3527.6 3549.1 5712.5 5860.9 6020.3 6076.4 6081.8 5961.1 5971.2 5979.2 6047.1 6125.0 5392.0 5442.6 5443.6 5472.4 5477.8 5527.4 5575.9 5582.6 5587.9 5616.7 5282.8 5398.9 5415.0 5519.3 5543.3 5443.2 5463.0 5466.2 5467.6 5480.9 5262.1 5375.2 5416.3 5417.9 5438.6 5919.3 5958.9 5960.6 5963.7 6020.5 6323.0 6347.6 6364.6 6370.1 6376.4 6177.0 6244.8 6309.6 6313.6 6419.5 6089.6 6105.5 6108.8 6119.3 6123.9 6396.2 6425.2 6491.3 6497.0 6505.3 6289.6 6298.6 6302.8 6305.2 6313.3 5806.2 5889.9 6424.8 6425.0 6442.3 6154.1 6245.3 6256.9 6259.3 6272.9 6253.4 6300.1 6303.9 6318.9 6324.7 4957.9 5061.7 5108.9 5119.9 5171.4 4588.1 4631.6 4664.8 4670.8 4676.9 6008.4 6016.5 6022.5 6022.8 6028.2 6284.9 6298.3 6303.5 6307.4 6308.0 5930.9 5993.4 5999.9 6005.3 6026.1 5452.3 5566.8 5575.3 5586.4 5597.9 6411.0 6426.6 6465.1 6493.0 6590.5 6411.4 6416.8 6442.2 6445.0 6447.0 6564.8 6565.3 6589.1 6589.2 6589.7 6179.3 6185.3 6277.2 6285.2 6300.3 6359.7 6375.1 6396.5 6399.7 6404.2 6283.7 6293.7 6296.1 6303.7 6322.1 6118.9 6139.6 6218.2 6235.1 6264.2 6225.8 6248.2 6270.2 6297.5 6299.1 6186.2 6342.6 6343.9 6353.3 6362.7 5178.9 5980.3 6082.8 6115.5 6125.9 01:43:09 INFO - 2015-11-20 01:43:09,019 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,020 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66611.12 Median:35918.32 stddev:139998.99 (389.8%) stddev-sans-first:140303.83 01:43:09 INFO - 2015-11-20 01:43:09,020 DEBUG : BROWSER_OUTPUT: Values: 539.9 550.2 621.1 639.8 661.4 32095.5 32598.3 32674.7 32709.8 41600.0 44162.9 44552.9 44755.0 44759.6 44779.6 9618.9 9792.0 9796.4 9798.3 9819.7 8793.4 8896.7 8920.4 9597.7 11802.2 11633.2 11715.2 11742.8 11742.9 11753.7 11654.8 11709.3 11709.8 11710.6 11717.5 8720.7 8832.4 8835.0 8842.0 8848.4 43023.0 43037.8 43433.0 43585.6 43745.6 3307.5 3408.2 3425.9 3868.8 3920.2 28273.0 28989.9 29096.4 29475.9 29653.4 2853.7 2857.7 2889.5 2926.9 3004.9 386641.1 427961.0 508554.0 509533.0 511821.0 64389.0 64803.7 64854.0 65002.7 65009.3 68646.7 69056.0 69057.0 69123.0 69134.0 16377.3 16778.9 16933.4 17002.8 17009.4 12850.7 12898.1 12916.4 12926.2 12927.3 19474.8 20055.7 20100.9 20113.9 20157.9 8179.3 9435.5 9705.9 9709.6 9720.4 989.9 997.4 1014.0 1054.3 1132.8 29832.4 30339.7 30380.2 30601.5 30822.2 944.7 1083.8 1090.3 1124.5 1136.2 14281.5 14641.4 14672.8 15252.5 15958.3 537425.0 540432.0 541305.3 543523.0 545611.3 59239.0 59460.0 59535.4 59638.2 59794.0 1299.3 1319.1 1361.7 1475.6 1475.7 23335.4 23919.6 30094.8 30310.4 30549.4 55970.0 56158.7 56337.7 56362.0 56400.0 481194.0 484444.0 548346.0 628822.0 631266.0 29996.3 30184.1 30293.2 30405.5 30437.7 42535.6 43012.9 43020.4 43353.8 44235.9 30375.7 36213.3 36573.8 36654.3 37605.0 29059.9 35884.0 35952.6 36563.7 37559.0 35389.0 35606.0 35657.8 36007.5 36097.5 30871.2 33227.8 33276.2 33359.0 33452.7 24605.5 24747.5 24875.0 24876.6 24939.5 01:43:09 INFO - 2015-11-20 01:43:09,020 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,021 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39368.32 Median:359.63 stddev:127494.10 (35451.4%) stddev-sans-first:127818.00 01:43:09 INFO - 2015-11-20 01:43:09,021 DEBUG : BROWSER_OUTPUT: Values: 299.8 355.4 357.1 358.7 360.6 16220.8 16582.8 19756.8 20275.8 21218.9 17864.7 21133.6 21506.4 21588.0 21635.0 5622.8 5925.7 5936.0 5938.3 5947.3 4234.6 4344.0 5917.0 5964.0 5971.1 6199.4 6311.6 6370.6 6376.3 6384.6 6222.7 6352.3 6452.4 6453.3 6461.4 5585.3 5611.9 5612.1 5615.6 5626.4 26092.7 26331.5 26591.5 26634.5 26828.9 1961.5 2135.3 2280.9 2309.9 2392.8 9303.2 9551.3 9726.6 9743.8 15299.3 1726.7 1730.1 1730.1 1760.8 1787.9 87345.0 101685.5 104644.0 108719.0 109042.0 10569.9 10601.6 10644.4 10675.0 10854.8 12665.4 12689.4 12691.6 12695.7 12710.8 8331.6 8405.4 8409.5 8467.7 8471.0 8553.8 8580.8 8627.8 8666.4 8683.7 3884.1 4195.2 4231.8 4248.9 4303.2 1653.2 1697.7 1738.8 1747.8 1785.1 396.4 396.7 416.9 974.8 986.5 11282.5 11664.5 11857.3 11944.0 12042.3 394.7 426.3 435.5 443.3 445.0 5936.7 6049.1 6085.4 6095.8 6109.8 761001.0 765653.0 774964.0 780643.0 782450.0 129312.0 132157.0 132703.0 132884.0 133597.3 476.6 481.6 481.7 482.8 483.1 10906.2 11007.0 11039.9 11096.5 11108.9 50527.7 51237.7 51340.0 51372.7 51590.2 71113.0 74512.6 76484.4 76846.0 77831.0 9595.9 9664.6 9937.6 9940.9 9943.8 11756.7 11892.0 11904.9 11919.0 11958.9 14943.7 16161.5 16219.7 16538.8 16671.9 15808.8 15918.6 16105.0 16137.4 16744.4 13220.1 14522.9 16489.9 16572.0 17151.0 9765.0 9878.8 9992.2 10033.5 10200.2 16200.4 16286.9 16711.5 16752.8 16799.9 01:43:09 INFO - 2015-11-20 01:43:09,022 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,022 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5886.38 Median:5286.75 stddev:3082.00 (58.3%) stddev-sans-first:3073.46 01:43:09 INFO - 2015-11-20 01:43:09,023 DEBUG : BROWSER_OUTPUT: Values: 1555.2 1614.8 1658.4 1906.5 2022.8 7193.7 7442.4 7873.2 8573.3 8584.5 8259.5 8395.0 8430.0 8467.2 8492.1 2380.2 2401.9 2404.7 2406.3 2406.7 2421.3 2440.4 2441.6 2447.2 2448.5 2139.6 2346.9 2372.0 2399.2 2401.4 2335.6 2340.8 2352.0 2352.4 2399.0 2384.3 2405.1 2416.8 2420.5 2422.8 7613.7 8361.5 8422.7 8424.2 8432.6 4717.2 4851.5 5141.1 5240.6 5253.9 3514.1 3579.5 3633.7 3654.8 3655.9 1043.1 1064.2 1075.8 1076.9 1081.2 11218.0 11287.8 11299.4 11305.8 11354.0 4717.5 4724.7 4776.8 4789.8 4792.3 9898.0 9906.6 9925.9 9931.1 9936.3 5258.2 5293.3 5297.0 5297.4 5298.6 4773.4 4815.1 4815.7 4819.7 4839.5 3704.6 3803.6 3804.4 3806.7 3837.5 1222.1 1250.8 1254.9 1258.6 1259.4 1227.7 1355.6 1371.6 1394.1 1418.3 7726.5 7941.0 8030.6 8060.8 8062.4 504.3 510.7 518.2 518.6 519.7 5280.2 5977.9 6062.2 6227.3 6238.5 9532.2 10268.6 10370.1 10385.8 10419.6 10070.6 10250.3 10284.6 10301.9 10314.4 7907.9 7941.8 7948.4 8033.9 8050.6 7784.6 7879.2 7899.3 7919.5 7935.6 9215.9 9307.1 9310.3 9347.9 9372.3 9094.8 9351.8 9459.3 9464.5 9566.0 7400.1 7408.8 7413.6 7454.7 7456.8 8091.8 8138.6 8143.9 8164.2 8168.6 7504.0 7597.5 7668.0 7718.0 7761.1 6692.9 7206.3 7425.6 7435.3 7588.8 7553.6 7595.1 7596.0 7598.2 7608.5 6727.0 6871.1 6928.9 6934.3 6961.4 7016.9 7049.2 7050.2 7053.6 7062.9 01:43:09 INFO - 2015-11-20 01:43:09,023 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,023 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5834.66 Median:6606.86 stddev:1858.98 (28.1%) stddev-sans-first:1817.44 01:43:09 INFO - 2015-11-20 01:43:09,024 DEBUG : BROWSER_OUTPUT: Values: 315.1 317.5 326.8 328.2 328.2 6551.6 6603.3 6628.5 6715.2 6740.8 5401.8 6671.5 6682.0 6684.6 6715.1 4106.2 4713.0 4830.7 4851.0 4959.2 4832.1 4857.5 4929.7 4937.8 4950.3 4834.3 4841.3 4878.5 4898.7 4899.6 4618.8 4735.5 4752.4 4768.8 4908.6 4166.9 4179.0 4183.8 4200.7 4228.9 6348.6 6361.7 6370.6 6381.7 6413.6 5693.6 5791.5 5826.5 5837.4 5847.2 7113.1 7128.8 7144.8 7150.2 7160.0 4340.9 4471.2 4534.7 4735.8 4746.1 6060.5 7302.2 7546.5 7551.4 7557.9 4799.3 4823.8 4827.5 4834.4 4842.8 4899.3 4905.4 4922.8 4924.0 4932.9 5835.8 5836.9 5849.7 5850.1 5856.5 6843.7 7161.9 7162.5 7171.6 7187.1 1677.2 1703.6 1703.7 1706.1 1707.2 1095.3 1100.4 1115.4 1123.6 1123.7 6610.4 6647.0 6662.1 6667.1 6675.3 6073.8 7342.6 7377.8 7415.7 7418.7 6425.5 6435.6 6666.2 6670.9 6673.2 3833.3 3870.6 3870.7 3870.9 3874.3 7609.1 7629.2 7785.6 7792.7 7798.5 7564.8 7799.9 7802.3 7806.6 7826.5 7774.5 7774.9 7777.5 7782.6 7792.8 7487.7 7493.0 7494.4 7502.4 7525.3 6133.6 7030.8 7378.2 7383.5 7389.9 7723.0 7723.3 7731.1 7731.8 7750.6 4830.9 4832.3 4837.4 4837.9 4840.3 6048.5 6368.6 7150.9 7204.0 7479.6 7163.9 7180.6 7182.0 7193.7 7205.1 6915.5 7157.2 7167.4 7172.3 7173.2 6990.1 7003.4 7008.0 7008.0 7017.3 7152.1 7164.5 7164.6 7166.7 7170.1 5676.2 6822.4 6999.5 7017.1 7045.5 01:43:09 INFO - 2015-11-20 01:43:09,024 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,025 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19496.10 Median:4209.56 stddev:28603.34 (679.5%) stddev-sans-first:28648.74 01:43:09 INFO - 2015-11-20 01:43:09,026 DEBUG : BROWSER_OUTPUT: Values: 695.9 726.2 732.6 819.7 828.9 14629.6 15024.7 15077.5 15093.9 15098.9 11921.0 13767.4 13789.7 13947.9 13952.9 761.3 770.2 772.2 949.2 977.1 960.3 962.3 975.8 978.4 981.4 1010.6 1025.3 1026.1 1026.7 1027.3 792.8 802.4 803.4 809.8 1012.3 608.0 751.2 758.6 768.1 768.5 14592.8 14777.0 14787.0 14791.0 14804.6 12195.6 12262.1 12438.5 12505.6 12564.5 9949.5 10080.1 10088.8 10094.5 10097.5 3510.6 3555.4 3564.5 3565.1 3568.4 78156.6 78305.6 79478.6 79956.0 80126.6 9457.8 9515.6 9597.1 9719.3 9739.5 20619.9 20646.7 20669.7 20674.6 20713.7 7325.3 7507.5 7510.3 7669.4 7686.3 3964.5 3972.3 4071.3 4137.5 4164.2 3460.2 3507.2 3507.7 3512.8 3514.4 574.8 575.6 601.0 613.9 624.3 558.9 594.3 607.4 611.9 618.4 8517.1 8691.8 8692.5 8692.6 8802.9 545.2 610.6 616.2 624.7 646.3 3880.2 4112.8 4155.2 4164.7 4254.4 108681.5 108727.5 108950.0 110840.4 111476.4 89477.1 90454.0 90500.1 91100.5 91961.0 65933.0 71383.6 77347.0 77565.0 78323.0 8239.5 8294.3 8415.5 8417.8 8522.4 54218.2 54377.7 54426.7 54993.0 55326.2 66065.3 72411.8 73874.6 74849.0 79651.4 10171.6 10952.9 11118.7 11203.0 11330.7 11923.5 12030.9 12043.8 12092.6 12095.5 11442.1 11484.9 11509.5 11514.9 11540.5 11414.0 11427.3 11432.9 11487.7 11500.2 11199.5 11201.3 11238.5 11244.8 11299.7 9799.4 9820.6 10176.6 10288.9 10338.8 9911.0 10027.6 10102.0 10102.6 10171.3 01:43:09 INFO - 2015-11-20 01:43:09,026 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:43:09 INFO - 2015-11-20 01:43:09,026 DEBUG : BROWSER_OUTPUT: 01:43:09 INFO - 2015-11-20 01:43:09,459 INFO : Browser exited with error code: 0 01:43:09 INFO - 2015-11-20 01:43:09,484 INFO : Completed test dromaeo_css (00:18:34) 01:43:09 INFO - 2015-11-20 01:43:09,484 INFO : Starting test kraken 01:43:09 INFO - 2015-11-20 01:43:09,484 DEBUG : operating with platform_type : mac_ 01:43:09 INFO - 2015-11-20 01:43:09,484 INFO : Initialising browser for kraken test... 01:43:09 INFO - 2015-11-20 01:43:09,496 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmp8ARjjO/profile http://localhost:60687/getInfo.html 01:43:11 INFO - 2015-11-20 01:43:11,505 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:43:11 INFO - 2015-11-20 01:43:11,505 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:43:11 INFO - 2015-11-20 01:43:11,506 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:43:11 INFO - 2015-11-20 01:43:11,506 DEBUG : BROWSER_OUTPUT: __metrics 01:43:11 INFO - 2015-11-20 01:43:11,521 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:43:12 INFO - 2015-11-20 01:43:12,131 INFO : Browser initialized. 01:43:12 INFO - 2015-11-20 01:43:12,131 INFO : Running cycle 1/1 for kraken test... 01:43:12 INFO - 2015-11-20 01:43:12,131 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmp8ARjjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:43:23 INFO - 2015-11-20 01:43:23,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 224735232 01:43:23 INFO - 2015-11-20 01:43:23,951 DEBUG : BROWSER_OUTPUT: 01:43:26 INFO - 2015-11-20 01:43:26,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60687/tests/kraken/driver.html?testName=audio-beat-detection) 01:43:27 INFO - 2015-11-20 01:43:27,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 274866176 01:43:27 INFO - 2015-11-20 01:43:27,072 DEBUG : BROWSER_OUTPUT: 01:43:29 INFO - 2015-11-20 01:43:29,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60687/tests/kraken/driver.html?testName=audio-dft) 01:43:30 INFO - 2015-11-20 01:43:30,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 289771520 01:43:30 INFO - 2015-11-20 01:43:30,359 DEBUG : BROWSER_OUTPUT: 01:43:33 INFO - 2015-11-20 01:43:33,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60687/tests/kraken/driver.html?testName=audio-fft) 01:43:34 INFO - 2015-11-20 01:43:34,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 276480000 01:43:34 INFO - 2015-11-20 01:43:34,396 DEBUG : BROWSER_OUTPUT: 01:43:36 INFO - 2015-11-20 01:43:36,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60687/tests/kraken/driver.html?testName=audio-oscillator) 01:43:36 INFO - 2015-11-20 01:43:36,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 278212608 01:43:36 INFO - 2015-11-20 01:43:36,986 DEBUG : BROWSER_OUTPUT: 01:43:38 INFO - 2015-11-20 01:43:38,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:43:39 INFO - 2015-11-20 01:43:39,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 280281088 01:43:39 INFO - 2015-11-20 01:43:39,565 DEBUG : BROWSER_OUTPUT: 01:43:42 INFO - 2015-11-20 01:43:42,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60687/tests/kraken/driver.html?testName=imaging-darkroom) 01:43:42 INFO - 2015-11-20 01:43:42,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 281288704 01:43:42 INFO - 2015-11-20 01:43:42,864 DEBUG : BROWSER_OUTPUT: 01:43:45 INFO - 2015-11-20 01:43:45,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60687/tests/kraken/driver.html?testName=imaging-desaturate) 01:43:46 INFO - 2015-11-20 01:43:46,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 281554944 01:43:46 INFO - 2015-11-20 01:43:46,248 DEBUG : BROWSER_OUTPUT: 01:43:49 INFO - 2015-11-20 01:43:49,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60687/tests/kraken/driver.html?testName=json-parse-financial) 01:43:49 INFO - 2015-11-20 01:43:49,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 281575424 01:43:49 INFO - 2015-11-20 01:43:49,632 DEBUG : BROWSER_OUTPUT: 01:43:51 INFO - 2015-11-20 01:43:51,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:43:51 INFO - 2015-11-20 01:43:51,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 313311232 01:43:51 INFO - 2015-11-20 01:43:51,710 DEBUG : BROWSER_OUTPUT: 01:43:53 INFO - 2015-11-20 01:43:53,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:43:54 INFO - 2015-11-20 01:43:54,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 315277312 01:43:54 INFO - 2015-11-20 01:43:54,113 DEBUG : BROWSER_OUTPUT: 01:43:56 INFO - 2015-11-20 01:43:56,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:43:56 INFO - 2015-11-20 01:43:56,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 322191360 01:43:56 INFO - 2015-11-20 01:43:56,756 DEBUG : BROWSER_OUTPUT: 01:43:59 INFO - 2015-11-20 01:43:59,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:43:59 INFO - 2015-11-20 01:43:59,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 324526080 01:43:59 INFO - 2015-11-20 01:43:59,874 DEBUG : BROWSER_OUTPUT: 01:44:02 INFO - 2015-11-20 01:44:02,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:44:02 INFO - 2015-11-20 01:44:02,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 322678784 01:44:02 INFO - 2015-11-20 01:44:02,835 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60687/tests/kraken/driver.html?testName=ai-astar) 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 382689280 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;106;109;111;110;98;111;102;111 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;119;162;183;119;152;168;141;174;118 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;201;258;205;186;186;185;186;216;230 01:44:04 INFO - 2015-11-20 01:44:04,835 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;67;76;79;80;82;81;75;71;55 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;88;116;74;75;77;116;74;74;109 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;86;88;87;86;86;87;86;87;88 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;97;94;93;95;94;96;94;94;94 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;104;141;86;86;82;85;84;88;86;84 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;55;55;53;54;56;53;64;52;52 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;65;66;65;67;68;68;69;69 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;81;83;83;81;82;84;83;83;82 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;127;123;123;121;119;121;120;120;132 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;124;134;133;134;123;135;132;125;122 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;67;66;67;63;64;78;86;89 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1052 01:44:04 INFO - 2015-11-20 01:44:04,836 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:44:04 INFO - 2015-11-20 01:44:04,837 DEBUG : BROWSER_OUTPUT: __startTimestamp1448012644833__endTimestamp 01:44:04 INFO - 2015-11-20 01:44:04,837 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,840 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:44:04 INFO - 2015-11-20 01:44:04,840 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:44:04 INFO - 2015-11-20 01:44:04,840 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,840 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:110.50 stddev:4.42 (4.0%) stddev-sans-first:4.67 01:44:04 INFO - 2015-11-20 01:44:04,840 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 106.0 109.0 111.0 110.0 98.0 111.0 102.0 111.0 01:44:04 INFO - 2015-11-20 01:44:04,840 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:157.00 stddev:23.90 (15.2%) stddev-sans-first:25.35 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: Values: 149.0 119.0 162.0 183.0 119.0 152.0 168.0 141.0 174.0 118.0 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:203.70 Median:203.00 stddev:24.67 (12.2%) stddev-sans-first:25.12 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: Values: 184.0 201.0 258.0 205.0 186.0 186.0 185.0 186.0 216.0 230.0 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.40 Median:77.50 stddev:8.37 (10.8%) stddev-sans-first:8.65 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 76.0 79.0 80.0 82.0 81.0 75.0 71.0 55.0 01:44:04 INFO - 2015-11-20 01:44:04,841 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,842 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.60 Median:74.50 stddev:17.98 (24.1%) stddev-sans-first:18.95 01:44:04 INFO - 2015-11-20 01:44:04,842 DEBUG : BROWSER_OUTPUT: Values: 83.0 88.0 116.0 74.0 75.0 77.0 116.0 74.0 74.0 109.0 01:44:04 INFO - 2015-11-20 01:44:04,842 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,842 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 01:44:04 INFO - 2015-11-20 01:44:04,842 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 88.0 87.0 86.0 86.0 87.0 86.0 87.0 88.0 01:44:04 INFO - 2015-11-20 01:44:04,842 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,842 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.24 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: Values: 93.0 97.0 94.0 93.0 95.0 94.0 96.0 94.0 94.0 94.0 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:92.60 Median:85.50 stddev:18.08 (21.1%) stddev-sans-first:18.70 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: Values: 104.0 141.0 86.0 86.0 82.0 85.0 84.0 88.0 86.0 84.0 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:3.54 (6.4%) stddev-sans-first:3.69 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: Values: 57.0 55.0 55.0 53.0 54.0 56.0 53.0 64.0 52.0 52.0 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.50 stddev:1.84 (2.7%) stddev-sans-first:1.69 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 66.0 65.0 67.0 68.0 68.0 69.0 69.0 01:44:04 INFO - 2015-11-20 01:44:04,844 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: Values: 82.0 81.0 83.0 83.0 81.0 82.0 84.0 83.0 83.0 82.0 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:122.00 stddev:4.12 (3.4%) stddev-sans-first:4.17 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: Values: 119.0 127.0 123.0 123.0 121.0 119.0 121.0 120.0 120.0 132.0 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.70 Median:133.50 stddev:5.46 (4.1%) stddev-sans-first:5.44 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: Values: 135.0 124.0 134.0 133.0 134.0 123.0 135.0 132.0 125.0 122.0 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:67.00 stddev:9.66 (14.4%) stddev-sans-first:10.00 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 67.0 66.0 67.0 63.0 64.0 78.0 86.0 89.0 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:44:04 INFO - 2015-11-20 01:44:04,845 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-11-20 01:44:05,497 INFO : Browser exited with error code: 0 01:44:05 INFO - 2015-11-20 01:44:05,544 INFO : Completed test kraken (00:00:56) 01:44:05 INFO - 2015-11-20 01:44:05,544 INFO : Starting test v8_7 01:44:05 INFO - 2015-11-20 01:44:05,544 DEBUG : operating with platform_type : mac_ 01:44:05 INFO - 2015-11-20 01:44:05,544 INFO : Initialising browser for v8_7 test... 01:44:05 INFO - 2015-11-20 01:44:05,555 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpLUCglt/profile http://localhost:60687/getInfo.html 01:44:07 INFO - 2015-11-20 01:44:07,625 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:44:07 INFO - 2015-11-20 01:44:07,625 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:44:07 INFO - 2015-11-20 01:44:07,625 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:44:07 INFO - 2015-11-20 01:44:07,625 DEBUG : BROWSER_OUTPUT: __metrics 01:44:07 INFO - 2015-11-20 01:44:07,641 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:44:08 INFO - 2015-11-20 01:44:08,457 INFO : Browser initialized. 01:44:08 INFO - 2015-11-20 01:44:08,458 INFO : Running cycle 1/1 for v8_7 test... 01:44:08 INFO - 2015-11-20 01:44:08,458 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpLUCglt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:44:20 INFO - 2015-11-20 01:44:20,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 224194560 01:44:20 INFO - 2015-11-20 01:44:20,346 DEBUG : BROWSER_OUTPUT: 01:44:41 INFO - 2015-11-20 01:44:41,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60687/tests/v8_7/run.html (next: http://localhost:60687/tests/v8_7/run.html) 01:44:42 INFO - 2015-11-20 01:44:42,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 720068608 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |0;Richards;146.0493646852636 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.95284081764044 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.56569652444193 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4784.688995215311 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1694.915254237288 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 01:44:42 INFO - 2015-11-20 01:44:42,048 DEBUG : BROWSER_OUTPUT: |6;Boyer;14400 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: |8;Splay;962.4639076034649 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4533.93665158371 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: __startTimestamp1448012682046__endTimestamp 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.05 Median:146.05 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,049 DEBUG : BROWSER_OUTPUT: Values: 146.0 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.95 Median:160.95 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: Values: 161.0 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: Values: 282.6 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4784.69 Median:4784.69 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: Values: 4784.7 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1694.92 Median:1694.92 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: Values: 1694.9 01:44:42 INFO - 2015-11-20 01:44:42,050 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: Values: 788.6 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14400.00 Median:14400.00 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: Values: 14400.0 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: Values: 26921.1 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: Values: 962.5 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,051 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4533.94 Median:4533.94 stddev:0.00 (0.0%) 01:44:42 INFO - 2015-11-20 01:44:42,052 DEBUG : BROWSER_OUTPUT: Values: 4533.9 01:44:42 INFO - 2015-11-20 01:44:42,052 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:44:42 INFO - 2015-11-20 01:44:42,052 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-20 01:44:42,748 INFO : Browser exited with error code: 0 01:44:42 INFO - 2015-11-20 01:44:42,765 INFO : Completed test v8_7 (00:00:37) 01:44:43 INFO - 2015-11-20 01:44:43,129 INFO : Completed test suite (00:20:07) 01:44:43 INFO - 2015-11-20 01:44:43,129 DEBUG : Working with test: dromaeo_css 01:44:43 INFO - 2015-11-20 01:44:43,130 DEBUG : Generating results file: dromaeo_css 01:44:43 INFO - 2015-11-20 01:44:43,130 DEBUG : Working with test: kraken 01:44:43 INFO - 2015-11-20 01:44:43,130 DEBUG : Generating results file: kraken 01:44:43 INFO - 2015-11-20 01:44:43,131 INFO : javascript benchmark 01:44:43 INFO - 2015-11-20 01:44:43,131 DEBUG : Working with test: v8_7 01:44:43 INFO - 2015-11-20 01:44:43,131 DEBUG : Generating results file: v8_7 01:44:43 INFO - 2015-11-20 01:44:43,131 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:44:43 INFO - 2015-11-20 01:44:43,510 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 01:44:43 INFO - 2015-11-20 01:44:43,511 DEBUG : process_Request line: dromaeo_css 7566.27 graph.html#tests=[[72,64,59]] 01:44:43 INFO - 2015-11-20 01:44:43,511 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:44:43 INFO - 2015-11-20 01:44:43,539 DEBUG : process_Request line: kraken 1423.00 graph.html#tests=[[232,64,59]] 01:44:43 INFO - 2015-11-20 01:44:43,539 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:44:43 INFO - 2015-11-20 01:44:43,563 DEBUG : process_Request line: v8_7 19677.44 graph.html#tests=[[230,64,59]] 01:44:43 INFO - 2015-11-20 01:44:43,564 INFO : javascript benchmark 01:44:43 INFO - 2015-11-20 01:44:43,566 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3444.7416443766715, 3479.8608055677773, 3519.2081781599127, 3527.5766907971047, 3549.1304630365566, 5712.542996560275, 5860.941390586093, 6020.307664618565, 6076.361981991888, 6081.78713745019, 5961.135635332874, 5971.223740913686, 5979.222701048869, 6047.092936059593, 6124.969375153118, 5392.0, 5442.619016668835, 5443.564514838823, 5472.398036216013, 5477.75350109246, 5527.364353099385, 5575.916361254584, 5582.581306402016, 5587.944120558783, 5616.66300022, 5282.788688452457, 5398.946010539884, 5414.998225328327, 5519.254900588429, 5543.279373681416, 5443.183522471661, 5463.0, 5466.180072989044, 5467.589930755209, 5480.862978425532, 5262.131748261532, 5375.193720941851, 5416.268803711488, 5417.945820541783, 5438.619296649196, 5919.348871624118, 5958.910616340759, 5960.552958528127, 5963.701814909237, 6020.458158765732, 6323.004199064561, 6347.555671103025, 6364.586301890362, 6370.108184854124, 6376.39424254695, 6176.96911515444, 6244.781432649881, 6309.558330916838, 6313.621182729005, 6419.486441084702, 6089.573729838913, 6105.481034112106, 6108.816735497942, 6119.258838874149, 6123.877522449615, 6396.168498095218, 6425.228972523327, 6491.253505846794, 6496.967515162394, 6505.349465053551, 6289.591176573508, 6298.559100862987, 6302.842428939313, 6305.180326557518, 6313.273973493107, 5806.216160818235, 5889.880922624688, 6424.775132870327, 6425.004124360731, 6442.259140198843, 6154.076888466766, 6245.313015568284, 6256.937430625636, 6259.311475737665, 6272.905906411407, 6253.405926436982, 6300.1494798202575, 6303.873922521616, 6318.905216421757, 6324.747010119544, 4957.90084198314, 5061.670991385548, 5108.923366149511, 5119.87200319995, 5171.4052883918075, 4588.105319462673, 4631.606313463326, 4664.813407463731, 4670.813167473331, 4676.859694209179, 6008.429199226067, 6016.458518733335, 6022.45797878193, 6022.819315420545, 6028.246469191351, 6284.937150628527, 6298.307186209513, 6303.495720342362, 6307.432331090224, 6307.968460157762, 5930.851728706817, 5993.400659934059, 5999.910001349983, 6005.3394126646035, 6026.126211699367, 5452.263944367539, 5566.832995010156, 5575.275214222125, 5586.441355864381, 5597.8600534986135, 6410.967945160244, 6426.550141490051, 6465.127207826883, 6492.993585994179, 6590.505712071518, 6411.3909178627955, 6416.839579010375, 6442.162518872517, 6444.967775161094, 6447.0, 6564.770233041821, 6565.310642382481, 6589.110470086477, 6589.242237142598, 6589.7364105435245, 6179.258488981351, 6185.257769067741, 6277.18396608438, 6285.182926219562, 6300.338464461165, 6359.682015899279, 6375.107484952017, 6396.520260980538, 6399.6800159992745, 6404.199475065617, 6283.685815709105, 6293.685315734287, 6296.0555916612875, 6303.653299068412, 6322.0516922462, 6118.923762351665, 6139.6009259398, 6218.22272215973, 6235.095911092957, 6264.248290205204, 6225.750969961151, 6248.218972628421, 6270.184875966095, 6297.464715499051, 6299.149614801943, 6186.19579454668, 6342.587731797418, 6343.873122537616, 6353.3011368748475, 6362.681865906594, 5178.8964220716125, 5980.28236611592, 6082.817515474543, 6115.541334400027, 6125.908111378422], "unit": "ms", "name": "dojo.html", "value": 5891.578339237705}, {"lowerIsBetter": false, "replicates": [539.935207775067, 550.1939658400443, 621.1459243540133, 639.7760783725697, 661.3948237362813, 32095.518567221512, 32598.348033039325, 32674.67325326746, 32709.836450817744, 41599.96000099999, 44162.89592760183, 44552.88617784549, 44755.0, 44759.552404475944, 44779.55220447794, 9618.903810961889, 9791.951040244825, 9796.412215267106, 9798.314118011742, 9819.705408837746, 8793.428427152214, 8896.688615898445, 8920.375573709844, 9597.66408175714, 11802.173847830656, 11633.243839150471, 11715.179937404386, 11742.823857642143, 11742.882571174265, 11753.706157346092, 11654.8251776223, 11709.297442153498, 11709.824352634718, 11710.648680539598, 11717.53129874804, 8720.651173953098, 8832.381733278673, 8834.983976842617, 8841.955790221007, 8848.424852384574, 43023.0, 43037.78481107606, 43433.0, 43585.56414435847, 43745.562544374465, 3307.4873394623874, 3408.1820363112924, 3425.9143521411916, 3868.8065596720335, 3920.157166209279, 28273.0, 28989.855050724822, 29096.418071638447, 29475.852620736758, 29653.406931861457, 2853.7003614620376, 2857.7428031477057, 2889.479893619148, 2926.9121926342245, 3004.8948286809855, 386641.06679466704, 427961.0, 508554.0, 509533.0, 511821.0, 64389.03416448757, 64803.67598161979, 64854.02718959219, 65002.67498662476, 65009.34990650127, 68646.65676671684, 69055.96416053764, 69057.0, 69123.0, 69134.0, 16377.344906203618, 16778.916105419637, 16933.407330743365, 17002.829971700372, 17009.404670836462, 12850.678733031562, 12898.097133200587, 12916.41876115577, 12926.159799612995, 12927.28899910495, 19474.805251947582, 20055.699164512545, 20100.899495502428, 20113.899430502755, 20157.899210503852, 8179.304759095544, 9435.528223588793, 9705.854412183822, 9709.621142820055, 9720.368176068674, 989.9010098990043, 997.436448406648, 1013.9695809125737, 1054.330500132406, 1132.818749000156, 29832.40335193284, 30339.69660303413, 30380.24049398783, 30601.540976885364, 30822.229444263623, 944.6835310171169, 1083.7724077943562, 1090.2749671468544, 1124.4827379405401, 1136.2216881436243, 14281.500147494788, 14641.414343426357, 14672.75281601076, 15252.466163684217, 15958.28472866122, 537425.0, 540432.0, 541305.293473538, 543523.0, 545611.2719436378, 59239.0, 59460.0, 59535.404645952985, 59638.210853674456, 59794.0, 1299.311364976564, 1319.129374612751, 1361.686812033218, 1475.5942115917994, 1475.7196132734746, 23335.41661458477, 23919.641205382282, 30094.84952575223, 30310.393792124476, 30549.389012220076, 55970.0, 56158.71920640371, 56337.71831140818, 56362.0, 56400.0, 481194.0, 484444.0, 548346.0, 628822.0, 631266.0, 29996.250093747833, 30184.09447716572, 30293.242668933453, 30405.543916841707, 30437.695623043484, 42535.57464425316, 43012.924676882074, 43020.35469468023, 43353.783231083646, 44235.89410264769, 30375.696243037288, 36213.27573448569, 36573.817130914176, 36654.26691466102, 37605.0, 29059.854700726362, 35884.0, 35952.64047359493, 36563.72026979043, 37559.0, 35389.0, 35606.0, 35657.82171089128, 36007.45988810118, 36097.45853812143, 30871.2282192938, 33227.83386083054, 33276.1680957978, 33359.0, 33452.665473344954, 24605.50788984246, 24747.50504989854, 24875.0, 24876.62685059762, 24939.501209975337], "unit": "ms", "name": "ext.html", "value": 20257.106110539855}, {"lowerIsBetter": false, "replicates": [299.78115975338005, 355.38873138202297, 357.11257525050246, 358.65927368999456, 360.6015353034896, 16220.756688649679, 16582.83417165828, 19756.802431975677, 20275.797242027576, 21218.89390553047, 17864.732029019542, 21133.57732845346, 21506.354809355704, 21588.028538715756, 21635.026423810927, 5622.775088996435, 5925.703714814264, 5936.0, 5938.287405511344, 5947.345791962881, 4234.640055595278, 4343.9565604344025, 5917.023691090986, 5964.015937370329, 5971.104334349839, 6199.380061993787, 6311.589746666475, 6370.649614271213, 6376.330485299047, 6384.648844313584, 6222.688865556704, 6352.333005034474, 6452.4192822645955, 6453.322401147859, 6461.386168314003, 5585.273914391144, 5611.915821262684, 5612.07400778871, 5615.5507559395555, 5626.352969408488, 26092.73907260922, 26331.473370532673, 26591.46817063648, 26634.467310653872, 26828.865855670792, 1961.4704029911986, 2135.3060255416895, 2280.897359618821, 2309.90760369585, 2392.784649381564, 9303.162715355582, 9551.283653725928, 9726.610935562569, 9743.756406089833, 15299.311530981133, 1726.7064599018197, 1730.0917018565228, 1730.1003478191396, 1760.8327208915132, 1787.928482860684, 87345.0, 101685.49157254166, 104644.0, 108719.0, 109042.0, 10569.894301057046, 10601.575936962436, 10644.414557199429, 10675.0, 10854.837177442345, 12665.430055647517, 12689.428975696115, 12691.619251422471, 12695.746085078246, 12710.809337859939, 8331.583420828934, 8405.360954613914, 8409.537475438787, 8467.661293548312, 8471.025832029396, 8553.802467654534, 8580.785480363042, 8627.784305392415, 8666.393352465393, 8683.739487815375, 3884.106655469258, 4195.244855925963, 4231.788410579458, 4248.87253382399, 4303.225419424533, 1653.2147230065864, 1697.73685078813, 1738.8435040846384, 1747.8339557741995, 1785.1074462768615, 396.4251834839494, 396.7242766277467, 416.90202802341423, 974.8058628180422, 986.5264672957021, 11282.492287847066, 11664.500510948094, 11857.347845868388, 11944.0, 12042.337671428155, 394.6783371552233, 426.34768803730344, 435.4904761429072, 443.2553310438494, 445.03427562190126, 5936.7031648417405, 6049.122877182784, 6085.421884920926, 6095.756169753249, 6109.75560977556, 761001.0, 765653.0, 774964.0, 780643.0, 782450.0, 129312.0, 132157.0, 132703.0, 132884.0, 133597.3320133393, 476.62108623643593, 481.5978657820689, 481.66283601478403, 482.83100914680284, 483.0869656349432, 10906.182036347147, 11006.95433933775, 11039.944800275947, 11096.500657470271, 11108.944455277671, 50527.74736126296, 51237.74381128071, 51340.0, 51372.74313628408, 51590.22614660708, 71113.0, 74512.62743686247, 76484.3515648453, 76846.0, 77831.0, 9595.90404095978, 9664.613415463302, 9937.602495900082, 9940.850887236553, 9943.751406214902, 11756.70608234801, 11891.989180919718, 11904.880951190724, 11918.986886114777, 11958.880411195776, 14943.701125977203, 16161.515154545383, 16219.675606488041, 16538.751918720987, 16671.91664041672, 15808.76286855675, 15918.60203494922, 16105.0, 16137.354505819636, 16744.41394551185, 13220.140690855063, 14522.854771452572, 16489.91755041217, 16572.0, 17151.0, 9764.951175244078, 9878.753031174278, 9992.150667193078, 10033.49832508357, 10200.234982376203, 16200.351985920432, 16286.918565407097, 16711.498655040366, 16752.832471675614, 16799.91600041992], "unit": "ms", "name": "jquery.html", "value": 9017.805160332407}, {"lowerIsBetter": false, "replicates": [1555.1679851279564, 1614.790077289952, 1658.361530810638, 1906.4852489827747, 2022.7876073012324, 7193.71225150994, 7442.441816863737, 7873.212678732131, 8573.271271941892, 8584.527850968194, 8259.463134896228, 8394.958025209866, 8430.0, 8467.195616416431, 8492.108328625498, 2380.155044959045, 2401.855888646678, 2404.663347131403, 2406.2660888429023, 2406.651035599837, 2421.285720712394, 2440.3777036855668, 2441.5849305618, 2447.204658485999, 2448.51029794041, 2139.60417322795, 2346.8617720405673, 2372.039324073753, 2399.172285561487, 2401.363638635763, 2335.556244313575, 2340.8361414700976, 2351.95296094078, 2352.447174913885, 2399.0283935006178, 2384.260879127476, 2405.0740464920955, 2416.794572461343, 2420.5037967216854, 2422.8304018718695, 7613.695452181906, 8361.456505327134, 8422.705205317785, 8424.241818236327, 8432.578371081421, 4717.150912835688, 4851.490593487668, 5141.126008578551, 5240.554552863011, 5253.9474605253845, 3514.0687717754818, 3579.516765236686, 3633.6729694327373, 3654.8355324010217, 3655.9268814623824, 1043.0664555223034, 1064.1539975719322, 1075.7687097274045, 1076.9192310576739, 1081.2429801572446, 11217.971147790133, 11287.830682539769, 11299.435028248638, 11305.830412543819, 11354.0, 4717.481077081518, 4724.716517008922, 4776.832810851603, 4789.808407663724, 4792.305115758265, 9897.950510247403, 9906.55420506079, 9925.851112233322, 9931.106200441995, 9936.304458687822, 5258.158694608845, 5293.311869456946, 5296.973515132399, 5297.390800058042, 5298.576113910878, 4773.355596994431, 4815.061063092663, 4815.686980346266, 4819.734914579662, 4839.540243676845, 3704.5554533456157, 3803.6497043549143, 3804.410316400962, 3806.657400833938, 3837.501124853751, 1222.10175520992, 1250.7748605251143, 1254.9372531373576, 1258.5657948007922, 1259.4332550352194, 1227.7053507158396, 1355.5594431809702, 1371.5885234429632, 1394.065975796219, 1418.326295009862, 7726.459147859596, 7941.0, 8030.638621262057, 8060.798480038046, 8062.435629505878, 504.29902435614525, 510.6553076673231, 518.225253246399, 518.5747686896708, 519.7297405349198, 5280.181571856291, 5977.940220597825, 6062.181605483292, 6227.252729672468, 6238.469730072904, 9532.237421006303, 10268.58925642966, 10370.11853992404, 10385.792284154426, 10419.583216671399, 10070.59717611302, 10250.282480226462, 10284.640037598798, 10301.896981030244, 10314.43270620123, 7907.881381779278, 7941.761747147595, 7948.364130869517, 8033.879491807627, 8050.59747012647, 7784.5718485481575, 7879.212078792304, 7899.328557072483, 7919.485233459806, 7935.642896069575, 9215.907840921505, 9307.06929307064, 9310.255179585753, 9347.859782103138, 9372.297077719062, 9094.772630684285, 9351.812963740824, 9459.337846350689, 9464.479453630116, 9565.952170239383, 7400.148982867039, 7408.777736667908, 7413.629318534159, 7454.701811927463, 7456.813579660552, 8091.797705057185, 8138.633761480629, 8143.877841832259, 8164.183581641788, 8168.632411541376, 7504.024476817979, 7597.506162099446, 7667.961660191663, 7718.035245594301, 7761.107472640719, 6692.933070669231, 7206.315400036988, 7425.591592462466, 7435.293647103516, 7588.772336829904, 7553.584552849646, 7595.08858936909, 7595.962020189863, 7598.164201937672, 7608.505447145918, 6726.966365168339, 6871.072405225231, 6928.930710692828, 6934.341237582422, 6961.443084553122, 7016.894746578703, 7049.224585295716, 7050.189228238613, 7053.612051337226, 7062.858742825218], "unit": "ms", "name": "mootools.html", "value": 4744.23998073667}, {"lowerIsBetter": false, "replicates": [315.07054190139087, 317.5078628126403, 326.80228461780615, 328.1517277836792, 328.2417615308636, 6551.574147680403, 6603.306652801459, 6628.536002479828, 6715.213186527585, 6740.831479213022, 5401.78392864286, 6671.49963752718, 6682.0, 6684.632345221011, 6715.127033485653, 4106.240345536085, 4712.952870471303, 4830.73430961297, 4850.951490485085, 4959.181735013718, 4832.130216561018, 4857.465678775332, 4929.679570827902, 4937.77779999899, 4950.257461380804, 4834.323194752737, 4841.3464182335465, 4878.512148785111, 4898.681585696918, 4899.583535399477, 4618.838340658078, 4735.455422626407, 4752.382190315237, 4768.785404656799, 4908.607311415096, 4166.937495937564, 4178.979105104486, 4183.811728472226, 4200.726952748092, 4228.851990180359, 6348.619082855043, 6361.713722882481, 6370.649614271213, 6381.712822922979, 6413.551051426402, 5693.615729886124, 5791.478766910998, 5826.504747096502, 5837.35789063207, 5847.181394604716, 7113.110861142357, 7128.821779455503, 7144.785656430316, 7150.1777295611155, 7160.0, 4340.91318173638, 4471.217536931056, 4534.659900507475, 4735.83424580138, 4746.121967436035, 6060.454559089703, 7302.160251571084, 7546.509476883985, 7551.358134558569, 7557.886631700529, 4799.328094066834, 4823.831165909176, 4827.468978412372, 4834.444038935497, 4842.757862106881, 4899.314096026559, 4905.435874874435, 4922.803087876517, 4924.03981223658, 4932.8766780830765, 5835.795747148914, 5836.8540786479825, 5849.707514624251, 5850.063989761703, 5856.472917437451, 6843.657817109125, 7161.928380716126, 7162.46281528877, 7171.605561694157, 7187.101612298463, 1677.2117104960648, 1703.6252024554578, 1703.7444383342597, 1706.1128213329248, 1707.1549582956516, 1095.3209010413436, 1100.3947828694186, 1115.4478533126155, 1123.5618108937522, 1123.6685177872548, 6610.4050635443045, 6647.0, 6662.133922590032, 6667.099941507931, 6675.332466753286, 6073.75704971805, 7342.632868356561, 7377.81555461107, 7415.740449084256, 7418.703251869865, 6425.518086143465, 6435.581687190412, 6666.200055993215, 6670.933290667128, 6673.232578253563, 3833.2525157594, 3870.632289932452, 3870.6709929656295, 3870.9225815483533, 3874.3026255273758, 7609.086909570887, 7629.19893411195, 7785.5985922533355, 7792.727254546064, 7798.454108212371, 7564.773056808304, 7799.883001754978, 7802.336801371834, 7806.648700808477, 7826.530408175528, 7774.533527988338, 7774.92225077742, 7777.455578109591, 7782.571958542335, 7792.844143117106, 7487.737929172453, 7492.9625351875075, 7494.437917156344, 7502.36229920441, 7525.285097915689, 6133.631982080911, 7030.824229394101, 7378.225286344857, 7383.520071195355, 7389.926100739139, 7722.961385193263, 7723.34351580122, 7731.072271327476, 7731.7680469586, 7750.573718445539, 4830.855074347775, 4832.275158726219, 4837.443693975238, 4837.927431088607, 4840.322354870392, 6048.455638992512, 6368.554201205871, 7150.928490715026, 7204.027456293334, 7479.588622625808, 7163.892541611985, 7180.60506672138, 7181.964090179516, 7193.748218812317, 7205.135383753983, 6915.481338899502, 7157.1769246537315, 7167.3549380556, 7172.282771722786, 7173.175084865307, 6990.126234220723, 7003.404710599656, 7007.964960175166, 7008.018877357072, 7017.298270173146, 7152.141742990666, 7164.498485105993, 7164.605946672983, 7166.677499512639, 7170.103737032871, 5676.2337084493065, 6822.351876571718, 6999.51003429755, 7017.087778588751, 7045.471589630695], "unit": "ms", "name": "prototype.html", "value": 5213.736090919357}, {"lowerIsBetter": false, "replicates": [695.9304069593042, 726.1975517053652, 732.6373445144653, 819.6516480495787, 828.8881001064856, 14629.561113166608, 15024.699506009887, 15077.472288469906, 15093.92453037736, 15098.924505377472, 11921.046316294698, 13767.449302027906, 13789.655258618539, 13947.930260348685, 13952.93023534881, 761.3262262897348, 770.2413123073768, 772.2007722007695, 949.2453499467922, 977.0717818072824, 960.255801753643, 962.3023308101606, 975.8438649816031, 978.3591747405461, 981.4258658684678, 1010.5604062232916, 1025.2720568396448, 1026.1482969135636, 1026.712520494263, 1027.2706378471257, 792.809725665839, 802.3941923847516, 803.4335793265734, 809.805646644801, 1012.2762225009117, 607.9937703101374, 751.1812124784012, 758.5789886612928, 768.0859776865512, 768.5081547809407, 14592.781108283385, 14777.0, 14787.0, 14791.038582492103, 14804.555863324009, 12195.573154939624, 12262.141650084497, 12438.502459901592, 12505.624831255076, 12564.497420103186, 9949.452780097092, 10080.092791648713, 10088.848667269996, 10094.545745441474, 10097.495125243708, 3510.613832478425, 3555.3600351936643, 3564.518789963348, 3565.144365352323, 3568.4290513517712, 78156.60921695412, 78305.60847195728, 79478.60260698717, 79956.0, 80126.59936700338, 9457.763555911157, 9515.619375224913, 9597.136257736836, 9719.266391836552, 9739.464329461805, 20619.896900515403, 20646.690299645517, 20669.689954650694, 20674.62241842177, 20713.68929466059, 7325.304096110861, 7507.474476786572, 7510.324070833652, 7669.3864490841715, 7686.308232259012, 3964.5044369453817, 3972.2651309507833, 4071.267171909085, 4137.482814648169, 4164.167166566699, 3460.186856088817, 3507.228409749851, 3507.7369197310304, 3512.7892326459983, 3514.4376899695926, 574.8160588611604, 575.6459777236969, 600.9579329446897, 613.929398119213, 624.2976651267325, 558.8854284871592, 594.2868557730654, 607.3926073926074, 611.8894207014255, 618.4495798739126, 8517.06312305646, 8691.782705432415, 8692.478451292942, 8692.550445625693, 8802.911970880337, 545.2285016701402, 610.5970059760537, 616.1989413762092, 624.6595605395071, 646.2632598837329, 3880.2239552089695, 4112.773797441169, 4155.210510003089, 4164.708470407042, 4254.404383386328, 108681.45659271652, 108727.45636271927, 108950.0, 110840.4457977721, 111476.44261778801, 89477.10522894817, 90454.0, 90500.09499905049, 91100.5444972771, 91961.0, 65933.01100483496, 71383.57232855314, 77347.0, 77565.0, 78323.0, 8239.546824924686, 8294.253517183482, 8415.53714545706, 8417.789555260922, 8522.36082293818, 54218.186727199914, 54377.72811135919, 54426.727866360416, 54993.0, 55326.17010744922, 66065.33934660784, 72411.82764517074, 73874.63062684653, 74849.0, 79651.40697186139, 10171.64399246023, 10952.945235273774, 11118.722031949266, 11203.0, 11330.660080197607, 11923.523059077539, 12030.879691202976, 12043.75912481763, 12092.637220883387, 12095.516179353079, 11442.141839361915, 11484.94257528707, 11509.482073306888, 11514.94242528782, 11540.480678369326, 11414.0, 11427.257228280136, 11432.885671143182, 11487.712807179887, 11500.194986351209, 11199.496022678835, 11201.271917325348, 11238.51606002142, 11244.775104497701, 11299.717507062389, 9799.363041402286, 9820.607175712892, 10176.643817466353, 10288.942211557569, 10338.844917326396, 9910.950445247727, 10027.560313149042, 10102.040306170902, 10102.646407375707, 10171.338862973884], "unit": "ms", "name": "yui.html", "value": 7047.428283393443}], "name": "dromaeo_css", "value": 7566.271837054413}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 109.0, 111.0, 110.0, 98.0, 111.0, 102.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [149.0, 119.0, 162.0, 183.0, 119.0, 152.0, 168.0, 141.0, 174.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [184.0, 201.0, 258.0, 205.0, 186.0, 186.0, 185.0, 186.0, 216.0, 230.0], "unit": "ms", "name": "audio-dft", "value": 203.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 76.0, 79.0, 80.0, 82.0, 81.0, 75.0, 71.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 73.4}, {"lowerIsBetter": true, "replicates": [83.0, 88.0, 116.0, 74.0, 75.0, 77.0, 116.0, 74.0, 74.0, 109.0], "unit": "ms", "name": "audio-oscillator", "value": 88.6}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 87.0, 86.0, 86.0, 87.0, 86.0, 87.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 97.0, 94.0, 93.0, 95.0, 94.0, 96.0, 94.0, 94.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.4}, {"lowerIsBetter": true, "replicates": [104.0, 141.0, 86.0, 86.0, 82.0, 85.0, 84.0, 88.0, 86.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 92.6}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 53.0, 54.0, 56.0, 53.0, 64.0, 52.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 67.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 83.0, 81.0, 82.0, 84.0, 83.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [119.0, 127.0, 123.0, 123.0, 121.0, 119.0, 121.0, 120.0, 120.0, 132.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [135.0, 124.0, 134.0, 133.0, 134.0, 123.0, 135.0, 132.0, 125.0, 122.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 129.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 66.0, 67.0, 63.0, 64.0, 78.0, 86.0, 89.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1423.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.0493646852636], "unit": "score", "name": "Richards", "value": 241.71279399999992}, {"lowerIsBetter": false, "replicates": [160.95284081764044], "unit": "score", "name": "DeltaBlue", "value": 410.791134}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [4784.688995215311], "unit": "score", "name": "Decrypt", "value": 55.63182899999996}, {"lowerIsBetter": false, "replicates": [1694.915254237288], "unit": "score", "name": "RayTrace", "value": 436.59351000000004}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [14400.0], "unit": "score", "name": "Boyer", "value": 46.282152777777746}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "Splay", "value": 84.66914900000003}, {"lowerIsBetter": false, "replicates": [4533.93665158371], "unit": "score", "name": "NavierStokes", "value": 327.3093812375252}], "name": "v8_7", "value": 19677.43980747405}]} 01:44:43 INFO - RETURN: dromaeo_css: 7566.27 01:44:43 INFO - RETURN: kraken: 1423.00 01:44:43 INFO - RETURN: v8_7: 19677.44 01:44:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "19677.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1423.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7566.27"}}} 01:44:43 INFO - Return code: 0 01:44:43 INFO - # TBPL SUCCESS # 01:44:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:44:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:44:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:44:43 INFO - 2015-11-20 01:44:43.640 screenresolution[2854:88129] starting screenresolution argv=screenresolution get 01:44:43 INFO - 2015-11-20 01:44:43.642 screenresolution[2854:88129] Display 0: 1600x1200x32@60 01:44:43 INFO - 2015-11-20 01:44:43.648 screenresolution[2855:88132] starting screenresolution argv=screenresolution list 01:44:43 INFO - Available Modes on Display 0 01:44:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:44:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:44:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:44:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:44:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:44:43 INFO - Intel Iris: 01:44:43 INFO - Chipset Model: Intel Iris 01:44:43 INFO - Type: GPU 01:44:43 INFO - Bus: Built-In 01:44:43 INFO - VRAM (Dynamic, Max): 1536 MB 01:44:43 INFO - Vendor: Intel (0x8086) 01:44:43 INFO - Device ID: 0x0a2e 01:44:43 INFO - Revision ID: 0x0009 01:44:43 INFO - Displays: 01:44:43 INFO - Display: 01:44:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:44:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:44:43 INFO - Display Serial Number: 1600x1200 60 01:44:43 INFO - Main Display: Yes 01:44:43 INFO - Mirror: Off 01:44:43 INFO - Online: Yes 01:44:43 INFO - Rotation: Supported 01:44:43 INFO - Return code: 0 01:44:43 INFO - Running post-action listener: _resource_record_post_action 01:44:43 INFO - Running post-run listener: _resource_record_post_run 01:44:44 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 0; Write bytes: 689730048; Read time: 0; Write time: 2378 01:44:44 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336286208; Write bytes: 338408448; Read time: 26100; Write time: 657 01:44:44 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 0; Write bytes: 340110848; Read time: 0; Write time: 1684 01:44:44 INFO - Running post-run listener: _upload_blobber_files 01:44:44 INFO - Blob upload gear active. 01:44:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:44:44 INFO - Copying logs to upload dir... 01:44:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1382.182409 ========= master_lag: 8.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2015-11-20 01:44:53.073385) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:44:53.074601) ========= 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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010106 build_url: 'https://queue.taskcluster.net/v1/task/ZDCMBZn0T9yKGfUPcBkzgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.61 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:44:53.690789) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-20 01:44:53.691080) ========= 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.lucCKBy3Zb/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.YEoO8k0w8l/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.005488 ========= master_lag: 4.65 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-20 01:44:58.342236) ========= ========= Started reboot skipped (results: 3, elapsed: 9 secs) (at 2015-11-20 01:44:58.342528) ========= ========= Finished reboot skipped (results: 3, elapsed: 9 secs) (at 2015-11-20 01:45:07.441848) ========= ========= Total master_lag: 13.52 =========