builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0024 starttime: 1447865619.82 results: success (0) buildid: 20151117113504 builduid: c24efe3037a4408886b2077dc045f3b8 revision: 02919b7d57d7f8206328f53ac0f7b2b9fe334c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:39.820944) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:39.821309) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:39.821588) ========= 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.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006269 basedir: '/builds/slave/test' ========= master_lag: 0.56 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.383628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.383936) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.418033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.418478) ========= 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.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.023579 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.468933) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.469245) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.469631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.472952) ========= 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.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False --2015-11-18 08:53:40-- 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% 7.21M=0.002s 2015-11-18 08:53:40 (7.21 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.221630 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.711662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.712029) ========= 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.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.147362 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.907860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:40.908197) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 02919b7d57d7f8206328f53ac0f7b2b9fe334c9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 02919b7d57d7f8206328f53ac0f7b2b9fe334c9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False 2015-11-18 08:53:41,004 truncating revision to first 12 chars 2015-11-18 08:53:41,005 Setting DEBUG logging. 2015-11-18 08:53:41,005 attempt 1/10 2015-11-18 08:53:41,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/02919b7d57d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 08:53:41,381 unpacking tar archive at: mozilla-inbound-02919b7d57d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644228 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:41.570876) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:41.571168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:41.585480) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:41.585767) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:53:41.586180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-18 08:53:41.586483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False 08:53:41 INFO - MultiFileLogger online at 20151118 08:53:41 in /builds/slave/test 08:53:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 08:53:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:41 INFO - {'append_to_log': False, 08:53:41 INFO - 'base_work_dir': '/builds/slave/test', 08:53:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:53:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:41 INFO - 'branch': 'Mozilla-Inbound', 08:53:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:41 INFO - 'config_files': ('talos/mac_config.py',), 08:53:41 INFO - 'default_actions': ('clobber', 08:53:41 INFO - 'read-buildbot-config', 08:53:41 INFO - 'download-and-extract', 08:53:41 INFO - 'populate-webroot', 08:53:41 INFO - 'create-virtualenv', 08:53:41 INFO - 'install', 08:53:41 INFO - 'run-tests'), 08:53:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:41 INFO - 'download_minidump_stackwalk': True, 08:53:41 INFO - 'download_symbols': 'ondemand', 08:53:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:41 INFO - 'installer_path': 'installer.exe', 08:53:41 INFO - 'log_level': 'info', 08:53:41 INFO - 'log_name': 'talos', 08:53:41 INFO - 'log_to_console': True, 08:53:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:53:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:53:41 INFO - 'opt_config_files': (), 08:53:41 INFO - 'pip_index': False, 08:53:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:41 INFO - 'cmd': ('bash', 08:53:41 INFO - '-c', 08:53:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:41 INFO - 'enabled': True, 08:53:41 INFO - 'halt_on_failure': False, 08:53:41 INFO - 'name': 'check_screen_resolution'},), 08:53:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:41 INFO - 'cmd': ('bash', 08:53:41 INFO - '-c', 08:53:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:41 INFO - 'enabled': True, 08:53:41 INFO - 'halt_on_failure': False, 08:53:41 INFO - 'name': 'check_screen_resolution'},), 08:53:41 INFO - 'run_cmd_checks_enabled': True, 08:53:41 INFO - 'sps_profile': False, 08:53:41 INFO - 'sps_profile_interval': 0, 08:53:41 INFO - 'suite': 'dromaeojs', 08:53:41 INFO - 'system_bits': '64', 08:53:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:41 INFO - 'title': 't-yosemite-r5-0024', 08:53:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:41 INFO - 'use_talos_json': True, 08:53:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:41 INFO - 'work_dir': 'build'} 08:53:41 INFO - ##### 08:53:41 INFO - ##### Running clobber step. 08:53:41 INFO - ##### 08:53:41 INFO - Running pre-action listener: _resource_record_pre_action 08:53:41 INFO - Running main action method: clobber 08:53:41 INFO - rmtree: /builds/slave/test/build 08:53:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - ##### 08:53:46 INFO - ##### Running read-buildbot-config step. 08:53:46 INFO - ##### 08:53:46 INFO - Running pre-action listener: _resource_record_pre_action 08:53:46 INFO - Running main action method: read_buildbot_config 08:53:46 INFO - Using buildbot properties: 08:53:46 INFO - { 08:53:46 INFO - "properties": { 08:53:46 INFO - "buildnumber": 3448, 08:53:46 INFO - "product": "firefox", 08:53:46 INFO - "script_repo_revision": "production", 08:53:46 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 08:53:46 INFO - "repository": "", 08:53:46 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 08:53:46 INFO - "buildid": "20151117113504", 08:53:46 INFO - "slavename": "t-yosemite-r5-0024", 08:53:46 INFO - "pgo_build": "False", 08:53:46 INFO - "basedir": "/builds/slave/test", 08:53:46 INFO - "project": "", 08:53:46 INFO - "platform": "yosemite", 08:53:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:53:46 INFO - "slavebuilddir": "test", 08:53:46 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 08:53:46 INFO - "branch": "mozilla-inbound", 08:53:46 INFO - "repo_path": "integration/mozilla-inbound", 08:53:46 INFO - "stage_platform": "macosx64", 08:53:46 INFO - "builduid": "c24efe3037a4408886b2077dc045f3b8", 08:53:46 INFO - "revision": "02919b7d57d7f8206328f53ac0f7b2b9fe334c9b" 08:53:46 INFO - }, 08:53:46 INFO - "sourcestamp": { 08:53:46 INFO - "repository": "", 08:53:46 INFO - "hasPatch": false, 08:53:46 INFO - "project": "", 08:53:46 INFO - "branch": "mozilla-inbound-macosx64-talos", 08:53:46 INFO - "changes": [ 08:53:46 INFO - { 08:53:46 INFO - "category": null, 08:53:46 INFO - "files": [ 08:53:46 INFO - { 08:53:46 INFO - "url": null, 08:53:46 INFO - "name": "https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:53:46 INFO - } 08:53:46 INFO - ], 08:53:46 INFO - "repository": "", 08:53:46 INFO - "rev": "02919b7d57d7f8206328f53ac0f7b2b9fe334c9b", 08:53:46 INFO - "who": "tcole@mozilla.com", 08:53:46 INFO - "when": 1447794017, 08:53:46 INFO - "number": 6673628, 08:53:46 INFO - "comments": "Bug 1225233 - Make MovableCellHasher a public interface, usable by embedders; r=jonco", 08:53:46 INFO - "project": "", 08:53:46 INFO - "at": "Tue 17 Nov 2015 13:00:17", 08:53:46 INFO - "branch": "mozilla-inbound-macosx64-talos", 08:53:46 INFO - "revlink": "", 08:53:46 INFO - "properties": [ 08:53:46 INFO - [ 08:53:46 INFO - "buildid", 08:53:46 INFO - "20151117113504", 08:53:46 INFO - "Change" 08:53:46 INFO - ], 08:53:46 INFO - [ 08:53:46 INFO - "builduid", 08:53:46 INFO - "c24efe3037a4408886b2077dc045f3b8", 08:53:46 INFO - "Change" 08:53:46 INFO - ], 08:53:46 INFO - [ 08:53:46 INFO - "pgo_build", 08:53:46 INFO - "False", 08:53:46 INFO - "Change" 08:53:46 INFO - ] 08:53:46 INFO - ], 08:53:46 INFO - "revision": "02919b7d57d7f8206328f53ac0f7b2b9fe334c9b" 08:53:46 INFO - } 08:53:46 INFO - ], 08:53:46 INFO - "revision": "02919b7d57d7f8206328f53ac0f7b2b9fe334c9b" 08:53:46 INFO - } 08:53:46 INFO - } 08:53:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - ##### 08:53:46 INFO - ##### Running download-and-extract step. 08:53:46 INFO - ##### 08:53:46 INFO - Running pre-action listener: _resource_record_pre_action 08:53:46 INFO - Running main action method: download_and_extract 08:53:46 INFO - mkdir: /builds/slave/test/build/tests 08:53: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')]} 08:53:46 INFO - https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/test_packages.json 08:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/test_packages.json 08:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:53:49 INFO - Downloaded 1149 bytes. 08:53:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:53:49 INFO - Using the following test package requirements: 08:53:49 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:53:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:53:49 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:53:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:53:49 INFO - u'jsshell-mac.zip'], 08:53:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:53:49 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:53:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:53:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:53:49 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:53:49 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:53:49 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:53:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:53:49 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:53:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:53:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:53:49 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:53:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:53: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')]} 08:53:49 INFO - https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:53:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:53:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:53:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/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 08:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/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 08:53:50 INFO - Downloaded 17463479 bytes. 08:53:50 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 08:53:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:53:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:53:55 INFO - Return code: 0 08:53:55 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 08:53:55 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')]} 08:53:55 INFO - https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:53:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:53:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:53:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/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 08:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/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 08:53:58 INFO - Downloaded 17463479 bytes. 08:53:58 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 08:53:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:53:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:54:04 INFO - Return code: 0 08:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:04 INFO - https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:54:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:54:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:54:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/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 08:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/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 08:54:06 INFO - Downloaded 11130997 bytes. 08:54:06 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 08:54:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:54:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:54:06 INFO - Return code: 0 08:54:06 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')]} 08:54:06 INFO - https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:54:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:54:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:54:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uI2u8GEYSAGab1ft5L2NfQ/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 08:54:10 INFO - Downloaded 108841260 bytes. 08:54:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:54:10 INFO - mkdir: /builds/slave/test/properties 08:54:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:10 INFO - Contents: 08:54:10 INFO - build_url:https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:54:10 INFO - Running post-action listener: _resource_record_post_action 08:54:10 INFO - Running post-action listener: set_extra_try_arguments 08:54:10 INFO - ##### 08:54:10 INFO - ##### Running populate-webroot step. 08:54:10 INFO - ##### 08:54:10 INFO - Running pre-action listener: _resource_record_pre_action 08:54:10 INFO - Running main action method: populate_webroot 08:54:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:54:10 INFO - '../fennec_ids.txt'], 08:54:10 INFO - 'tests': ['tcheck2']}, 08:54:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:10 INFO - '--tppagecycles', 08:54:10 INFO - '7'], 08:54:10 INFO - 'tests': ['tsvgm']}}, 08:54:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:54:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:54:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:54:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'tests': ['damp', 'tps']}, 08:54:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['damp', 'tps']}, 08:54:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:54:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:10 INFO - 'other': {'tests': ['a11yr', 08:54:10 INFO - 'ts_paint', 08:54:10 INFO - 'tpaint', 08:54:10 INFO - 'sessionrestore', 08:54:10 INFO - 'sessionrestore_no_auto_restore']}, 08:54:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['a11yr', 08:54:10 INFO - 'ts_paint', 08:54:10 INFO - 'tpaint', 08:54:10 INFO - 'sessionrestore', 08:54:10 INFO - 'sessionrestore_no_auto_restore']}, 08:54:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['a11yr', 08:54:10 INFO - 'ts_paint', 08:54:10 INFO - 'tpaint', 08:54:10 INFO - 'sessionrestore', 08:54:10 INFO - 'sessionrestore_no_auto_restore']}, 08:54:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['a11yr', 08:54:10 INFO - 'ts_paint', 08:54:10 INFO - 'tpaint', 08:54:10 INFO - 'sessionrestore', 08:54:10 INFO - 'sessionrestore_no_auto_restore']}, 08:54:10 INFO - 'other_l64': {'tests': ['a11yr', 08:54:10 INFO - 'ts_paint', 08:54:10 INFO - 'tpaint', 08:54:10 INFO - 'sessionrestore', 08:54:10 INFO - 'sessionrestore_no_auto_restore']}, 08:54:10 INFO - 'other_nol64': {'tests': ['a11yr', 08:54:10 INFO - 'ts_paint', 08:54:10 INFO - 'tpaint', 08:54:10 INFO - 'sessionrestore', 08:54:10 INFO - 'sessionrestore_no_auto_restore']}, 08:54:10 INFO - 'svgr': {'tests': ['tsvgx', 08:54:10 INFO - 'tsvgr_opacity', 08:54:10 INFO - 'tart', 08:54:10 INFO - 'tscrollx', 08:54:10 INFO - 'cart']}, 08:54:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['tsvgx', 08:54:10 INFO - 'tsvgr_opacity', 08:54:10 INFO - 'tart', 08:54:10 INFO - 'tscrollx', 08:54:10 INFO - 'cart']}, 08:54:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'tests': ['tp5o']}, 08:54:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'talos_options': ['--e10s'], 08:54:10 INFO - 'tests': ['tp5o']}, 08:54:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'talos_options': ['--xperf_path', 08:54:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:10 INFO - 'tests': ['tp5n']}, 08:54:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:10 INFO - 'talos_options': ['--e10s', 08:54:10 INFO - '--xperf_path', 08:54:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:10 INFO - 'tests': ['tp5n']}}, 08:54:10 INFO - 'talos.zip': {'path': '', 08:54:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:10 INFO - Running post-action listener: _resource_record_post_action 08:54:10 INFO - ##### 08:54:10 INFO - ##### Running create-virtualenv step. 08:54:10 INFO - ##### 08:54:10 INFO - Running pre-action listener: _resource_record_pre_action 08:54:10 INFO - Running main action method: create_virtualenv 08:54:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:10 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 08:54:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:11 INFO - Using real prefix '/tools/python27' 08:54:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:15 INFO - Installing pip.................done. 08:54:15 INFO - Return code: 0 08:54:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:15 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 0x10c081490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c05e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd59602650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:15 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 08:54:15 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 08:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:15 INFO - 'HOME': '/Users/cltbld', 08:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:15 INFO - 'LOGNAME': 'cltbld', 08:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:15 INFO - 'MOZ_NO_REMOTE': '1', 08:54:15 INFO - 'NO_EM_RESTART': '1', 08:54:15 INFO - 'PAGER': '/bin/cat', 08:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:15 INFO - 'PWD': '/builds/slave/test', 08:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:15 INFO - 'SHELL': '/bin/bash', 08:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:54:15 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:15 INFO - 'USER': 'cltbld', 08:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:15 INFO - 'XPC_FLAGS': '0x0', 08:54:15 INFO - 'XPC_SERVICE_NAME': '0', 08:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:16 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 08:54:16 INFO - Cleaning up... 08:54:16 INFO - Return code: 0 08:54:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:54:16 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')]} 08:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:16 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')]} 08:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:16 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 0x10c081490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c05e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd59602650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:16 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 08:54:16 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 08:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:16 INFO - 'HOME': '/Users/cltbld', 08:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:16 INFO - 'LOGNAME': 'cltbld', 08:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:16 INFO - 'MOZ_NO_REMOTE': '1', 08:54:16 INFO - 'NO_EM_RESTART': '1', 08:54:16 INFO - 'PAGER': '/bin/cat', 08:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:16 INFO - 'PWD': '/builds/slave/test', 08:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:16 INFO - 'SHELL': '/bin/bash', 08:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:54:16 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:16 INFO - 'USER': 'cltbld', 08:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:16 INFO - 'XPC_FLAGS': '0x0', 08:54:16 INFO - 'XPC_SERVICE_NAME': '0', 08:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:17 INFO - Downloading/unpacking psutil>=0.7.1 08:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:54:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:19 INFO - Installing collected packages: psutil 08:54:19 INFO - Running setup.py install for psutil 08:54:20 INFO - building 'psutil._psutil_osx' extension 08:54:20 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 08:54:21 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 08:54:21 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 08:54:22 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 08:54:22 INFO - building 'psutil._psutil_posix' extension 08:54:22 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 08:54:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:54:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:54:22 INFO - ^ 08:54:22 INFO - 1 warning generated. 08:54:22 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 08:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:22 INFO - Successfully installed psutil 08:54:22 INFO - Cleaning up... 08:54:22 INFO - Return code: 0 08:54:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:22 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 0x10c081490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c05e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd59602650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:22 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 08:54:22 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 08:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:22 INFO - 'HOME': '/Users/cltbld', 08:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:22 INFO - 'LOGNAME': 'cltbld', 08:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:22 INFO - 'MOZ_NO_REMOTE': '1', 08:54:22 INFO - 'NO_EM_RESTART': '1', 08:54:22 INFO - 'PAGER': '/bin/cat', 08:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:22 INFO - 'PWD': '/builds/slave/test', 08:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:22 INFO - 'SHELL': '/bin/bash', 08:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:54:22 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:22 INFO - 'USER': 'cltbld', 08:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:22 INFO - 'XPC_FLAGS': '0x0', 08:54:22 INFO - 'XPC_SERVICE_NAME': '0', 08:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:54:23 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 08:54:23 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 08:54:23 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 08:54:23 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 08:54:23 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 08:54:23 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 08:54:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:54:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:54:25 INFO - Installing collected packages: mozsystemmonitor 08:54:25 INFO - Running setup.py install for mozsystemmonitor 08:54:25 INFO - Successfully installed mozsystemmonitor 08:54:25 INFO - Cleaning up... 08:54:25 INFO - Return code: 0 08:54:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:25 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 0x10c081490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c05e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd59602650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:25 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 08:54:25 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 08:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:25 INFO - 'HOME': '/Users/cltbld', 08:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:25 INFO - 'LOGNAME': 'cltbld', 08:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:25 INFO - 'MOZ_NO_REMOTE': '1', 08:54:25 INFO - 'NO_EM_RESTART': '1', 08:54:25 INFO - 'PAGER': '/bin/cat', 08:54:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:25 INFO - 'PWD': '/builds/slave/test', 08:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:25 INFO - 'SHELL': '/bin/bash', 08:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:54:25 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:25 INFO - 'USER': 'cltbld', 08:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:25 INFO - 'XPC_FLAGS': '0x0', 08:54:25 INFO - 'XPC_SERVICE_NAME': '0', 08:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:54:26 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 08:54:26 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 08:54:26 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 08:54:26 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 08:54:26 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 08:54:26 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 08:54:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:28 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 08:54:28 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 08:54:28 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 08:54:28 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 08:54:28 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 08:54:28 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 08:54:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:54:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:29 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 08:54:29 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 08:54:29 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 08:54:29 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 08:54:29 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 08:54:29 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 08:54:30 INFO - Downloading docopt-0.6.1.tar.gz 08:54:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:30 INFO - Running setup.py install for blobuploader 08:54:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:54:30 INFO - Running setup.py install for requests 08:54:30 INFO - Running setup.py install for docopt 08:54:31 INFO - Successfully installed blobuploader requests docopt 08:54:31 INFO - Cleaning up... 08:54:31 INFO - Return code: 0 08:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:31 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 0x10c081490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c05e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd59602650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:31 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 08:54:31 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 08:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:31 INFO - 'HOME': '/Users/cltbld', 08:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:31 INFO - 'LOGNAME': 'cltbld', 08:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:31 INFO - 'MOZ_NO_REMOTE': '1', 08:54:31 INFO - 'NO_EM_RESTART': '1', 08:54:31 INFO - 'PAGER': '/bin/cat', 08:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:31 INFO - 'PWD': '/builds/slave/test', 08:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:31 INFO - 'SHELL': '/bin/bash', 08:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:54:31 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:31 INFO - 'USER': 'cltbld', 08:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:31 INFO - 'XPC_FLAGS': '0x0', 08:54:31 INFO - 'XPC_SERVICE_NAME': '0', 08:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:31 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-jEt7Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:31 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-0ekeAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:31 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-zK4xhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:31 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-WSXPjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-JALS08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-TuQ9O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-NbojFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-3XnEWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-otHcuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-y5KsQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-x40HCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:32 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-_WWwr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:33 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-CsThxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:33 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-Eea9Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:33 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-HPpk0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:33 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-1v3exY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:33 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-2mFFuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:33 INFO - Running setup.py install for manifestparser 08:54:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:54:33 INFO - Running setup.py install for mozcrash 08:54:34 INFO - Running setup.py install for mozdebug 08:54:34 INFO - Running setup.py install for mozdevice 08:54:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:54:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:54:34 INFO - Running setup.py install for mozfile 08:54:34 INFO - Running setup.py install for mozhttpd 08:54:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:54:34 INFO - Running setup.py install for mozinfo 08:54:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:54:34 INFO - Running setup.py install for mozInstall 08:54:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:54:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:54:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:54:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:54:35 INFO - Running setup.py install for mozleak 08:54:35 INFO - Running setup.py install for mozlog 08:54:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:54:35 INFO - Running setup.py install for moznetwork 08:54:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:54:35 INFO - Running setup.py install for mozprocess 08:54:35 INFO - Running setup.py install for mozprofile 08:54:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:54:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:54:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:54:36 INFO - Running setup.py install for mozrunner 08:54:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:54:36 INFO - Running setup.py install for mozscreenshot 08:54:36 INFO - Running setup.py install for moztest 08:54:36 INFO - Running setup.py install for mozversion 08:54:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:54:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:36 INFO - Cleaning up... 08:54:36 INFO - Return code: 0 08:54:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:36 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 0x10c081490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c05e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd59602650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:36 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 08:54:36 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 08:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:36 INFO - 'HOME': '/Users/cltbld', 08:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:36 INFO - 'LOGNAME': 'cltbld', 08:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:36 INFO - 'MOZ_NO_REMOTE': '1', 08:54:36 INFO - 'NO_EM_RESTART': '1', 08:54:36 INFO - 'PAGER': '/bin/cat', 08:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:36 INFO - 'PWD': '/builds/slave/test', 08:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:36 INFO - 'SHELL': '/bin/bash', 08:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:54:36 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:36 INFO - 'USER': 'cltbld', 08:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:36 INFO - 'XPC_FLAGS': '0x0', 08:54:36 INFO - 'XPC_SERVICE_NAME': '0', 08:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:37 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-3X7A0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:37 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)) 08:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:37 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-dhDJj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:37 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)) 08:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:37 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-R16UYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:37 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)) 08:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:37 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-bTWcRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:37 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)) 08:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:37 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-RyUdjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:37 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)) 08:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:37 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-RclkMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-4U59n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-OkEA3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-w2IMTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-mbKoPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-YKgcv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-BA5f4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-msOed6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:38 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)) 08:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:38 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-5aUm61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:39 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)) 08:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:39 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-DiNEns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:39 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)) 08:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:39 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-_IFfwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:39 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)) 08:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:39 INFO - Running setup.py (path:/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/pip-f4aYnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:39 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)) 08:54:39 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)) 08:54:39 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)) 08:54:39 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)) 08:54:39 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)) 08:54:39 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)) 08:54:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:39 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 08:54:39 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 08:54:39 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 08:54:39 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 08:54:39 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 08:54:39 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 08:54:41 INFO - Downloading blessings-1.5.1.tar.gz 08:54:41 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 08:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:42 INFO - Installing collected packages: blessings 08:54:42 INFO - Running setup.py install for blessings 08:54:42 INFO - Successfully installed blessings 08:54:42 INFO - Cleaning up... 08:54:42 INFO - Return code: 0 08:54:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:42 INFO - Reading from file tmpfile_stdout 08:54:42 INFO - Current package versions: 08:54:42 INFO - blessings == 1.5.1 08:54:42 INFO - blobuploader == 1.2.4 08:54:42 INFO - docopt == 0.6.1 08:54:42 INFO - manifestparser == 1.1 08:54:42 INFO - mozInstall == 1.12 08:54:42 INFO - mozcrash == 0.16 08:54:42 INFO - mozdebug == 0.1 08:54:42 INFO - mozdevice == 0.47 08:54:42 INFO - mozfile == 1.2 08:54:42 INFO - mozhttpd == 0.7 08:54:42 INFO - mozinfo == 0.9 08:54:42 INFO - mozleak == 0.1 08:54:42 INFO - mozlog == 3.0 08:54:42 INFO - moznetwork == 0.27 08:54:42 INFO - mozprocess == 0.22 08:54:42 INFO - mozprofile == 0.27 08:54:42 INFO - mozrunner == 6.11 08:54:42 INFO - mozscreenshot == 0.1 08:54:42 INFO - mozsystemmonitor == 0.0 08:54:42 INFO - moztest == 0.7 08:54:42 INFO - mozversion == 1.4 08:54:42 INFO - psutil == 3.1.1 08:54:42 INFO - requests == 1.2.3 08:54:42 INFO - wsgiref == 0.1.2 08:54:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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', '-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 0x10c081490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c05e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd59602650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/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.fFEciGDf1f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:42 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 08:54:42 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 08:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:42 INFO - 'HOME': '/Users/cltbld', 08:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:42 INFO - 'LOGNAME': 'cltbld', 08:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:42 INFO - 'MOZ_NO_REMOTE': '1', 08:54:42 INFO - 'NO_EM_RESTART': '1', 08:54:42 INFO - 'PAGER': '/bin/cat', 08:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:42 INFO - 'PWD': '/builds/slave/test', 08:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:42 INFO - 'SHELL': '/bin/bash', 08:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:54:42 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:42 INFO - 'USER': 'cltbld', 08:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:42 INFO - 'XPC_FLAGS': '0x0', 08:54:42 INFO - 'XPC_SERVICE_NAME': '0', 08:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 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)) 08:54:43 INFO - Cleaning up... 08:54:43 INFO - Return code: 0 08:54:43 INFO - Running post-action listener: _resource_record_post_action 08:54:43 INFO - Running post-action listener: _start_resource_monitoring 08:54:43 INFO - Starting resource monitoring. 08:54:43 INFO - ##### 08:54:43 INFO - ##### Running install step. 08:54:43 INFO - ##### 08:54:43 INFO - Running pre-action listener: _resource_record_pre_action 08:54:43 INFO - Running main action method: install 08:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:43 INFO - Reading from file tmpfile_stdout 08:54:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:54:43 INFO - Reading from file tmpfile_stdout 08:54:43 INFO - Output received: 08:54:43 INFO - Usage: mozinstall [options] installer 08:54:43 INFO - Options: 08:54:43 INFO - -h, --help show this help message and exit 08:54:43 INFO - -d DEST, --destination=DEST 08:54:43 INFO - Directory to install application into. [default: 08:54:43 INFO - "/builds/slave/test"] 08:54:43 INFO - --app=APP Application being installed. [default: firefox] 08:54:43 INFO - mkdir: /builds/slave/test/build/application 08:54:43 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'] 08:54:43 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 08:55:23 INFO - Reading from file tmpfile_stdout 08:55:23 INFO - Output received: 08:55:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:55:23 INFO - Running post-action listener: _resource_record_post_action 08:55:23 INFO - ##### 08:55:23 INFO - ##### Running run-tests step. 08:55:23 INFO - ##### 08:55:23 INFO - Running pre-action listener: _resource_record_pre_action 08:55:23 INFO - Running main action method: run_tests 08:55:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:55:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:55:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:55:23 INFO - 2015-11-18 08:55:23.524 screenresolution[1626:7561] starting screenresolution argv=screenresolution get 08:55:23 INFO - 2015-11-18 08:55:23.527 screenresolution[1626:7561] Display 0: 1600x1200x32@60 08:55:23 INFO - 2015-11-18 08:55:23.534 screenresolution[1627:7563] starting screenresolution argv=screenresolution list 08:55:23 INFO - Available Modes on Display 0 08:55:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:55:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:55:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:55:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:55:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:55:23 INFO - Intel HD Graphics 3000: 08:55:23 INFO - Chipset Model: Intel HD Graphics 3000 08:55:23 INFO - Type: GPU 08:55:23 INFO - Bus: Built-In 08:55:23 INFO - VRAM (Total): 512 MB 08:55:23 INFO - VRAM (Dynamic, Max): 10 08:55:23 INFO - Vendor: Intel (0x8086) 08:55:23 INFO - Device ID: 0x0116 08:55:23 INFO - Revision ID: 0x0009 08:55:23 INFO - Displays: 08:55:23 INFO - Display: 08:55:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:55:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:55:23 INFO - Display Serial Number: 1600x1200 60 08:55:23 INFO - Main Display: Yes 08:55:23 INFO - Mirror: Off 08:55:23 INFO - Online: Yes 08:55:23 INFO - Rotation: Supported 08:55:23 INFO - Return code: 0 08:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:23 INFO - Python 2.7.3 08:55:23 INFO - Return code: 0 08:55:23 INFO - grabbing minidump binary from tooltool 08:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:23 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 0x10bfa59f0>, '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 0x10bd04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf988c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:23 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 08:55:23 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 08:55:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:23 INFO - Return code: 0 08:55:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:55:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:55:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0024', '--webServer', 'localhost'] in /builds/slave/test/build 08:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0024 --webServer localhost 08:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIuuqoV6QT/Render', 08:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:23 INFO - 'HOME': '/Users/cltbld', 08:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:23 INFO - 'LOGNAME': 'cltbld', 08:55:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:23 INFO - 'MOZ_NO_REMOTE': '1', 08:55:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:23 INFO - 'NO_EM_RESTART': '1', 08:55:23 INFO - 'PAGER': '/bin/cat', 08:55:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:23 INFO - 'PWD': '/builds/slave/test', 08:55:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:23 INFO - 'SHELL': '/bin/bash', 08:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFEciGDf1f/Listeners', 08:55:23 INFO - 'TMPDIR': '/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/', 08:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:23 INFO - 'USER': 'cltbld', 08:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:23 INFO - 'XPC_FLAGS': '0x0', 08:55:23 INFO - 'XPC_SERVICE_NAME': '0', 08:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:55:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0024', '--webServer', 'localhost'] with output_timeout 3600 08:55:24 INFO - mozversion INFO | application_buildid: 20151117113504 08:55:24 INFO - mozversion INFO | application_changeset: 02919b7d57d7f8206328f53ac0f7b2b9fe334c9b 08:55:24 INFO - mozversion INFO | application_display_name: Nightly 08:55:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:24 INFO - mozversion INFO | application_name: Firefox 08:55:24 INFO - mozversion INFO | application_remotingname: firefox 08:55:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:55:24 INFO - mozversion INFO | application_vendor: Mozilla 08:55:24 INFO - mozversion INFO | application_version: 45.0a1 08:55:24 INFO - mozversion INFO | platform_buildid: 20151117113504 08:55:24 INFO - mozversion INFO | platform_changeset: 02919b7d57d7f8206328f53ac0f7b2b9fe334c9b 08:55:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:55:24 INFO - mozversion INFO | platform_version: 45.0a1 08:55:24 INFO - 2015-11-18 08:55:24,236 DEBUG : using testdate: 1447865724 08:55:24 INFO - 2015-11-18 08:55:24,236 DEBUG : actual date: 1447865724 08:55:24 INFO - 2015-11-18 08:55:24,245 INFO : starting webserver on 'localhost:49266' 08:55:24 INFO - 2015-11-18 08:55:24,246 INFO : Starting test suite t-yosemite-r5-0024 08:55:24 INFO - 2015-11-18 08:55:24,246 INFO : Starting test dromaeo_css 08:55:24 INFO - 2015-11-18 08:55:24,246 DEBUG : operating with platform_type : mac_ 08:55:24 INFO - 2015-11-18 08:55:24,247 INFO : Initialising browser for dromaeo_css test... 08:55:24 INFO - 2015-11-18 08:55:24,277 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/tmpadIWts/profile http://localhost:49266/getInfo.html 08:55:27 INFO - 2015-11-18 08:55:27,925 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:55:27 INFO - 2015-11-18 08:55:27,926 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:55:27 INFO - 2015-11-18 08:55:27,926 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:55:27 INFO - 2015-11-18 08:55:27,926 DEBUG : BROWSER_OUTPUT: __metrics 08:55:27 INFO - 2015-11-18 08:55:27,942 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:28 INFO - 2015-11-18 08:55:28,717 INFO : Browser initialized. 08:55:28 INFO - 2015-11-18 08:55:28,718 INFO : Running cycle 1/1 for dromaeo_css test... 08:55:28 INFO - 2015-11-18 08:55:28,718 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/tmpadIWts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:55:40 INFO - 2015-11-18 08:55:40,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 230051840 08:55:40 INFO - 2015-11-18 08:55:40,823 DEBUG : BROWSER_OUTPUT: 08:56:32 INFO - 2015-11-18 08:56:32,434 DEBUG : BROWSER_OUTPUT: 1447865792433 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] 08:58:40 INFO - 2015-11-18 08:58:40,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 08:58:42 INFO - 2015-11-18 08:58:42,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 328327168 08:58:42 INFO - 2015-11-18 08:58:42,282 DEBUG : BROWSER_OUTPUT: 09:01:45 INFO - 2015-11-18 09:01:45,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 09:01:45 INFO - 2015-11-18 09:01:45,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 377417728 09:01:45 INFO - 2015-11-18 09:01:45,619 DEBUG : BROWSER_OUTPUT: 09:04:48 INFO - 2015-11-18 09:04:48,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 09:04:48 INFO - 2015-11-18 09:04:48,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 340750336 09:04:48 INFO - 2015-11-18 09:04:48,682 DEBUG : BROWSER_OUTPUT: 09:07:50 INFO - 2015-11-18 09:07:50,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 09:07:51 INFO - 2015-11-18 09:07:51,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 326336512 09:07:51 INFO - 2015-11-18 09:07:51,597 DEBUG : BROWSER_OUTPUT: 09:10:54 INFO - 2015-11-18 09:10:54,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 09:10:55 INFO - 2015-11-18 09:10:55,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 329605120 09:10:55 INFO - 2015-11-18 09:10:55,338 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 09:13:58 INFO - 2015-11-18 09:13:58,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 385241088 09:13:58 INFO - 2015-11-18 09:13:58,453 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,453 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:13:58 INFO - 2015-11-18 09:13:58,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:13:58 INFO - 2015-11-18 09:13:58,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:13:58 INFO - 2015-11-18 09:13:58,453 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:13:58 INFO - 2015-11-18 09:13:58,455 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2672.385351369185;2767.3220061085035;2778.8888444462223;2779.221817890989;2803.4393121375724;4372.540883207265;4471.619912307449;4491.752953587551;4510.887227819306;4585.380973568572;4448.488423831261;4464.575865292792;4489.618382437488;4534.206513860077;4605.861824145281;4174.08170202555;4177.874663760077;4190.643795277405;4266.997255644937;4305.63402110821;120.16468206763899;3941.881743547698;4012.25773231953;4080.18396320737;4135.689823263252;4078.3882417637296;4146.460960075201;4147.875563733093;4155.252054630166;4177.749335039907;4155.667546596265;4180.623743863037;4181.142865712522;4207.810648520824;4233.767142807144;3995.4805875236325;4116;4120.979395103005;4161.729487583298;4193.874183774492;4349.282368409209;4435.179491793996;4467.285234362519;4514.164879497271;4528.50186479487;4694.929576056362;4716.622670186377;4716.669833111683;4744.6441516886025;4750.216214324632;4689.859304220879;4771.451283102453;4773.856784296477;4815.831445899376;4846.903061938777;4449.28811390176;4501.549845015505;4541.114482675879;4559.179347717442;4580.358749775034;4859.611231101503;4903.362562866804;4906;4914.754262286871;4964.404271487445;4482.148391805546;4700.764961751899;4714.57568818808;4722.362481065013;4758.42898852133;4649.767511624405;4720.551547602972;4767.118083154627;4774.904501909942;4782.258749893772;4757.904841903142;4792.904141917142;4803.351547541107;4809.278608208727;4839.903201935942;4569.543045695404;4777.737224452619;4807.975960120247;4822.807087716522;4932.457429682732;3728.459373390843;3755.8873233802483;3755.887323380303;3757.680597149218;3762.3415902217002;3284.1625385526536;3436.329915666421;3476.7392445566684;3477.1828620274214;3511.17487390463;4577.542245775462;4584.954150458453;4596.241620132708;4633.166030114612;4639.930401043987;4868.148074087091;4877.341558889575;4905.3623029006;4944.678595891256;4964.925526117111;4454.175977444183;4508.571685689854;4567.9086418271445;4579.038401935631;4660.1145782301255;4175.645070169009;4239.554846741109;4272.679549033773;4278.55075217104;4284.293091639907;5008.4240312364545;5019.824306149268;5043.36957880265;5057.165567681365;5070.4929507049;4697.741624210701;4817.181079216612;4888.437829649636;4914.926276105933;4973.676711013917;4996.050750357421;5015.1975683890405;5015.874603134951;5051.646384753032;5062.67092638992;4784.569388755029;4806.663533552758;4808.927866081942;4817.566419022305;4853.126437241331;4880.633952453509;4884.218525036119;4891.046245981999;4898.289747986593;4921.8523444296725;4610.469795973372;4666.92999605013;4667.626589872734;4673.906521869476;4722.244440889579;4674.5091765365505;4702.952970470252;4747.311639812277;4752.073345697556;4753.738544380092;4265.808038638207;4620.676552641283;4624.098300831306;4658.231391820312;4660.440747110233;4632.675712700078;4654.581087702123;4703.929441058455;4748.62011039123;4758.666893317434;4664.160451118695;4678.321643361625;4717.9056418872115;4726.6455015874635;4775.880602984953 09:13:58 INFO - 2015-11-18 09:13:58,456 DEBUG : BROWSER_OUTPUT: |1;ext.html;486.5329283887468;493.3808070871056;501.3407369309358;513.1712284660275;518.9299444574986;27759;28892.711072889266;35170.47244291334;35715.64284357156;35884.282314353695;38140.42789358162;38315;38327.616723832754;38699.22601547974;38760.80619596905;7296.489245752799;8155.4291199616055;8234.505929644241;8278.172182781735;8295.585220738969;7356.043714317158;7476.214997425273;9790.167835733935;9900.356476828983;9934.602615895355;9584.137427631511;9633.518324083803;9694.903050969471;9729.416235025885;9847.704568862946;7473.588952607604;9751.609935602639;9759.95120024399;9763.951180244088;9789.461579613118;7334.4865859389865;9643;9813.90186098137;9841.950790246003;9988;35068.123296917525;35483;35498.11254718627;35853.82073089644;35886.28227435463;2442.63729271882;2557.8848951797213;2617.8429294242214;2628.2246737212377;2724.7275272472793;24848.875755621106;25060.997560097574;25209.747902521107;25626.23121306364;26081.478370432484;2098.9790102098937;2125.3730149605904;2144.9785502144937;2168.392850002002;2233.0732745910427;222629;223903;227268;227447;229889.99999999834;50676.239856402186;51660.74169629203;52068.21897671538;54323;54800.45199548033;62633.68683156646;63747.36252637414;64569.67715161394;64581;64880.72917447961;12029.338386388657;14613.415463381558;15429.691406171814;15436.459723909833;15452;11455.140864435034;11654.475548600334;11654.475548600334;11661.35862527569;11742.236754611095;17447.302107915795;17925.37261195852;18064.09679516019;18139.09304534768;18215.908920455313;6704.765333213314;6722.596644201363;6807.4894382921475;6853;6889.105495988643;886.4193952960821;902.8781114549452;975.5366201054584;977.2524019125375;982.9875228514642;25429;25611.61582576263;25624;25852.482950341266;26248.34379140537;879.6745204274459;897.4749771383683;935.4527601353149;956.9951550871696;1006.0342071611188;13371.130876492996;13609.863901360859;13652.931735341459;14030.579082627537;14181.929090354482;272498;278635;280577;282135;282323;44359.77820110943;44834.55165448369;44887.77556112264;44911.55088449074;45161;1186.068935885343;1193.7910865598485;1195.5158160944832;1196.186593116689;1207.0645249931374;23968.76031239735;24502.38744031342;24628;24705;26253.868730656224;42216.577834221265;42493;42577.787111064245;42591.3611295837;42591.7870410646;222331.87847154494;247079;252699;253207;260817;25526;25649;25760.8711956439;25939.610905836806;26123.477530449665;36893.44659830158;37870;37914.24171516499;38062.80968595139;38352.42471362987;31016.22459438532;31816.363672725955;31826.204344890637;32142.83928580342;32478.188045299055;31686.841565792023;31960;32354.676453235166;32382.83808580942;32469.350612987135;31947.520787188674;32390.676093238766;32477.350452990337;32751.672483275815;33108.337833243684;24582.850492622063;27438.314042149104;27957;27961.580576291777;28170.43659126847;21276.893615531822;21333.6799948004;21507.354779356643;21521.246756363453;21607.45981350479 09:13:58 INFO - 2015-11-18 09:13:58,459 DEBUG : BROWSER_OUTPUT: |2;jquery.html;295.80772497876376;298.07150725490106;300.2493765586035;306.6396983544335;310.15018848355504;12444;12860.935695321534;15092.773608395883;15200.467983620576;15490.148041857694;12907;15280.312385942632;15795;16378.344866205338;16485.67028659426;4617.261238201897;4654.674172807905;4755.0489902019735;4759.381280433538;4810.11012962603;3432.4508078707413;3529.0824385659785;3530.929381412383;4709.905801883978;4749.311349854269;5039.168537191359;5174.637775355726;5181.87045323868;5208.869778255555;5235.502627250406;5075.771590278447;5133.84598462043;5169.6898186108765;5184.611154163415;5191.87020324493;4454.955450445486;4457.3091170868565;4463.709858859196;4467.530909254547;4517.616002639779;17769.644607107915;17875.553111172194;18037.7294340585;18308.90845545777;19418;1684.8146703862565;1690.7548405481136;1760.709482935314;1804.5082864134615;2047.8156965873143;11669.241499302518;11750.941245293805;11939.761204775856;12271.57049503263;12402.19385739933;1401.7126489069717;1468.1998310920574;1508.1328236264192;1516.6966606678598;1585.952421427359;52172.478275217145;52806.735966319924;52981.7350913243;53025.08362040086;53434;8229.588520574067;8380.664773409117;8567.314614830799;8627.094155113622;8671.479711217347;10570.207234457446;10581.36511809294;10585.259031867849;10595.15238780911;10716.089132423831;6956.7217311307995;7011.6143612100805;7042.718291268292;7053.365197132282;7053.788386348418;7182.96408517954;7191.820204494825;7255.09311336083;7321.3410793027815;7338.266173382619;5018.071656743514;5090;5092.949070509321;5137.537621614073;5148.76830542619;1380.9723805523834;1435.3899592673072;1448.5654303708845;1469.258024697521;1526.259764014452;316.8114971591899;328.62864962592596;330.1333998254582;796.506166176974;819.4223072733828;8345.332373410112;9046.411983221069;9536.666216682383;10309.690709278733;10322.329048611966;373.20321114420364;409.1591778894341;414.61440859999885;426.1285670803153;433.86767036053675;4685.0395668887795;5249.763760630781;5312.1766126250495;5319.202119682079;5428.864278393072;476959;480981;504450;507169;515119;61882.69058654678;64692.676536617015;64959.675201623686;65412.67293663501;65668.67165664141;431.55334229073384;436.11033491676625;436.85802114312975;440.96251818595135;445.58337954012455;9526.285528585522;9679.612815487302;9680.951595241979;9796.804063918538;9825.16486098661;29356.853215733783;30145.69854301429;30903.845480772452;31019.379612408076;31053.534196986613;41136.58863411328;41231.58768412397;41687.374689379074;41715.582844172386;42104.78947605365;5385.434529374359;5469.589780766538;5489;5528.474794894479;5531.8893622128135;10150.187984961038;10357.22320825926;10470.790584188426;10476.68569942903;10542.420166890588;8783.472991620267;8796.91203087961;8906.821863562822;8930.732078037669;9057.36598438103;8488.066312705474;8657.39398242117;8687.522186279815;8746;8940;7383.556986580822;7452.552846829208;8717.041125476066;8784.077671844365;9159.633614655339;5189.506996835295;5200.141976573823;5203.453637368173;5222.060029194781;5258.710770907637;8252.752417427488;8316.916830831857;8438.409311348147;8509.659613615386;8512 09:13:58 INFO - 2015-11-18 09:13:58,460 DEBUG : BROWSER_OUTPUT: |3;mootools.html;673.9561928474652;1413.8232720909884;1474.5281509916827;1475.358219174659;1553.1224857955253;5640.492355687988;5914;5919.940800591993;5935.85160370991;5992.101184822279;5939.316978547468;5963.791267305645;6091.177691011712;6093.542984276175;6152.169457123287;1803.9098045097726;1820.872538922276;1822.8086050964657;1823.2524664887399;1831.7069268916975;1796.5778042160082;1849.2972670385302;1859.479345783176;1872.896990665513;1881.4261650196684;1836.2471386731443;1855.0817345414039;1857.1642760757645;1875.4279944616887;1878.4176905159377;1827.2964908510187;1862.6833438315518;1874.4751469588537;1875.0156168011767;1890.7542019537373;1828.2138680367436;1845.1143451143391;1847.9630407391912;1848.168324254091;1848.3068849181557;6118.4799292060225;6122.8775424491705;6124.96937515314;6153.538484613672;6217.347178546278;3303.339332133559;3652.5799533053773;3750.1187221003042;3753.2681127180213;3769.5099637047283;2057.989710051455;2092.016752126498;2094.800993905592;2246.977530224693;2298.9999350282515;731.5647189921988;740.7703611880335;771.6720393832599;777.2033665492859;786.1862971824191;7877.724279650185;7915.88126178102;7950.3242224410415;8022.277994980422;8034.116247212802;3024.758019358446;3139.937201255962;3281.409346317686;3297.5218593303834;3337.0656216259486;6917.515773895779;7028.156621205488;7066.823329416703;7067.328603782633;7068;3819.197968426606;3842.615738426135;3852.4221366795205;3878;3879.922401551953;3489.965100349015;3494.685478306914;3501.632328605511;3517.718582513393;3530.011596752913;3064.417760625474;3080.8151510909415;3087.706667866549;3112.673169317234;3132.561441398206;988.0564061321421;988.5996171550534;993.8857031441477;1001.9298649094493;1015.3958394755109;830.7258604660448;845.7335939179139;846.2130218896485;846.6528723223449;1065.3341661461586;6000.249968753906;6040.456358927718;6042.758289668452;6049.939500604937;6105.786297479567;336.7962382758445;342.78062040293736;349.587486765619;353.68698701649225;353.97168226541817;4681.555252251031;4687.906241875144;4738.668293219442;4739.502352253033;4740.6444516660695;6932.757353492603;7002;7086.114235720535;7105.218425973138;7174.928250717426;6971.895421568681;6991.7902462926195;7030.050943122716;7035.226125126232;7070.964645176741;5643.294588176478;5698.00284950132;5735.340435849847;5804.21643078179;5819.330776960704;5534.667919924817;5571.721413929368;5597.524210442158;5608.242887210337;5636.408177141505;6201.844953876189;6291.307956124914;6345.936540634534;6366.076918846834;6397.232332120176;6388.968055159695;6415.903761443488;6460.612363258219;6483.351664833667;6498.772542960974;5054.368203974504;5106.897862042812;5291.894162116813;5453.318335208099;5529.806456773994;5908.881822363614;5910.940890591039;5911.113333000085;5914.674692891932;5930.673812940329;5300.814471493633;5561.388247292875;5601.467860553241;5614.915776263441;5627.8593035174445;5497.8075767347955;5520.282363292747;5555.638883472561;5587.580931430078;5639.041362968387;5677.687727175045;5693.829185124453;5699.344575373885;5702.6293290935955;5724.74238659253;5098;5205.713685747321;5233.790648374023;5250.816221432385;5294.655847369909;5270.49930256625;5332.200169974535;5336.599755018312;5347.5721942243745;5382.784688612568 09:13:58 INFO - 2015-11-18 09:13:58,463 DEBUG : BROWSER_OUTPUT: |4;prototype.html;270.27700900092253;271.8898845967383;273.24447901552213;275.7848877875257;282.41986087838563;5443.727813609314;5553.888922221553;5576.888462230753;5623.550115990721;5666.291713535813;5395.379531353896;5583.804566840161;5593.328800543941;5601.103823388259;5610.326760788701;4212.852550160745;4215.789210539476;4217.21981433435;4268.658507319423;4286.957130428703;4005.0588111793704;4155.127423241123;4163.125743593849;4195.6573896353175;4233.491980962273;3871;4007.4790277263915;4116.855910043149;4121.670266378683;4130.958690413087;4019.4975628046495;4143.482064741907;4148.149629326011;4148.315527937887;4200.495940487131;3571.2678900825267;3579.28414317135;3579.8568057277676;3591.910202244939;3618.7105031597407;5338.145896656555;5359.705216213107;5364.034473794715;5369.973150134224;5400.945990540084;4726.196546587088;4728.999999999965;4731.195696731564;4739.0758802033615;4759.690620109682;5663.4336566343445;5836.533077353802;5846.123081537761;5866.941330586725;5879.176915231871;3857.652811246973;3857.6528112470014;3862.3627101528214;3864.188520410717;3895.4156876468473;5861.5603829712945;5964.522838172979;6025.78909738157;6147.969260153715;6163.476104531121;3821.178446633987;3884.1649045454797;3905.082305658168;3915.980420097881;3916.8433262669746;3928.4500169976227;3982.542007669097;3993.0416699991792;3993.121513267077;3995.9400608990886;4673.275642275453;4684.992726563805;4686.203345431217;4687.859364219079;4697.0840686065885;5663.830085097454;5838.766449341979;5847.298324201123;5851.034579294454;5864;1373.8557451467452;1378.0835744230176;1381.2610253514322;1383.2392184298596;1383.9584812455641;863.5207459859838;877.2148926710558;884.1423818895661;892.8794612727198;895.2837729816121;5643.153526970905;5643.294588176478;5653.123765816305;5657.405972372924;5670.404607516234;6097.359777223416;6097.664628445389;6099.75600975956;6100;6173.228346456693;5644.5484361251;5644.8306550803545;5645.350784659735;5696.231008813757;5741.569382296345;3181.2046988252937;3261.2173078460996;3288.3752087103376;3311.1887587541205;3318.1041118898247;6247.968760156261;6286.8428289292215;6296.590721603081;6315.147455093504;6343.016832390987;6213.943629582982;6217.813465596039;6220.03589443637;6251.437370636664;6277.2781130170615;6004.639721616717;6236.968815155895;6243.250809902659;6306.2747784004505;6317.6209427434505;5995.850103747442;6068.6358818471035;6125.571210015256;6130.693465326805;6144.354842741448;5868.882622347614;5927.585069045125;5930.851728706817;5938.8218353449465;5975.880482390415;5823.4176582343125;5952.410701344928;6230.7819226326865;6240.28236752761;6307.274663413767;3835.5972622874197;4010.7994600269285;4021.8994525137105;4025.718199726108;4063.4108054332546;6155.4767844731905;6182.072689096672;6186.907196392148;6234.532410069172;6242.469390101892;5969.134475500941;5980;5982.7307771149535;6024.668643224665;6029.366916473882;5720.08478643415;5918.408159184047;5954;6008.729607167776;6015.578909476295;5816.243888294494;5829.3004839417845;5866.6186697864505;5872.530197584098;5892.587518873637;5926.2295901532525;5944.167816505606;5990.64056156632;5992.221011268507;6016;5636.830895073154;5799.420057994167;5828.562857785768;5833.241678581757;5858.47273745365 09:13:58 INFO - 2015-11-18 09:13:58,464 DEBUG : BROWSER_OUTPUT: |5;yui.html;607.7052629474701;629.1632129268074;644.1336402538587;649.3993056422809;665.5973136252566;12066.75866482671;12275.570355037575;12298.63104106876;12300.630981070572;12347.691307717312;11204.103671706263;11465.885341146586;11772.882271177286;11781.823272650918;11802.291862488257;622.1290193728793;625.8779537990093;631.2897989761518;789.715702347156;810.0481933727875;619.8264485943943;626.6741294526844;784.568487331968;793.6626933553217;801.9238172373615;817.207308910356;824.826786374862;830.8587540118165;831.1688311688312;831.5177197225624;649.1074772188241;652.9347065293433;817.2767101115526;825.2407784837964;825.7151282807451;485.245443335613;486.95617394434316;490.66389523176383;602.4066294699717;614.7663887722637;12100.455479503444;12274.263544187377;12290;12303.138780285384;12459.750804983849;10068.29521933465;10175.694729158064;10264.74338141545;10619.522121504473;10811.729706757314;7749.690012399497;8245.79385515367;8311.501309921425;8342.749717508425;8346.791330216793;2909.621749172615;2933.6039634649264;2978.8361640109783;2987.118799954019;3093.5978322818114;43670.56329436697;45135.77432112851;45433.77283113563;45521;45963.770181149215;7952.3638108951145;8012.4791888528225;8058.1538938411795;8100.71647492335;8132.308753755997;17034.48896533106;17055.658886822195;17229.39697110595;17242.913785430992;17272.22274997603;5746.712664366765;5830.096335068071;5960.225170727777;5961.5826892118;6034.879302413927;3383.7293016558615;3402.4726167444087;3422.7775194612273;3446.5174875517446;3462.3594634992105;2445.9266222013366;2492.090387008765;2513.208339373092;2530.4053547416343;2537.8984840606167;353.60219752778124;354.3992931980269;357.8997880593438;358.08330673475984;360.3082082401795;493.7333839726579;497.66159011872276;500.924861270805;504.0102980493147;532.9094054010827;6540.411362977355;7058.823529411703;7143.9642801786695;7147.099485428851;7324.2309557496765;500.91734863747075;502.6707506583194;510.2346480279581;531.5515961395694;547.6139321778137;3311.7516186285643;3394.59264888215;3529.8941031769086;3641.10792855752;3674.3937250353392;46455.535444645124;51219.743901281;51405.742971285654;52070.73964630228;52508.21237681438;44177.77911110488;45070.54929450729;45194.54805451969;45271.547284526736;45751.542484575395;40697.79651101726;40983.385249220686;41096;41370;41720.37419438711;7492.363149132385;7505.624718763931;7524.774256772305;7536.359409450258;7556.886646700414;30182;30486.542701859933;31237;31237.219069523442;31290.530642039932;38971.415428769156;40424;41736.79131604444;42458;42466;6772.796816095525;6888.7244510221035;6923.723051077901;7035.155781306276;7231.876948082484;10045.196384289093;10068.597256109673;10277.177825773771;10318;10872.945635271773;9315.441073535609;9727.464989425367;9833.262505312274;9885.901140988786;10038.397696138256;9383.296252780932;9395.248380129437;9402.670906518239;9503.097205765718;9959.850602241117;9656.565454554702;9696.75758106053;9755.56099975517;9837.213022958003;9969.40183588987;8008.359331253369;8012.067386196064;8195.385346098947;8268.958655206685;8940.761510338767;7502.812429689301;7731.536107833548;8313.459625124347;8460.54026210728;8620.353473489387 09:13:58 INFO - 2015-11-18 09:13:58,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:13:58 INFO - 2015-11-18 09:13:58,465 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:13:58 INFO - 2015-11-18 09:13:58,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1584 09:13:58 INFO - 2015-11-18 09:13:58,465 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:13:58 INFO - 2015-11-18 09:13:58,465 DEBUG : BROWSER_OUTPUT: __startTimestamp1447866838451__endTimestamp 09:13:58 INFO - 2015-11-18 09:13:58,465 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,465 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:13:58 INFO - 2015-11-18 09:13:58,466 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:13:58 INFO - 2015-11-18 09:13:58,466 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,466 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4472.83 Median:4654.58 stddev:583.94 (12.5%) stddev-sans-first:568.39 09:13:58 INFO - 2015-11-18 09:13:58,467 DEBUG : BROWSER_OUTPUT: Values: 2672.4 2767.3 2778.9 2779.2 2803.4 4372.5 4471.6 4491.8 4510.9 4585.4 4448.5 4464.6 4489.6 4534.2 4605.9 4174.1 4177.9 4190.6 4267.0 4305.6 120.2 3941.9 4012.3 4080.2 4135.7 4078.4 4146.5 4147.9 4155.3 4177.7 4155.7 4180.6 4181.1 4207.8 4233.8 3995.5 4116.0 4121.0 4161.7 4193.9 4349.3 4435.2 4467.3 4514.2 4528.5 4694.9 4716.6 4716.7 4744.6 4750.2 4689.9 4771.5 4773.9 4815.8 4846.9 4449.3 4501.5 4541.1 4559.2 4580.4 4859.6 4903.4 4906.0 4914.8 4964.4 4482.1 4700.8 4714.6 4722.4 4758.4 4649.8 4720.6 4767.1 4774.9 4782.3 4757.9 4792.9 4803.4 4809.3 4839.9 4569.5 4777.7 4808.0 4822.8 4932.5 3728.5 3755.9 3755.9 3757.7 3762.3 3284.2 3436.3 3476.7 3477.2 3511.2 4577.5 4585.0 4596.2 4633.2 4639.9 4868.1 4877.3 4905.4 4944.7 4964.9 4454.2 4508.6 4567.9 4579.0 4660.1 4175.6 4239.6 4272.7 4278.6 4284.3 5008.4 5019.8 5043.4 5057.2 5070.5 4697.7 4817.2 4888.4 4914.9 4973.7 4996.1 5015.2 5015.9 5051.6 5062.7 4784.6 4806.7 4808.9 4817.6 4853.1 4880.6 4884.2 4891.0 4898.3 4921.9 4610.5 4666.9 4667.6 4673.9 4722.2 4674.5 4703.0 4747.3 4752.1 4753.7 4265.8 4620.7 4624.1 4658.2 4660.4 4632.7 4654.6 4703.9 4748.6 4758.7 4664.2 4678.3 4717.9 4726.6 4775.9 09:13:58 INFO - 2015-11-18 09:13:58,467 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,468 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40739.52 Median:32368.76 stddev:65781.14 (203.2%) stddev-sans-first:65896.24 09:13:58 INFO - 2015-11-18 09:13:58,469 DEBUG : BROWSER_OUTPUT: Values: 486.5 493.4 501.3 513.2 518.9 27759.0 28892.7 35170.5 35715.6 35884.3 38140.4 38315.0 38327.6 38699.2 38760.8 7296.5 8155.4 8234.5 8278.2 8295.6 7356.0 7476.2 9790.2 9900.4 9934.6 9584.1 9633.5 9694.9 9729.4 9847.7 7473.6 9751.6 9760.0 9764.0 9789.5 7334.5 9643.0 9813.9 9842.0 9988.0 35068.1 35483.0 35498.1 35853.8 35886.3 2442.6 2557.9 2617.8 2628.2 2724.7 24848.9 25061.0 25209.7 25626.2 26081.5 2099.0 2125.4 2145.0 2168.4 2233.1 222629.0 223903.0 227268.0 227447.0 229890.0 50676.2 51660.7 52068.2 54323.0 54800.5 62633.7 63747.4 64569.7 64581.0 64880.7 12029.3 14613.4 15429.7 15436.5 15452.0 11455.1 11654.5 11654.5 11661.4 11742.2 17447.3 17925.4 18064.1 18139.1 18215.9 6704.8 6722.6 6807.5 6853.0 6889.1 886.4 902.9 975.5 977.3 983.0 25429.0 25611.6 25624.0 25852.5 26248.3 879.7 897.5 935.5 957.0 1006.0 13371.1 13609.9 13652.9 14030.6 14181.9 272498.0 278635.0 280577.0 282135.0 282323.0 44359.8 44834.6 44887.8 44911.6 45161.0 1186.1 1193.8 1195.5 1196.2 1207.1 23968.8 24502.4 24628.0 24705.0 26253.9 42216.6 42493.0 42577.8 42591.4 42591.8 222331.9 247079.0 252699.0 253207.0 260817.0 25526.0 25649.0 25760.9 25939.6 26123.5 36893.4 37870.0 37914.2 38062.8 38352.4 31016.2 31816.4 31826.2 32142.8 32478.2 31686.8 31960.0 32354.7 32382.8 32469.4 31947.5 32390.7 32477.4 32751.7 33108.3 24582.9 27438.3 27957.0 27961.6 28170.4 21276.9 21333.7 21507.4 21521.2 21607.5 09:13:58 INFO - 2015-11-18 09:13:58,469 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,469 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24847.30 Median:478970.00 stddev:81294.58 (17.0%) stddev-sans-first:81501.73 09:13:58 INFO - 2015-11-18 09:13:58,470 DEBUG : BROWSER_OUTPUT: Values: 295.8 298.1 300.2 306.6 310.2 12444.0 12860.9 15092.8 15200.5 15490.1 12907.0 15280.3 15795.0 16378.3 16485.7 4617.3 4654.7 4755.0 4759.4 4810.1 3432.5 3529.1 3530.9 4709.9 4749.3 5039.2 5174.6 5181.9 5208.9 5235.5 5075.8 5133.8 5169.7 5184.6 5191.9 4455.0 4457.3 4463.7 4467.5 4517.6 17769.6 17875.6 18037.7 18308.9 19418.0 1684.8 1690.8 1760.7 1804.5 2047.8 11669.2 11750.9 11939.8 12271.6 12402.2 1401.7 1468.2 1508.1 1516.7 1586.0 52172.5 52806.7 52981.7 53025.1 53434.0 8229.6 8380.7 8567.3 8627.1 8671.5 10570.2 10581.4 10585.3 10595.2 10716.1 6956.7 7011.6 7042.7 7053.4 7053.8 7183.0 7191.8 7255.1 7321.3 7338.3 5018.1 5090.0 5092.9 5137.5 5148.8 1381.0 1435.4 1448.6 1469.3 1526.3 316.8 328.6 330.1 796.5 819.4 8345.3 9046.4 9536.7 10309.7 10322.3 373.2 409.2 414.6 426.1 433.9 4685.0 5249.8 5312.2 5319.2 5428.9 476959.0 480981.0 504450.0 507169.0 515119.0 61882.7 64692.7 64959.7 65412.7 65668.7 431.6 436.1 436.9 441.0 445.6 9526.3 9679.6 9681.0 9796.8 9825.2 29356.9 30145.7 30903.8 31019.4 31053.5 41136.6 41231.6 41687.4 41715.6 42104.8 5385.4 5469.6 5489.0 5528.5 5531.9 10150.2 10357.2 10470.8 10476.7 10542.4 8783.5 8796.9 8906.8 8930.7 9057.4 8488.1 8657.4 8687.5 8746.0 8940.0 7383.6 7452.6 8717.0 8784.1 9159.6 5189.5 5200.1 5203.5 5222.1 5258.7 8252.8 8316.9 8438.4 8509.7 8512.0 09:13:58 INFO - 2015-11-18 09:13:58,471 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,471 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4266.55 Median:5545.15 stddev:2175.48 (39.2%) stddev-sans-first:2164.81 09:13:58 INFO - 2015-11-18 09:13:58,471 DEBUG : BROWSER_OUTPUT: Values: 674.0 1413.8 1474.5 1475.4 1553.1 5640.5 5914.0 5919.9 5935.9 5992.1 5939.3 5963.8 6091.2 6093.5 6152.2 1803.9 1820.9 1822.8 1823.3 1831.7 1796.6 1849.3 1859.5 1872.9 1881.4 1836.2 1855.1 1857.2 1875.4 1878.4 1827.3 1862.7 1874.5 1875.0 1890.8 1828.2 1845.1 1848.0 1848.2 1848.3 6118.5 6122.9 6125.0 6153.5 6217.3 3303.3 3652.6 3750.1 3753.3 3769.5 2058.0 2092.0 2094.8 2247.0 2299.0 731.6 740.8 771.7 777.2 786.2 7877.7 7915.9 7950.3 8022.3 8034.1 3024.8 3139.9 3281.4 3297.5 3337.1 6917.5 7028.2 7066.8 7067.3 7068.0 3819.2 3842.6 3852.4 3878.0 3879.9 3490.0 3494.7 3501.6 3517.7 3530.0 3064.4 3080.8 3087.7 3112.7 3132.6 988.1 988.6 993.9 1001.9 1015.4 830.7 845.7 846.2 846.7 1065.3 6000.2 6040.5 6042.8 6049.9 6105.8 336.8 342.8 349.6 353.7 354.0 4681.6 4687.9 4738.7 4739.5 4740.6 6932.8 7002.0 7086.1 7105.2 7174.9 6971.9 6991.8 7030.1 7035.2 7071.0 5643.3 5698.0 5735.3 5804.2 5819.3 5534.7 5571.7 5597.5 5608.2 5636.4 6201.8 6291.3 6345.9 6366.1 6397.2 6389.0 6415.9 6460.6 6483.4 6498.8 5054.4 5106.9 5291.9 5453.3 5529.8 5908.9 5910.9 5911.1 5914.7 5930.7 5300.8 5561.4 5601.5 5614.9 5627.9 5497.8 5520.3 5555.6 5587.6 5639.0 5677.7 5693.8 5699.3 5702.6 5724.7 5098.0 5205.7 5233.8 5250.8 5294.7 5270.5 5332.2 5336.6 5347.6 5382.8 09:13:58 INFO - 2015-11-18 09:13:58,471 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,471 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4870.85 Median:5655.26 stddev:1527.17 (27.0%) stddev-sans-first:1491.91 09:13:58 INFO - 2015-11-18 09:13:58,472 DEBUG : BROWSER_OUTPUT: Values: 270.3 271.9 273.2 275.8 282.4 5443.7 5553.9 5576.9 5623.6 5666.3 5395.4 5583.8 5593.3 5601.1 5610.3 4212.9 4215.8 4217.2 4268.7 4287.0 4005.1 4155.1 4163.1 4195.7 4233.5 3871.0 4007.5 4116.9 4121.7 4131.0 4019.5 4143.5 4148.1 4148.3 4200.5 3571.3 3579.3 3579.9 3591.9 3618.7 5338.1 5359.7 5364.0 5370.0 5400.9 4726.2 4729.0 4731.2 4739.1 4759.7 5663.4 5836.5 5846.1 5866.9 5879.2 3857.7 3857.7 3862.4 3864.2 3895.4 5861.6 5964.5 6025.8 6148.0 6163.5 3821.2 3884.2 3905.1 3916.0 3916.8 3928.5 3982.5 3993.0 3993.1 3995.9 4673.3 4685.0 4686.2 4687.9 4697.1 5663.8 5838.8 5847.3 5851.0 5864.0 1373.9 1378.1 1381.3 1383.2 1384.0 863.5 877.2 884.1 892.9 895.3 5643.2 5643.3 5653.1 5657.4 5670.4 6097.4 6097.7 6099.8 6100.0 6173.2 5644.5 5644.8 5645.4 5696.2 5741.6 3181.2 3261.2 3288.4 3311.2 3318.1 6248.0 6286.8 6296.6 6315.1 6343.0 6213.9 6217.8 6220.0 6251.4 6277.3 6004.6 6237.0 6243.3 6306.3 6317.6 5995.9 6068.6 6125.6 6130.7 6144.4 5868.9 5927.6 5930.9 5938.8 5975.9 5823.4 5952.4 6230.8 6240.3 6307.3 3835.6 4010.8 4021.9 4025.7 4063.4 6155.5 6182.1 6186.9 6234.5 6242.5 5969.1 5980.0 5982.7 6024.7 6029.4 5720.1 5918.4 5954.0 6008.7 6015.6 5816.2 5829.3 5866.6 5872.5 5892.6 5926.2 5944.2 5990.6 5992.2 6016.0 5636.8 5799.4 5828.6 5833.2 5858.5 09:13:58 INFO - 2015-11-18 09:13:58,473 DEBUG : BROWSER_OUTPUT: 09:13:58 INFO - 2015-11-18 09:13:58,473 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12094.88 Median:507.12 stddev:14436.44 (2846.7%) stddev-sans-first:14451.16 09:13:58 INFO - 2015-11-18 09:13:58,474 DEBUG : BROWSER_OUTPUT: Values: 607.7 629.2 644.1 649.4 665.6 12066.8 12275.6 12298.6 12300.6 12347.7 11204.1 11465.9 11772.9 11781.8 11802.3 622.1 625.9 631.3 789.7 810.0 619.8 626.7 784.6 793.7 801.9 817.2 824.8 830.9 831.2 831.5 649.1 652.9 817.3 825.2 825.7 485.2 487.0 490.7 602.4 614.8 12100.5 12274.3 12290.0 12303.1 12459.8 10068.3 10175.7 10264.7 10619.5 10811.7 7749.7 8245.8 8311.5 8342.7 8346.8 2909.6 2933.6 2978.8 2987.1 3093.6 43670.6 45135.8 45433.8 45521.0 45963.8 7952.4 8012.5 8058.2 8100.7 8132.3 17034.5 17055.7 17229.4 17242.9 17272.2 5746.7 5830.1 5960.2 5961.6 6034.9 3383.7 3402.5 3422.8 3446.5 3462.4 2445.9 2492.1 2513.2 2530.4 2537.9 353.6 354.4 357.9 358.1 360.3 493.7 497.7 500.9 504.0 532.9 6540.4 7058.8 7144.0 7147.1 7324.2 500.9 502.7 510.2 531.6 547.6 3311.8 3394.6 3529.9 3641.1 3674.4 46455.5 51219.7 51405.7 52070.7 52508.2 44177.8 45070.5 45194.5 45271.5 45751.5 40697.8 40983.4 41096.0 41370.0 41720.4 7492.4 7505.6 7524.8 7536.4 7556.9 30182.0 30486.5 31237.0 31237.2 31290.5 38971.4 40424.0 41736.8 42458.0 42466.0 6772.8 6888.7 6923.7 7035.2 7231.9 10045.2 10068.6 10277.2 10318.0 10872.9 9315.4 9727.5 9833.3 9885.9 10038.4 9383.3 9395.2 9402.7 9503.1 9959.9 9656.6 9696.8 9755.6 9837.2 9969.4 8008.4 8012.1 8195.4 8269.0 8940.8 7502.8 7731.5 8313.5 8460.5 8620.4 09:13:58 INFO - 2015-11-18 09:13:58,474 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:13:58 INFO - 2015-11-18 09:13:58,474 DEBUG : BROWSER_OUTPUT: 09:13:59 INFO - 2015-11-18 09:13:59,152 INFO : Browser exited with error code: 0 09:13:59 INFO - 2015-11-18 09:13:59,183 INFO : Completed test dromaeo_css (00:18:34) 09:13:59 INFO - 2015-11-18 09:13:59,183 INFO : Starting test kraken 09:13:59 INFO - 2015-11-18 09:13:59,183 DEBUG : operating with platform_type : mac_ 09:13:59 INFO - 2015-11-18 09:13:59,183 INFO : Initialising browser for kraken test... 09:13:59 INFO - 2015-11-18 09:13:59,197 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/tmp1KvR2i/profile http://localhost:49266/getInfo.html 09:14:01 INFO - 2015-11-18 09:14:01,660 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:14:01 INFO - 2015-11-18 09:14:01,660 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:14:01 INFO - 2015-11-18 09:14:01,661 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:14:01 INFO - 2015-11-18 09:14:01,661 DEBUG : BROWSER_OUTPUT: __metrics 09:14:01 INFO - 2015-11-18 09:14:01,677 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:02 INFO - 2015-11-18 09:14:02,443 INFO : Browser initialized. 09:14:02 INFO - 2015-11-18 09:14:02,443 INFO : Running cycle 1/1 for kraken test... 09:14:02 INFO - 2015-11-18 09:14:02,443 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/tmp1KvR2i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:14:14 INFO - 2015-11-18 09:14:14,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 229195776 09:14:14 INFO - 2015-11-18 09:14:14,524 DEBUG : BROWSER_OUTPUT: 09:14:17 INFO - 2015-11-18 09:14:17,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:17 INFO - 2015-11-18 09:14:17,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 285941760 09:14:17 INFO - 2015-11-18 09:14:17,951 DEBUG : BROWSER_OUTPUT: 09:14:20 INFO - 2015-11-18 09:14:20,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 09:14:21 INFO - 2015-11-18 09:14:21,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 299483136 09:14:21 INFO - 2015-11-18 09:14:21,459 DEBUG : BROWSER_OUTPUT: 09:14:24 INFO - 2015-11-18 09:14:24,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 09:14:25 INFO - 2015-11-18 09:14:25,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 283107328 09:14:25 INFO - 2015-11-18 09:14:25,275 DEBUG : BROWSER_OUTPUT: 09:14:27 INFO - 2015-11-18 09:14:27,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 09:14:28 INFO - 2015-11-18 09:14:28,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 284258304 09:14:28 INFO - 2015-11-18 09:14:28,016 DEBUG : BROWSER_OUTPUT: 09:14:30 INFO - 2015-11-18 09:14:30,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:30 INFO - 2015-11-18 09:14:30,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 285102080 09:14:30 INFO - 2015-11-18 09:14:30,978 DEBUG : BROWSER_OUTPUT: 09:14:34 INFO - 2015-11-18 09:14:34,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:34 INFO - 2015-11-18 09:14:34,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 285261824 09:14:34 INFO - 2015-11-18 09:14:34,926 DEBUG : BROWSER_OUTPUT: 09:14:38 INFO - 2015-11-18 09:14:38,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:38 INFO - 2015-11-18 09:14:38,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 285380608 09:14:38 INFO - 2015-11-18 09:14:38,969 DEBUG : BROWSER_OUTPUT: 09:14:42 INFO - 2015-11-18 09:14:42,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 09:14:42 INFO - 2015-11-18 09:14:42,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 285753344 09:14:42 INFO - 2015-11-18 09:14:42,638 DEBUG : BROWSER_OUTPUT: 09:14:44 INFO - 2015-11-18 09:14:44,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:44 INFO - 2015-11-18 09:14:44,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 320393216 09:14:44 INFO - 2015-11-18 09:14:44,931 DEBUG : BROWSER_OUTPUT: 09:14:46 INFO - 2015-11-18 09:14:46,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:47 INFO - 2015-11-18 09:14:47,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 319524864 09:14:47 INFO - 2015-11-18 09:14:47,536 DEBUG : BROWSER_OUTPUT: 09:14:49 INFO - 2015-11-18 09:14:49,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:50 INFO - 2015-11-18 09:14:50,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 327163904 09:14:50 INFO - 2015-11-18 09:14:50,400 DEBUG : BROWSER_OUTPUT: 09:14:53 INFO - 2015-11-18 09:14:53,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:53 INFO - 2015-11-18 09:14:53,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 329150464 09:14:53 INFO - 2015-11-18 09:14:53,839 DEBUG : BROWSER_OUTPUT: 09:14:56 INFO - 2015-11-18 09:14:56,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:57 INFO - 2015-11-18 09:14:57,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 329822208 09:14:57 INFO - 2015-11-18 09:14:57,310 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 09:14:59 INFO - 2015-11-18 09:14:59,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 387710976 09:14:59 INFO - 2015-11-18 09:14:59,447 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,447 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:14:59 INFO - 2015-11-18 09:14:59,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:14:59 INFO - 2015-11-18 09:14:59,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:14:59 INFO - 2015-11-18 09:14:59,447 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:14:59 INFO - 2015-11-18 09:14:59,448 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;123;117;124;128;129;110;123;124;121 09:14:59 INFO - 2015-11-18 09:14:59,448 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;177;152;175;181;149;173;165;138;190;148 09:14:59 INFO - 2015-11-18 09:14:59,448 DEBUG : BROWSER_OUTPUT: |2;audio-dft;179;180;181;190;182;182;179;179;180;182 09:14:59 INFO - 2015-11-18 09:14:59,448 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;93;99;97;79;79;79;87;91;75 09:14:59 INFO - 2015-11-18 09:14:59,448 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;109;152;104;106;101;145;100;101;150 09:14:59 INFO - 2015-11-18 09:14:59,448 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;142;129;135;135;136;135;135;136;129 09:14:59 INFO - 2015-11-18 09:14:59,449 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;142;148;143;142;141;141;148;143;142;141 09:14:59 INFO - 2015-11-18 09:14:59,449 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;109;109;107;106;114;108;109;108;113 09:14:59 INFO - 2015-11-18 09:14:59,449 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;66;69;69;69;69;71;73;82;71;69 09:14:59 INFO - 2015-11-18 09:14:59,450 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;76;77;78;78;78;82;80;78;77 09:14:59 INFO - 2015-11-18 09:14:59,451 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;98;96;101;101;99;95;96;98;97;101 09:14:59 INFO - 2015-11-18 09:14:59,451 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;157;144;144;147;153;144;146;142;145 09:14:59 INFO - 2015-11-18 09:14:59,451 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;159;171;171;176;177;166;174;171;170;178 09:14:59 INFO - 2015-11-18 09:14:59,451 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;78;79;79;80;78;82;84;84;79 09:14:59 INFO - 2015-11-18 09:14:59,451 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:14:59 INFO - 2015-11-18 09:14:59,451 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:14:59 INFO - 2015-11-18 09:14:59,452 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 09:14:59 INFO - 2015-11-18 09:14:59,452 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:14:59 INFO - 2015-11-18 09:14:59,452 DEBUG : BROWSER_OUTPUT: __startTimestamp1447866899446__endTimestamp 09:14:59 INFO - 2015-11-18 09:14:59,452 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,452 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:14:59 INFO - 2015-11-18 09:14:59,452 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:14:59 INFO - 2015-11-18 09:14:59,453 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,453 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:121.70 Median:123.50 stddev:5.58 (4.5%) stddev-sans-first:5.75 09:14:59 INFO - 2015-11-18 09:14:59,453 DEBUG : BROWSER_OUTPUT: Values: 118.0 123.0 117.0 124.0 128.0 129.0 110.0 123.0 124.0 121.0 09:14:59 INFO - 2015-11-18 09:14:59,453 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,453 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:164.80 Median:174.00 stddev:17.10 (9.8%) stddev-sans-first:17.56 09:14:59 INFO - 2015-11-18 09:14:59,454 DEBUG : BROWSER_OUTPUT: Values: 177.0 152.0 175.0 181.0 149.0 173.0 165.0 138.0 190.0 148.0 09:14:59 INFO - 2015-11-18 09:14:59,454 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,454 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.40 Median:181.50 stddev:3.27 (1.8%) stddev-sans-first:3.35 09:14:59 INFO - 2015-11-18 09:14:59,454 DEBUG : BROWSER_OUTPUT: Values: 179.0 180.0 181.0 190.0 182.0 182.0 179.0 179.0 180.0 182.0 09:14:59 INFO - 2015-11-18 09:14:59,454 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,455 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.70 Median:89.00 stddev:8.79 (9.9%) stddev-sans-first:8.88 09:14:59 INFO - 2015-11-18 09:14:59,456 DEBUG : BROWSER_OUTPUT: Values: 78.0 93.0 99.0 97.0 79.0 79.0 79.0 87.0 91.0 75.0 09:14:59 INFO - 2015-11-18 09:14:59,456 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,456 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.70 Median:109.00 stddev:21.89 (20.1%) stddev-sans-first:22.99 09:14:59 INFO - 2015-11-18 09:14:59,456 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 152.0 104.0 106.0 101.0 145.0 100.0 101.0 150.0 09:14:59 INFO - 2015-11-18 09:14:59,456 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,456 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.70 Median:135.00 stddev:3.68 (2.7%) stddev-sans-first:3.91 09:14:59 INFO - 2015-11-18 09:14:59,456 DEBUG : BROWSER_OUTPUT: Values: 135.0 142.0 129.0 135.0 135.0 136.0 135.0 135.0 136.0 129.0 09:14:59 INFO - 2015-11-18 09:14:59,457 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,457 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:143.10 Median:142.50 stddev:2.69 (1.9%) stddev-sans-first:2.82 09:14:59 INFO - 2015-11-18 09:14:59,457 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 143.0 142.0 141.0 141.0 148.0 143.0 142.0 141.0 09:14:59 INFO - 2015-11-18 09:14:59,457 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,457 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:109.70 Median:109.00 stddev:2.91 (2.7%) stddev-sans-first:2.64 09:14:59 INFO - 2015-11-18 09:14:59,457 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 109.0 107.0 106.0 114.0 108.0 109.0 108.0 113.0 09:14:59 INFO - 2015-11-18 09:14:59,458 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,458 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.80 Median:70.00 stddev:4.34 (6.2%) stddev-sans-first:4.24 09:14:59 INFO - 2015-11-18 09:14:59,458 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 69.0 69.0 69.0 71.0 73.0 82.0 71.0 69.0 09:14:59 INFO - 2015-11-18 09:14:59,458 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,458 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:77.60 Median:78.00 stddev:2.59 (3.3%) stddev-sans-first:1.79 09:14:59 INFO - 2015-11-18 09:14:59,458 DEBUG : BROWSER_OUTPUT: Values: 72.0 76.0 77.0 78.0 78.0 78.0 82.0 80.0 78.0 77.0 09:14:59 INFO - 2015-11-18 09:14:59,459 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,459 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.20 Median:96.50 stddev:2.25 (2.3%) stddev-sans-first:2.39 09:14:59 INFO - 2015-11-18 09:14:59,459 DEBUG : BROWSER_OUTPUT: Values: 98.0 96.0 101.0 101.0 99.0 95.0 96.0 98.0 97.0 101.0 09:14:59 INFO - 2015-11-18 09:14:59,459 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,459 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:145.50 stddev:4.72 (3.2%) stddev-sans-first:4.91 09:14:59 INFO - 2015-11-18 09:14:59,459 DEBUG : BROWSER_OUTPUT: Values: 144.0 157.0 144.0 144.0 147.0 153.0 144.0 146.0 142.0 145.0 09:14:59 INFO - 2015-11-18 09:14:59,460 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,460 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:172.50 stddev:5.66 (3.3%) stddev-sans-first:3.87 09:14:59 INFO - 2015-11-18 09:14:59,460 DEBUG : BROWSER_OUTPUT: Values: 159.0 171.0 171.0 176.0 177.0 166.0 174.0 171.0 170.0 178.0 09:14:59 INFO - 2015-11-18 09:14:59,460 DEBUG : BROWSER_OUTPUT: 09:14:59 INFO - 2015-11-18 09:14:59,460 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.10 Median:79.50 stddev:2.38 (3.0%) stddev-sans-first:2.40 09:14:59 INFO - 2015-11-18 09:14:59,462 DEBUG : BROWSER_OUTPUT: Values: 78.0 78.0 79.0 79.0 80.0 78.0 82.0 84.0 84.0 79.0 09:14:59 INFO - 2015-11-18 09:14:59,462 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:14:59 INFO - 2015-11-18 09:14:59,462 DEBUG : BROWSER_OUTPUT: 09:15:00 INFO - 2015-11-18 09:15:00,220 INFO : Browser exited with error code: 0 09:15:00 INFO - 2015-11-18 09:15:00,273 INFO : Completed test kraken (00:01:01) 09:15:00 INFO - 2015-11-18 09:15:00,273 INFO : Starting test v8_7 09:15:00 INFO - 2015-11-18 09:15:00,273 DEBUG : operating with platform_type : mac_ 09:15:00 INFO - 2015-11-18 09:15:00,273 INFO : Initialising browser for v8_7 test... 09:15:00 INFO - 2015-11-18 09:15:00,288 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/tmp6rHR8b/profile http://localhost:49266/getInfo.html 09:15:02 INFO - 2015-11-18 09:15:02,727 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:15:02 INFO - 2015-11-18 09:15:02,727 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:15:02 INFO - 2015-11-18 09:15:02,727 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:15:02 INFO - 2015-11-18 09:15:02,727 DEBUG : BROWSER_OUTPUT: __metrics 09:15:02 INFO - 2015-11-18 09:15:02,743 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:03 INFO - 2015-11-18 09:15:03,543 INFO : Browser initialized. 09:15:03 INFO - 2015-11-18 09:15:03,544 INFO : Running cycle 1/1 for v8_7 test... 09:15:03 INFO - 2015-11-18 09:15:03,544 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/T/tmp6rHR8b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:15:15 INFO - 2015-11-18 09:15:15,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 230060032 09:15:15 INFO - 2015-11-18 09:15:15,597 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 09:15:38 INFO - 2015-11-18 09:15:38,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 624037888 09:15:38 INFO - 2015-11-18 09:15:38,724 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,724 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:15:38 INFO - 2015-11-18 09:15:38,724 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:15:38 INFO - 2015-11-18 09:15:38,724 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |0;Richards;188.040616773223 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;219.39447125932426 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |2;Encrypt;360.1008282319049 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6711.4093959731545 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2219.512195121951 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |5;Earley;1033.0237358101135 09:15:38 INFO - 2015-11-18 09:15:38,725 DEBUG : BROWSER_OUTPUT: |6;Boyer;14720.588235294117 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: |7;RegExp;33491.80327868852 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: |8;Splay;788.6435331230284 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6407.643312101911 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: __startTimestamp1447866938718__endTimestamp 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:15:38 INFO - 2015-11-18 09:15:38,726 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:188.04 Median:188.04 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: Values: 188.0 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:219.39 Median:219.39 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: Values: 219.4 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:360.10 Median:360.10 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: Values: 360.1 09:15:38 INFO - 2015-11-18 09:15:38,727 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6711.41 Median:6711.41 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: Values: 6711.4 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2219.51 Median:2219.51 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: Values: 2219.5 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1033.02 Median:1033.02 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,728 DEBUG : BROWSER_OUTPUT: Values: 1033.0 09:15:38 INFO - 2015-11-18 09:15:38,729 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,729 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14720.59 Median:14720.59 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,729 DEBUG : BROWSER_OUTPUT: Values: 14720.6 09:15:38 INFO - 2015-11-18 09:15:38,729 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,729 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33491.80 Median:33491.80 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,729 DEBUG : BROWSER_OUTPUT: Values: 33491.8 09:15:38 INFO - 2015-11-18 09:15:38,729 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,730 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,730 DEBUG : BROWSER_OUTPUT: Values: 788.6 09:15:38 INFO - 2015-11-18 09:15:38,730 DEBUG : BROWSER_OUTPUT: 09:15:38 INFO - 2015-11-18 09:15:38,730 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6407.64 Median:6407.64 stddev:0.00 (0.0%) 09:15:38 INFO - 2015-11-18 09:15:38,730 DEBUG : BROWSER_OUTPUT: Values: 6407.6 09:15:38 INFO - 2015-11-18 09:15:38,730 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:15:38 INFO - 2015-11-18 09:15:38,730 DEBUG : BROWSER_OUTPUT: 09:15:39 INFO - 2015-11-18 09:15:39,492 INFO : Browser exited with error code: 0 09:15:39 INFO - 2015-11-18 09:15:39,514 INFO : Completed test v8_7 (00:00:39) 09:15:39 INFO - 2015-11-18 09:15:39,963 INFO : Completed test suite (00:20:15) 09:15:39 INFO - 2015-11-18 09:15:39,963 DEBUG : Working with test: dromaeo_css 09:15:39 INFO - 2015-11-18 09:15:39,963 DEBUG : Generating results file: dromaeo_css 09:15:39 INFO - 2015-11-18 09:15:39,964 DEBUG : Working with test: kraken 09:15:39 INFO - 2015-11-18 09:15:39,964 DEBUG : Generating results file: kraken 09:15:39 INFO - 2015-11-18 09:15:39,965 INFO : javascript benchmark 09:15:39 INFO - 2015-11-18 09:15:39,965 DEBUG : Working with test: v8_7 09:15:39 INFO - 2015-11-18 09:15:39,965 DEBUG : Generating results file: v8_7 09:15:39 INFO - 2015-11-18 09:15:39,965 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:15:40 INFO - 2015-11-18 09:15:40,096 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 09:15:40 INFO - 2015-11-18 09:15:40,096 DEBUG : process_Request line: dromaeo_css 5827.92 graph.html#tests=[[72,63,55]] 09:15:40 INFO - 2015-11-18 09:15:40,097 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:15:40 INFO - 2015-11-18 09:15:40,136 DEBUG : process_Request line: kraken 1703.40 graph.html#tests=[[232,63,55]] 09:15:40 INFO - 2015-11-18 09:15:40,136 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:15:40 INFO - 2015-11-18 09:15:40,238 DEBUG : process_Request line: v8_7 16006.91 graph.html#tests=[[230,63,55]] 09:15:40 INFO - 2015-11-18 09:15:40,239 INFO : javascript benchmark 09:15:40 INFO - 2015-11-18 09:15:40,241 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2672.385351369185, 2767.3220061085035, 2778.8888444462223, 2779.221817890989, 2803.4393121375724, 4372.540883207265, 4471.619912307449, 4491.752953587551, 4510.887227819306, 4585.380973568572, 4448.488423831261, 4464.575865292792, 4489.618382437488, 4534.206513860077, 4605.861824145281, 4174.08170202555, 4177.874663760077, 4190.643795277405, 4266.997255644937, 4305.63402110821, 120.16468206763899, 3941.881743547698, 4012.25773231953, 4080.18396320737, 4135.689823263252, 4078.3882417637296, 4146.460960075201, 4147.875563733093, 4155.252054630166, 4177.749335039907, 4155.667546596265, 4180.623743863037, 4181.142865712522, 4207.810648520824, 4233.767142807144, 3995.4805875236325, 4116.0, 4120.979395103005, 4161.729487583298, 4193.874183774492, 4349.282368409209, 4435.179491793996, 4467.285234362519, 4514.164879497271, 4528.50186479487, 4694.929576056362, 4716.622670186377, 4716.669833111683, 4744.6441516886025, 4750.216214324632, 4689.859304220879, 4771.451283102453, 4773.856784296477, 4815.831445899376, 4846.903061938777, 4449.28811390176, 4501.549845015505, 4541.114482675879, 4559.179347717442, 4580.358749775034, 4859.611231101503, 4903.362562866804, 4906.0, 4914.754262286871, 4964.404271487445, 4482.148391805546, 4700.764961751899, 4714.57568818808, 4722.362481065013, 4758.42898852133, 4649.767511624405, 4720.551547602972, 4767.118083154627, 4774.904501909942, 4782.258749893772, 4757.904841903142, 4792.904141917142, 4803.351547541107, 4809.278608208727, 4839.903201935942, 4569.543045695404, 4777.737224452619, 4807.975960120247, 4822.807087716522, 4932.457429682732, 3728.459373390843, 3755.8873233802483, 3755.887323380303, 3757.680597149218, 3762.3415902217002, 3284.1625385526536, 3436.329915666421, 3476.7392445566684, 3477.1828620274214, 3511.17487390463, 4577.542245775462, 4584.954150458453, 4596.241620132708, 4633.166030114612, 4639.930401043987, 4868.148074087091, 4877.341558889575, 4905.3623029006, 4944.678595891256, 4964.925526117111, 4454.175977444183, 4508.571685689854, 4567.9086418271445, 4579.038401935631, 4660.1145782301255, 4175.645070169009, 4239.554846741109, 4272.679549033773, 4278.55075217104, 4284.293091639907, 5008.4240312364545, 5019.824306149268, 5043.36957880265, 5057.165567681365, 5070.4929507049, 4697.741624210701, 4817.181079216612, 4888.437829649636, 4914.926276105933, 4973.676711013917, 4996.050750357421, 5015.1975683890405, 5015.874603134951, 5051.646384753032, 5062.67092638992, 4784.569388755029, 4806.663533552758, 4808.927866081942, 4817.566419022305, 4853.126437241331, 4880.633952453509, 4884.218525036119, 4891.046245981999, 4898.289747986593, 4921.8523444296725, 4610.469795973372, 4666.92999605013, 4667.626589872734, 4673.906521869476, 4722.244440889579, 4674.5091765365505, 4702.952970470252, 4747.311639812277, 4752.073345697556, 4753.738544380092, 4265.808038638207, 4620.676552641283, 4624.098300831306, 4658.231391820312, 4660.440747110233, 4632.675712700078, 4654.581087702123, 4703.929441058455, 4748.62011039123, 4758.666893317434, 4664.160451118695, 4678.321643361625, 4717.9056418872115, 4726.6455015874635, 4775.880602984953], "unit": "ms", "name": "dojo.html", "value": 4438.53064034298}, {"lowerIsBetter": false, "replicates": [486.5329283887468, 493.3808070871056, 501.3407369309358, 513.1712284660275, 518.9299444574986, 27759.0, 28892.711072889266, 35170.47244291334, 35715.64284357156, 35884.282314353695, 38140.42789358162, 38315.0, 38327.616723832754, 38699.22601547974, 38760.80619596905, 7296.489245752799, 8155.4291199616055, 8234.505929644241, 8278.172182781735, 8295.585220738969, 7356.043714317158, 7476.214997425273, 9790.167835733935, 9900.356476828983, 9934.602615895355, 9584.137427631511, 9633.518324083803, 9694.903050969471, 9729.416235025885, 9847.704568862946, 7473.588952607604, 9751.609935602639, 9759.95120024399, 9763.951180244088, 9789.461579613118, 7334.4865859389865, 9643.0, 9813.90186098137, 9841.950790246003, 9988.0, 35068.123296917525, 35483.0, 35498.11254718627, 35853.82073089644, 35886.28227435463, 2442.63729271882, 2557.8848951797213, 2617.8429294242214, 2628.2246737212377, 2724.7275272472793, 24848.875755621106, 25060.997560097574, 25209.747902521107, 25626.23121306364, 26081.478370432484, 2098.9790102098937, 2125.3730149605904, 2144.9785502144937, 2168.392850002002, 2233.0732745910427, 222629.0, 223903.0, 227268.0, 227447.0, 229889.99999999834, 50676.239856402186, 51660.74169629203, 52068.21897671538, 54323.0, 54800.45199548033, 62633.68683156646, 63747.36252637414, 64569.67715161394, 64581.0, 64880.72917447961, 12029.338386388657, 14613.415463381558, 15429.691406171814, 15436.459723909833, 15452.0, 11455.140864435034, 11654.475548600334, 11654.475548600334, 11661.35862527569, 11742.236754611095, 17447.302107915795, 17925.37261195852, 18064.09679516019, 18139.09304534768, 18215.908920455313, 6704.765333213314, 6722.596644201363, 6807.4894382921475, 6853.0, 6889.105495988643, 886.4193952960821, 902.8781114549452, 975.5366201054584, 977.2524019125375, 982.9875228514642, 25429.0, 25611.61582576263, 25624.0, 25852.482950341266, 26248.34379140537, 879.6745204274459, 897.4749771383683, 935.4527601353149, 956.9951550871696, 1006.0342071611188, 13371.130876492996, 13609.863901360859, 13652.931735341459, 14030.579082627537, 14181.929090354482, 272498.0, 278635.0, 280577.0, 282135.0, 282323.0, 44359.77820110943, 44834.55165448369, 44887.77556112264, 44911.55088449074, 45161.0, 1186.068935885343, 1193.7910865598485, 1195.5158160944832, 1196.186593116689, 1207.0645249931374, 23968.76031239735, 24502.38744031342, 24628.0, 24705.0, 26253.868730656224, 42216.577834221265, 42493.0, 42577.787111064245, 42591.3611295837, 42591.7870410646, 222331.87847154494, 247079.0, 252699.0, 253207.0, 260817.0, 25526.0, 25649.0, 25760.8711956439, 25939.610905836806, 26123.477530449665, 36893.44659830158, 37870.0, 37914.24171516499, 38062.80968595139, 38352.42471362987, 31016.22459438532, 31816.363672725955, 31826.204344890637, 32142.83928580342, 32478.188045299055, 31686.841565792023, 31960.0, 32354.676453235166, 32382.83808580942, 32469.350612987135, 31947.520787188674, 32390.676093238766, 32477.350452990337, 32751.672483275815, 33108.337833243684, 24582.850492622063, 27438.314042149104, 27957.0, 27961.580576291777, 28170.43659126847, 21276.893615531822, 21333.6799948004, 21507.354779356643, 21521.246756363453, 21607.45981350479], "unit": "ms", "name": "ext.html", "value": 16522.414788755603}, {"lowerIsBetter": false, "replicates": [295.80772497876376, 298.07150725490106, 300.2493765586035, 306.6396983544335, 310.15018848355504, 12444.0, 12860.935695321534, 15092.773608395883, 15200.467983620576, 15490.148041857694, 12907.0, 15280.312385942632, 15795.0, 16378.344866205338, 16485.67028659426, 4617.261238201897, 4654.674172807905, 4755.0489902019735, 4759.381280433538, 4810.11012962603, 3432.4508078707413, 3529.0824385659785, 3530.929381412383, 4709.905801883978, 4749.311349854269, 5039.168537191359, 5174.637775355726, 5181.87045323868, 5208.869778255555, 5235.502627250406, 5075.771590278447, 5133.84598462043, 5169.6898186108765, 5184.611154163415, 5191.87020324493, 4454.955450445486, 4457.3091170868565, 4463.709858859196, 4467.530909254547, 4517.616002639779, 17769.644607107915, 17875.553111172194, 18037.7294340585, 18308.90845545777, 19418.0, 1684.8146703862565, 1690.7548405481136, 1760.709482935314, 1804.5082864134615, 2047.8156965873143, 11669.241499302518, 11750.941245293805, 11939.761204775856, 12271.57049503263, 12402.19385739933, 1401.7126489069717, 1468.1998310920574, 1508.1328236264192, 1516.6966606678598, 1585.952421427359, 52172.478275217145, 52806.735966319924, 52981.7350913243, 53025.08362040086, 53434.0, 8229.588520574067, 8380.664773409117, 8567.314614830799, 8627.094155113622, 8671.479711217347, 10570.207234457446, 10581.36511809294, 10585.259031867849, 10595.15238780911, 10716.089132423831, 6956.7217311307995, 7011.6143612100805, 7042.718291268292, 7053.365197132282, 7053.788386348418, 7182.96408517954, 7191.820204494825, 7255.09311336083, 7321.3410793027815, 7338.266173382619, 5018.071656743514, 5090.0, 5092.949070509321, 5137.537621614073, 5148.76830542619, 1380.9723805523834, 1435.3899592673072, 1448.5654303708845, 1469.258024697521, 1526.259764014452, 316.8114971591899, 328.62864962592596, 330.1333998254582, 796.506166176974, 819.4223072733828, 8345.332373410112, 9046.411983221069, 9536.666216682383, 10309.690709278733, 10322.329048611966, 373.20321114420364, 409.1591778894341, 414.61440859999885, 426.1285670803153, 433.86767036053675, 4685.0395668887795, 5249.763760630781, 5312.1766126250495, 5319.202119682079, 5428.864278393072, 476959.0, 480981.0, 504450.0, 507169.0, 515119.0, 61882.69058654678, 64692.676536617015, 64959.675201623686, 65412.67293663501, 65668.67165664141, 431.55334229073384, 436.11033491676625, 436.85802114312975, 440.96251818595135, 445.58337954012455, 9526.285528585522, 9679.612815487302, 9680.951595241979, 9796.804063918538, 9825.16486098661, 29356.853215733783, 30145.69854301429, 30903.845480772452, 31019.379612408076, 31053.534196986613, 41136.58863411328, 41231.58768412397, 41687.374689379074, 41715.582844172386, 42104.78947605365, 5385.434529374359, 5469.589780766538, 5489.0, 5528.474794894479, 5531.8893622128135, 10150.187984961038, 10357.22320825926, 10470.790584188426, 10476.68569942903, 10542.420166890588, 8783.472991620267, 8796.91203087961, 8906.821863562822, 8930.732078037669, 9057.36598438103, 8488.066312705474, 8657.39398242117, 8687.522186279815, 8746.0, 8940.0, 7383.556986580822, 7452.552846829208, 8717.041125476066, 8784.077671844365, 9159.633614655339, 5189.506996835295, 5200.141976573823, 5203.453637368173, 5222.060029194781, 5258.710770907637, 8252.752417427488, 8316.916830831857, 8438.409311348147, 8509.659613615386, 8512.0], "unit": "ms", "name": "jquery.html", "value": 6669.352219293165}, {"lowerIsBetter": false, "replicates": [673.9561928474652, 1413.8232720909884, 1474.5281509916827, 1475.358219174659, 1553.1224857955253, 5640.492355687988, 5914.0, 5919.940800591993, 5935.85160370991, 5992.101184822279, 5939.316978547468, 5963.791267305645, 6091.177691011712, 6093.542984276175, 6152.169457123287, 1803.9098045097726, 1820.872538922276, 1822.8086050964657, 1823.2524664887399, 1831.7069268916975, 1796.5778042160082, 1849.2972670385302, 1859.479345783176, 1872.896990665513, 1881.4261650196684, 1836.2471386731443, 1855.0817345414039, 1857.1642760757645, 1875.4279944616887, 1878.4176905159377, 1827.2964908510187, 1862.6833438315518, 1874.4751469588537, 1875.0156168011767, 1890.7542019537373, 1828.2138680367436, 1845.1143451143391, 1847.9630407391912, 1848.168324254091, 1848.3068849181557, 6118.4799292060225, 6122.8775424491705, 6124.96937515314, 6153.538484613672, 6217.347178546278, 3303.339332133559, 3652.5799533053773, 3750.1187221003042, 3753.2681127180213, 3769.5099637047283, 2057.989710051455, 2092.016752126498, 2094.800993905592, 2246.977530224693, 2298.9999350282515, 731.5647189921988, 740.7703611880335, 771.6720393832599, 777.2033665492859, 786.1862971824191, 7877.724279650185, 7915.88126178102, 7950.3242224410415, 8022.277994980422, 8034.116247212802, 3024.758019358446, 3139.937201255962, 3281.409346317686, 3297.5218593303834, 3337.0656216259486, 6917.515773895779, 7028.156621205488, 7066.823329416703, 7067.328603782633, 7068.0, 3819.197968426606, 3842.615738426135, 3852.4221366795205, 3878.0, 3879.922401551953, 3489.965100349015, 3494.685478306914, 3501.632328605511, 3517.718582513393, 3530.011596752913, 3064.417760625474, 3080.8151510909415, 3087.706667866549, 3112.673169317234, 3132.561441398206, 988.0564061321421, 988.5996171550534, 993.8857031441477, 1001.9298649094493, 1015.3958394755109, 830.7258604660448, 845.7335939179139, 846.2130218896485, 846.6528723223449, 1065.3341661461586, 6000.249968753906, 6040.456358927718, 6042.758289668452, 6049.939500604937, 6105.786297479567, 336.7962382758445, 342.78062040293736, 349.587486765619, 353.68698701649225, 353.97168226541817, 4681.555252251031, 4687.906241875144, 4738.668293219442, 4739.502352253033, 4740.6444516660695, 6932.757353492603, 7002.0, 7086.114235720535, 7105.218425973138, 7174.928250717426, 6971.895421568681, 6991.7902462926195, 7030.050943122716, 7035.226125126232, 7070.964645176741, 5643.294588176478, 5698.00284950132, 5735.340435849847, 5804.21643078179, 5819.330776960704, 5534.667919924817, 5571.721413929368, 5597.524210442158, 5608.242887210337, 5636.408177141505, 6201.844953876189, 6291.307956124914, 6345.936540634534, 6366.076918846834, 6397.232332120176, 6388.968055159695, 6415.903761443488, 6460.612363258219, 6483.351664833667, 6498.772542960974, 5054.368203974504, 5106.897862042812, 5291.894162116813, 5453.318335208099, 5529.806456773994, 5908.881822363614, 5910.940890591039, 5911.113333000085, 5914.674692891932, 5930.673812940329, 5300.814471493633, 5561.388247292875, 5601.467860553241, 5614.915776263441, 5627.8593035174445, 5497.8075767347955, 5520.282363292747, 5555.638883472561, 5587.580931430078, 5639.041362968387, 5677.687727175045, 5693.829185124453, 5699.344575373885, 5702.6293290935955, 5724.74238659253, 5098.0, 5205.713685747321, 5233.790648374023, 5250.816221432385, 5294.655847369909, 5270.49930256625, 5332.200169974535, 5336.599755018312, 5347.5721942243745, 5382.784688612568], "unit": "ms", "name": "mootools.html", "value": 3456.057270444702}, {"lowerIsBetter": false, "replicates": [270.27700900092253, 271.8898845967383, 273.24447901552213, 275.7848877875257, 282.41986087838563, 5443.727813609314, 5553.888922221553, 5576.888462230753, 5623.550115990721, 5666.291713535813, 5395.379531353896, 5583.804566840161, 5593.328800543941, 5601.103823388259, 5610.326760788701, 4212.852550160745, 4215.789210539476, 4217.21981433435, 4268.658507319423, 4286.957130428703, 4005.0588111793704, 4155.127423241123, 4163.125743593849, 4195.6573896353175, 4233.491980962273, 3871.0, 4007.4790277263915, 4116.855910043149, 4121.670266378683, 4130.958690413087, 4019.4975628046495, 4143.482064741907, 4148.149629326011, 4148.315527937887, 4200.495940487131, 3571.2678900825267, 3579.28414317135, 3579.8568057277676, 3591.910202244939, 3618.7105031597407, 5338.145896656555, 5359.705216213107, 5364.034473794715, 5369.973150134224, 5400.945990540084, 4726.196546587088, 4728.999999999965, 4731.195696731564, 4739.0758802033615, 4759.690620109682, 5663.4336566343445, 5836.533077353802, 5846.123081537761, 5866.941330586725, 5879.176915231871, 3857.652811246973, 3857.6528112470014, 3862.3627101528214, 3864.188520410717, 3895.4156876468473, 5861.5603829712945, 5964.522838172979, 6025.78909738157, 6147.969260153715, 6163.476104531121, 3821.178446633987, 3884.1649045454797, 3905.082305658168, 3915.980420097881, 3916.8433262669746, 3928.4500169976227, 3982.542007669097, 3993.0416699991792, 3993.121513267077, 3995.9400608990886, 4673.275642275453, 4684.992726563805, 4686.203345431217, 4687.859364219079, 4697.0840686065885, 5663.830085097454, 5838.766449341979, 5847.298324201123, 5851.034579294454, 5864.0, 1373.8557451467452, 1378.0835744230176, 1381.2610253514322, 1383.2392184298596, 1383.9584812455641, 863.5207459859838, 877.2148926710558, 884.1423818895661, 892.8794612727198, 895.2837729816121, 5643.153526970905, 5643.294588176478, 5653.123765816305, 5657.405972372924, 5670.404607516234, 6097.359777223416, 6097.664628445389, 6099.75600975956, 6100.0, 6173.228346456693, 5644.5484361251, 5644.8306550803545, 5645.350784659735, 5696.231008813757, 5741.569382296345, 3181.2046988252937, 3261.2173078460996, 3288.3752087103376, 3311.1887587541205, 3318.1041118898247, 6247.968760156261, 6286.8428289292215, 6296.590721603081, 6315.147455093504, 6343.016832390987, 6213.943629582982, 6217.813465596039, 6220.03589443637, 6251.437370636664, 6277.2781130170615, 6004.639721616717, 6236.968815155895, 6243.250809902659, 6306.2747784004505, 6317.6209427434505, 5995.850103747442, 6068.6358818471035, 6125.571210015256, 6130.693465326805, 6144.354842741448, 5868.882622347614, 5927.585069045125, 5930.851728706817, 5938.8218353449465, 5975.880482390415, 5823.4176582343125, 5952.410701344928, 6230.7819226326865, 6240.28236752761, 6307.274663413767, 3835.5972622874197, 4010.7994600269285, 4021.8994525137105, 4025.718199726108, 4063.4108054332546, 6155.4767844731905, 6182.072689096672, 6186.907196392148, 6234.532410069172, 6242.469390101892, 5969.134475500941, 5980.0, 5982.7307771149535, 6024.668643224665, 6029.366916473882, 5720.08478643415, 5918.408159184047, 5954.0, 6008.729607167776, 6015.578909476295, 5816.243888294494, 5829.3004839417845, 5866.6186697864505, 5872.530197584098, 5892.587518873637, 5926.2295901532525, 5944.167816505606, 5990.64056156632, 5992.221011268507, 6016.0, 5636.830895073154, 5799.420057994167, 5828.562857785768, 5833.241678581757, 5858.47273745365], "unit": "ms", "name": "prototype.html", "value": 4352.2278554167615}, {"lowerIsBetter": false, "replicates": [607.7052629474701, 629.1632129268074, 644.1336402538587, 649.3993056422809, 665.5973136252566, 12066.75866482671, 12275.570355037575, 12298.63104106876, 12300.630981070572, 12347.691307717312, 11204.103671706263, 11465.885341146586, 11772.882271177286, 11781.823272650918, 11802.291862488257, 622.1290193728793, 625.8779537990093, 631.2897989761518, 789.715702347156, 810.0481933727875, 619.8264485943943, 626.6741294526844, 784.568487331968, 793.6626933553217, 801.9238172373615, 817.207308910356, 824.826786374862, 830.8587540118165, 831.1688311688312, 831.5177197225624, 649.1074772188241, 652.9347065293433, 817.2767101115526, 825.2407784837964, 825.7151282807451, 485.245443335613, 486.95617394434316, 490.66389523176383, 602.4066294699717, 614.7663887722637, 12100.455479503444, 12274.263544187377, 12290.0, 12303.138780285384, 12459.750804983849, 10068.29521933465, 10175.694729158064, 10264.74338141545, 10619.522121504473, 10811.729706757314, 7749.690012399497, 8245.79385515367, 8311.501309921425, 8342.749717508425, 8346.791330216793, 2909.621749172615, 2933.6039634649264, 2978.8361640109783, 2987.118799954019, 3093.5978322818114, 43670.56329436697, 45135.77432112851, 45433.77283113563, 45521.0, 45963.770181149215, 7952.3638108951145, 8012.4791888528225, 8058.1538938411795, 8100.71647492335, 8132.308753755997, 17034.48896533106, 17055.658886822195, 17229.39697110595, 17242.913785430992, 17272.22274997603, 5746.712664366765, 5830.096335068071, 5960.225170727777, 5961.5826892118, 6034.879302413927, 3383.7293016558615, 3402.4726167444087, 3422.7775194612273, 3446.5174875517446, 3462.3594634992105, 2445.9266222013366, 2492.090387008765, 2513.208339373092, 2530.4053547416343, 2537.8984840606167, 353.60219752778124, 354.3992931980269, 357.8997880593438, 358.08330673475984, 360.3082082401795, 493.7333839726579, 497.66159011872276, 500.924861270805, 504.0102980493147, 532.9094054010827, 6540.411362977355, 7058.823529411703, 7143.9642801786695, 7147.099485428851, 7324.2309557496765, 500.91734863747075, 502.6707506583194, 510.2346480279581, 531.5515961395694, 547.6139321778137, 3311.7516186285643, 3394.59264888215, 3529.8941031769086, 3641.10792855752, 3674.3937250353392, 46455.535444645124, 51219.743901281, 51405.742971285654, 52070.73964630228, 52508.21237681438, 44177.77911110488, 45070.54929450729, 45194.54805451969, 45271.547284526736, 45751.542484575395, 40697.79651101726, 40983.385249220686, 41096.0, 41370.0, 41720.37419438711, 7492.363149132385, 7505.624718763931, 7524.774256772305, 7536.359409450258, 7556.886646700414, 30182.0, 30486.542701859933, 31237.0, 31237.219069523442, 31290.530642039932, 38971.415428769156, 40424.0, 41736.79131604444, 42458.0, 42466.0, 6772.796816095525, 6888.7244510221035, 6923.723051077901, 7035.155781306276, 7231.876948082484, 10045.196384289093, 10068.597256109673, 10277.177825773771, 10318.0, 10872.945635271773, 9315.441073535609, 9727.464989425367, 9833.262505312274, 9885.901140988786, 10038.397696138256, 9383.296252780932, 9395.248380129437, 9402.670906518239, 9503.097205765718, 9959.850602241117, 9656.565454554702, 9696.75758106053, 9755.56099975517, 9837.213022958003, 9969.40183588987, 8008.359331253369, 8012.067386196064, 8195.385346098947, 8268.958655206685, 8940.761510338767, 7502.812429689301, 7731.536107833548, 8313.459625124347, 8460.54026210728, 8620.353473489387], "unit": "ms", "name": "yui.html", "value": 5325.267242716103}], "name": "dromaeo_css", "value": 5827.915498617856}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 123.0, 117.0, 124.0, 128.0, 129.0, 110.0, 123.0, 124.0, 121.0], "unit": "ms", "name": "ai-astar", "value": 121.7}, {"lowerIsBetter": true, "replicates": [177.0, 152.0, 175.0, 181.0, 149.0, 173.0, 165.0, 138.0, 190.0, 148.0], "unit": "ms", "name": "audio-beat-detection", "value": 164.8}, {"lowerIsBetter": true, "replicates": [179.0, 180.0, 181.0, 190.0, 182.0, 182.0, 179.0, 179.0, 180.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 181.4}, {"lowerIsBetter": true, "replicates": [78.0, 93.0, 99.0, 97.0, 79.0, 79.0, 79.0, 87.0, 91.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 85.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 152.0, 104.0, 106.0, 101.0, 145.0, 100.0, 101.0, 150.0], "unit": "ms", "name": "audio-oscillator", "value": 117.7}, {"lowerIsBetter": true, "replicates": [135.0, 142.0, 129.0, 135.0, 135.0, 136.0, 135.0, 135.0, 136.0, 129.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 134.7}, {"lowerIsBetter": true, "replicates": [142.0, 148.0, 143.0, 142.0, 141.0, 141.0, 148.0, 143.0, 142.0, 141.0], "unit": "ms", "name": "imaging-darkroom", "value": 143.1}, {"lowerIsBetter": true, "replicates": [114.0, 109.0, 109.0, 107.0, 106.0, 114.0, 108.0, 109.0, 108.0, 113.0], "unit": "ms", "name": "imaging-desaturate", "value": 109.7}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 69.0, 69.0, 69.0, 71.0, 73.0, 82.0, 71.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.8}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 77.0, 78.0, 78.0, 78.0, 82.0, 80.0, 78.0, 77.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 77.6}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 101.0, 101.0, 99.0, 95.0, 96.0, 98.0, 97.0, 101.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 98.2}, {"lowerIsBetter": true, "replicates": [144.0, 157.0, 144.0, 144.0, 147.0, 153.0, 144.0, 146.0, 142.0, 145.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 146.6}, {"lowerIsBetter": true, "replicates": [159.0, 171.0, 171.0, 176.0, 177.0, 166.0, 174.0, 171.0, 170.0, 178.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 171.3}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 79.0, 80.0, 78.0, 82.0, 84.0, 84.0, 79.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 80.1}], "name": "kraken", "value": 1703.3999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [188.040616773223], "unit": "score", "name": "Richards", "value": 187.73603599999993}, {"lowerIsBetter": false, "replicates": [219.39447125932426], "unit": "score", "name": "DeltaBlue", "value": 301.365844}, {"lowerIsBetter": false, "replicates": [360.1008282319049], "unit": "score", "name": "Encrypt", "value": 739.1846370000003}, {"lowerIsBetter": false, "replicates": [6711.4093959731545], "unit": "score", "name": "Decrypt", "value": 39.66096900000002}, {"lowerIsBetter": false, "replicates": [2219.512195121951], "unit": "score", "name": "RayTrace", "value": 333.40163736263736}, {"lowerIsBetter": false, "replicates": [1033.0237358101135], "unit": "score", "name": "Earley", "value": 645.1574895104897}, {"lowerIsBetter": false, "replicates": [14720.588235294117], "unit": "score", "name": "Boyer", "value": 45.27420979020977}, {"lowerIsBetter": false, "replicates": [33491.80327868852], "unit": "score", "name": "RegExp", "value": 27.20023739598632}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Splay", "value": 103.33058799999999}, {"lowerIsBetter": false, "replicates": [6407.643312101911], "unit": "score", "name": "NavierStokes", "value": 231.5984095427434}], "name": "v8_7", "value": 16006.909926224589}]} 09:15:40 INFO - RETURN: dromaeo_css: 5827.92 09:15:40 INFO - RETURN: kraken: 1703.40 09:15:40 INFO - RETURN: v8_7: 16006.91 09:15:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "16006.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1703.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5827.92"}}} 09:15:40 INFO - Return code: 0 09:15:40 INFO - # TBPL SUCCESS # 09:15:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:15:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:15:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:15:40 INFO - 2015-11-18 09:15:40.350 screenresolution[1654:9948] starting screenresolution argv=screenresolution get 09:15:40 INFO - 2015-11-18 09:15:40.353 screenresolution[1654:9948] Display 0: 1600x1200x32@60 09:15:40 INFO - 2015-11-18 09:15:40.359 screenresolution[1655:9951] starting screenresolution argv=screenresolution list 09:15:40 INFO - Available Modes on Display 0 09:15:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:15:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:15:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:15:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:15:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:15:40 INFO - Intel HD Graphics 3000: 09:15:40 INFO - Chipset Model: Intel HD Graphics 3000 09:15:40 INFO - Type: GPU 09:15:40 INFO - Bus: Built-In 09:15:40 INFO - VRAM (Total): 512 MB 09:15:40 INFO - VRAM (Dynamic, Max): 10 09:15:40 INFO - Vendor: Intel (0x8086) 09:15:40 INFO - Device ID: 0x0116 09:15:40 INFO - Revision ID: 0x0009 09:15:40 INFO - Displays: 09:15:40 INFO - Display: 09:15:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:15:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:15:40 INFO - Display Serial Number: 1600x1200 60 09:15:40 INFO - Main Display: Yes 09:15:40 INFO - Mirror: Off 09:15:40 INFO - Online: Yes 09:15:40 INFO - Rotation: Supported 09:15:40 INFO - Return code: 0 09:15:40 INFO - Running post-action listener: _resource_record_post_action 09:15:40 INFO - Running post-run listener: _resource_record_post_run 09:15:41 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 40825856; Write bytes: 684877824; Read time: 5111; Write time: 49249 09:15:41 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 341500416; Write bytes: 336023552; Read time: 35409; Write time: 3601 09:15:41 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 38867968; Write bytes: 338606080; Read time: 4558; Write time: 44894 09:15:41 INFO - Running post-run listener: _upload_blobber_files 09:15:41 INFO - Blob upload gear active. 09:15:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:15:41 INFO - Copying logs to upload dir... 09:15:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1320.157409 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-18 09:15:41.777883) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:15:41.781277) ========= 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.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010154 build_url: 'https://queue.taskcluster.net/v1/task/uI2u8GEYSAGab1ft5L2NfQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.72 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:15:42.514305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:15:42.514723) ========= 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.yIuuqoV6QT/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.fFEciGDf1f/Listeners TMPDIR=/var/folders/20/g1_dkr6d7hg8mjcyrg_mh11m00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005190 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:15:42.544706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 09:15:42.545053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 09:15:42.545473) ========= ========= Total master_lag: 1.45 =========