builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0046 starttime: 1447860799.79 results: success (0) buildid: 20151118055225 builduid: 37d3acdba6c4433b845d2e92124a4771 revision: 7b0d3fa99e655643a36575b8714e5c7420d29588 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:19.788769) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:19.789245) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:19.789555) ========= 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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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.006159 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.104090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.104419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.123053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.123441) ========= 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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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.013422 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.181893) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.182164) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.182530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.182809) ========= 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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:33:20-- 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, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-18 07:33:20 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.333494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.539556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.539876) ========= 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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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.103609 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.666652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.666994) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7b0d3fa99e655643a36575b8714e5c7420d29588 --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 7b0d3fa99e655643a36575b8714e5c7420d29588 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:33:20,753 truncating revision to first 12 chars 2015-11-18 07:33:20,753 Setting DEBUG logging. 2015-11-18 07:33:20,753 attempt 1/10 2015-11-18 07:33:20,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7b0d3fa99e65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 07:33:21,006 unpacking tar archive at: mozilla-inbound-7b0d3fa99e65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513416 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.196403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.196747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.216967) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.217348) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.217787) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-18 07:33:21.218136) ========= /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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:33:21 INFO - MultiFileLogger online at 20151118 07:33:21 in /builds/slave/test 07:33:21 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 07:33:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:21 INFO - {'append_to_log': False, 07:33:21 INFO - 'base_work_dir': '/builds/slave/test', 07:33:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:33:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:21 INFO - 'branch': 'Mozilla-Inbound', 07:33:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:21 INFO - 'config_files': ('talos/mac_config.py',), 07:33:21 INFO - 'default_actions': ('clobber', 07:33:21 INFO - 'read-buildbot-config', 07:33:21 INFO - 'download-and-extract', 07:33:21 INFO - 'populate-webroot', 07:33:21 INFO - 'create-virtualenv', 07:33:21 INFO - 'install', 07:33:21 INFO - 'run-tests'), 07:33:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:21 INFO - 'download_minidump_stackwalk': True, 07:33:21 INFO - 'download_symbols': 'ondemand', 07:33:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:21 INFO - 'installer_path': 'installer.exe', 07:33:21 INFO - 'log_level': 'info', 07:33:21 INFO - 'log_name': 'talos', 07:33:21 INFO - 'log_to_console': True, 07:33:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:33:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:33:21 INFO - 'opt_config_files': (), 07:33:21 INFO - 'pip_index': False, 07:33:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:21 INFO - 'cmd': ('bash', 07:33:21 INFO - '-c', 07:33:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:21 INFO - 'enabled': True, 07:33:21 INFO - 'halt_on_failure': False, 07:33:21 INFO - 'name': 'check_screen_resolution'},), 07:33:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:21 INFO - 'cmd': ('bash', 07:33:21 INFO - '-c', 07:33:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:21 INFO - 'enabled': True, 07:33:21 INFO - 'halt_on_failure': False, 07:33:21 INFO - 'name': 'check_screen_resolution'},), 07:33:21 INFO - 'run_cmd_checks_enabled': True, 07:33:21 INFO - 'sps_profile': False, 07:33:21 INFO - 'sps_profile_interval': 0, 07:33:21 INFO - 'suite': 'dromaeojs', 07:33:21 INFO - 'system_bits': '64', 07:33:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:21 INFO - 'title': 't-yosemite-r5-0046', 07:33:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:21 INFO - 'use_talos_json': True, 07:33:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:21 INFO - 'work_dir': 'build'} 07:33:21 INFO - ##### 07:33:21 INFO - ##### Running clobber step. 07:33:21 INFO - ##### 07:33:21 INFO - Running pre-action listener: _resource_record_pre_action 07:33:21 INFO - Running main action method: clobber 07:33:21 INFO - rmtree: /builds/slave/test/build 07:33:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:25 INFO - Running post-action listener: _resource_record_post_action 07:33:25 INFO - ##### 07:33:25 INFO - ##### Running read-buildbot-config step. 07:33:25 INFO - ##### 07:33:25 INFO - Running pre-action listener: _resource_record_pre_action 07:33:25 INFO - Running main action method: read_buildbot_config 07:33:25 INFO - Using buildbot properties: 07:33:25 INFO - { 07:33:25 INFO - "properties": { 07:33:25 INFO - "buildnumber": 3174, 07:33:25 INFO - "product": "firefox", 07:33:25 INFO - "script_repo_revision": "production", 07:33:25 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 07:33:25 INFO - "repository": "", 07:33:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 07:33:25 INFO - "buildid": "20151118055225", 07:33:25 INFO - "slavename": "t-yosemite-r5-0046", 07:33:25 INFO - "pgo_build": "False", 07:33:25 INFO - "basedir": "/builds/slave/test", 07:33:25 INFO - "project": "", 07:33:25 INFO - "platform": "yosemite", 07:33:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:33:25 INFO - "slavebuilddir": "test", 07:33:25 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 07:33:25 INFO - "branch": "mozilla-inbound", 07:33:25 INFO - "repo_path": "integration/mozilla-inbound", 07:33:25 INFO - "stage_platform": "macosx64", 07:33:25 INFO - "builduid": "37d3acdba6c4433b845d2e92124a4771", 07:33:25 INFO - "revision": "7b0d3fa99e655643a36575b8714e5c7420d29588" 07:33:25 INFO - }, 07:33:25 INFO - "sourcestamp": { 07:33:25 INFO - "repository": "", 07:33:25 INFO - "hasPatch": false, 07:33:25 INFO - "project": "", 07:33:25 INFO - "branch": "mozilla-inbound-macosx64-talos", 07:33:25 INFO - "changes": [ 07:33:25 INFO - { 07:33:25 INFO - "category": null, 07:33:25 INFO - "files": [ 07:33:25 INFO - { 07:33:25 INFO - "url": null, 07:33:25 INFO - "name": "https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:33:25 INFO - } 07:33:25 INFO - ], 07:33:25 INFO - "repository": "", 07:33:25 INFO - "rev": "7b0d3fa99e655643a36575b8714e5c7420d29588", 07:33:25 INFO - "who": "cbook@mozilla.com", 07:33:25 INFO - "when": 1447860721, 07:33:25 INFO - "number": 6677298, 07:33:25 INFO - "comments": "Merge mozilla-central to mozilla-inbound", 07:33:25 INFO - "project": "", 07:33:25 INFO - "at": "Wed 18 Nov 2015 07:32:01", 07:33:25 INFO - "branch": "mozilla-inbound-macosx64-talos", 07:33:25 INFO - "revlink": "", 07:33:25 INFO - "properties": [ 07:33:25 INFO - [ 07:33:25 INFO - "buildid", 07:33:25 INFO - "20151118055225", 07:33:25 INFO - "Change" 07:33:25 INFO - ], 07:33:25 INFO - [ 07:33:25 INFO - "builduid", 07:33:25 INFO - "37d3acdba6c4433b845d2e92124a4771", 07:33:25 INFO - "Change" 07:33:25 INFO - ], 07:33:25 INFO - [ 07:33:25 INFO - "pgo_build", 07:33:25 INFO - "False", 07:33:25 INFO - "Change" 07:33:25 INFO - ] 07:33:25 INFO - ], 07:33:25 INFO - "revision": "7b0d3fa99e655643a36575b8714e5c7420d29588" 07:33:25 INFO - } 07:33:25 INFO - ], 07:33:25 INFO - "revision": "7b0d3fa99e655643a36575b8714e5c7420d29588" 07:33:25 INFO - } 07:33:25 INFO - } 07:33:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:33:25 INFO - Running post-action listener: _resource_record_post_action 07:33:25 INFO - ##### 07:33:25 INFO - ##### Running download-and-extract step. 07:33:25 INFO - ##### 07:33:25 INFO - Running pre-action listener: _resource_record_pre_action 07:33:25 INFO - Running main action method: download_and_extract 07:33:25 INFO - mkdir: /builds/slave/test/build/tests 07:33: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')]} 07:33:25 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:33:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json 07:33:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json 07:33:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:33:38 INFO - Downloaded 1149 bytes. 07:33:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:33:38 INFO - Using the following test package requirements: 07:33:38 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:33:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:38 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:33:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:38 INFO - u'jsshell-mac.zip'], 07:33:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:38 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:33:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:33:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:38 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:33:38 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:38 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:33:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:38 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:33:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:33:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:38 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:33:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:38 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:33:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:50 INFO - Downloaded 17463805 bytes. 07:33: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 07:33:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:33:54 INFO - Return code: 0 07:33:54 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 07:33:54 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')]} 07:33:54 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:33:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:55 INFO - Downloaded 17463805 bytes. 07:33:55 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 07:33:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:34:01 INFO - Return code: 0 07:34:01 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')]} 07:34:01 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:34:02 INFO - Downloaded 11130997 bytes. 07:34:02 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 07:34:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:34:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:34:02 INFO - Return code: 0 07:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:02 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:34:05 INFO - Downloaded 108849351 bytes. 07:34:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:34:05 INFO - mkdir: /builds/slave/test/properties 07:34:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:05 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:05 INFO - Contents: 07:34:05 INFO - build_url:https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:34:05 INFO - Running post-action listener: _resource_record_post_action 07:34:05 INFO - Running post-action listener: set_extra_try_arguments 07:34:05 INFO - ##### 07:34:05 INFO - ##### Running populate-webroot step. 07:34:05 INFO - ##### 07:34:05 INFO - Running pre-action listener: _resource_record_pre_action 07:34:05 INFO - Running main action method: populate_webroot 07:34:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:34:05 INFO - '../fennec_ids.txt'], 07:34:05 INFO - 'tests': ['tcheck2']}, 07:34:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:05 INFO - '--tppagecycles', 07:34:05 INFO - '7'], 07:34:05 INFO - 'tests': ['tsvgm']}}, 07:34:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:34:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:34:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:34:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'tests': ['damp', 'tps']}, 07:34:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['damp', 'tps']}, 07:34:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:34:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:05 INFO - 'other': {'tests': ['a11yr', 07:34:05 INFO - 'ts_paint', 07:34:05 INFO - 'tpaint', 07:34:05 INFO - 'sessionrestore', 07:34:05 INFO - 'sessionrestore_no_auto_restore']}, 07:34:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['a11yr', 07:34:05 INFO - 'ts_paint', 07:34:05 INFO - 'tpaint', 07:34:05 INFO - 'sessionrestore', 07:34:05 INFO - 'sessionrestore_no_auto_restore']}, 07:34:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['a11yr', 07:34:05 INFO - 'ts_paint', 07:34:05 INFO - 'tpaint', 07:34:05 INFO - 'sessionrestore', 07:34:05 INFO - 'sessionrestore_no_auto_restore']}, 07:34:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['a11yr', 07:34:05 INFO - 'ts_paint', 07:34:05 INFO - 'tpaint', 07:34:05 INFO - 'sessionrestore', 07:34:05 INFO - 'sessionrestore_no_auto_restore']}, 07:34:05 INFO - 'other_l64': {'tests': ['a11yr', 07:34:05 INFO - 'ts_paint', 07:34:05 INFO - 'tpaint', 07:34:05 INFO - 'sessionrestore', 07:34:05 INFO - 'sessionrestore_no_auto_restore']}, 07:34:05 INFO - 'other_nol64': {'tests': ['a11yr', 07:34:05 INFO - 'ts_paint', 07:34:05 INFO - 'tpaint', 07:34:05 INFO - 'sessionrestore', 07:34:05 INFO - 'sessionrestore_no_auto_restore']}, 07:34:05 INFO - 'svgr': {'tests': ['tsvgx', 07:34:05 INFO - 'tsvgr_opacity', 07:34:05 INFO - 'tart', 07:34:05 INFO - 'tscrollx', 07:34:05 INFO - 'cart']}, 07:34:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['tsvgx', 07:34:05 INFO - 'tsvgr_opacity', 07:34:05 INFO - 'tart', 07:34:05 INFO - 'tscrollx', 07:34:05 INFO - 'cart']}, 07:34:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'tests': ['tp5o']}, 07:34:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'talos_options': ['--e10s'], 07:34:05 INFO - 'tests': ['tp5o']}, 07:34:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'talos_options': ['--xperf_path', 07:34:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:05 INFO - 'tests': ['tp5n']}, 07:34:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:05 INFO - 'talos_options': ['--e10s', 07:34:05 INFO - '--xperf_path', 07:34:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:05 INFO - 'tests': ['tp5n']}}, 07:34:05 INFO - 'talos.zip': {'path': '', 07:34:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:05 INFO - Running post-action listener: _resource_record_post_action 07:34:05 INFO - ##### 07:34:05 INFO - ##### Running create-virtualenv step. 07:34:05 INFO - ##### 07:34:05 INFO - Running pre-action listener: _resource_record_pre_action 07:34:05 INFO - Running main action method: create_virtualenv 07:34:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:05 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 07:34:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:05 INFO - Using real prefix '/tools/python27' 07:34:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:09 INFO - Installing pip.................done. 07:34:09 INFO - Return code: 0 07:34:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:09 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')]} 07:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:09 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')]} 07:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:09 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 0x1100f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd990614ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, '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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:34:09 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 07:34:09 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 07:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:09 INFO - 'HOME': '/Users/cltbld', 07:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:09 INFO - 'LOGNAME': 'cltbld', 07:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:09 INFO - 'MOZ_NO_REMOTE': '1', 07:34:09 INFO - 'NO_EM_RESTART': '1', 07:34:09 INFO - 'PAGER': '/bin/cat', 07:34:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:09 INFO - 'PWD': '/builds/slave/test', 07:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:09 INFO - 'SHELL': '/bin/bash', 07:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:34:09 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:09 INFO - 'USER': 'cltbld', 07:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:09 INFO - 'XPC_FLAGS': '0x0', 07:34:09 INFO - 'XPC_SERVICE_NAME': '0', 07:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:10 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 07:34:10 INFO - Cleaning up... 07:34:10 INFO - Return code: 0 07:34:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:10 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 0x1100f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd990614ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, '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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:34:10 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 07:34:10 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 07:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:10 INFO - 'HOME': '/Users/cltbld', 07:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:10 INFO - 'LOGNAME': 'cltbld', 07:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:10 INFO - 'MOZ_NO_REMOTE': '1', 07:34:10 INFO - 'NO_EM_RESTART': '1', 07:34:10 INFO - 'PAGER': '/bin/cat', 07:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:10 INFO - 'PWD': '/builds/slave/test', 07:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:10 INFO - 'SHELL': '/bin/bash', 07:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:34:10 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:10 INFO - 'USER': 'cltbld', 07:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:10 INFO - 'XPC_FLAGS': '0x0', 07:34:10 INFO - 'XPC_SERVICE_NAME': '0', 07:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:11 INFO - Downloading/unpacking psutil>=0.7.1 07:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:34:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:13 INFO - Installing collected packages: psutil 07:34:13 INFO - Running setup.py install for psutil 07:34:13 INFO - building 'psutil._psutil_osx' extension 07:34:13 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 07:34:15 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 07:34:15 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 07:34:15 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 07:34:16 INFO - building 'psutil._psutil_posix' extension 07:34:16 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 07:34:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:34:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:34:16 INFO - ^ 07:34:16 INFO - 1 warning generated. 07:34:16 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 07:34:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:16 INFO - Successfully installed psutil 07:34:16 INFO - Cleaning up... 07:34:16 INFO - Return code: 0 07:34:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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', '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 0x1100f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd990614ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, '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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:34: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:34: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 mozsystemmonitor==0.0.0 07:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:16 INFO - 'HOME': '/Users/cltbld', 07:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:16 INFO - 'LOGNAME': 'cltbld', 07:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:16 INFO - 'MOZ_NO_REMOTE': '1', 07:34:16 INFO - 'NO_EM_RESTART': '1', 07:34:16 INFO - 'PAGER': '/bin/cat', 07:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:16 INFO - 'PWD': '/builds/slave/test', 07:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:16 INFO - 'SHELL': '/bin/bash', 07:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:34:16 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:16 INFO - 'USER': 'cltbld', 07:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:16 INFO - 'XPC_FLAGS': '0x0', 07:34:16 INFO - 'XPC_SERVICE_NAME': '0', 07:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:34:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:34:19 INFO - Installing collected packages: mozsystemmonitor 07:34:19 INFO - Running setup.py install for mozsystemmonitor 07:34:19 INFO - Successfully installed mozsystemmonitor 07:34:19 INFO - Cleaning up... 07:34:19 INFO - Return code: 0 07:34:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1100f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd990614ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, '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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:34:19 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 07:34:19 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 07:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:19 INFO - 'HOME': '/Users/cltbld', 07:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:19 INFO - 'LOGNAME': 'cltbld', 07:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:19 INFO - 'MOZ_NO_REMOTE': '1', 07:34:19 INFO - 'NO_EM_RESTART': '1', 07:34:19 INFO - 'PAGER': '/bin/cat', 07:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:19 INFO - 'PWD': '/builds/slave/test', 07:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:19 INFO - 'SHELL': '/bin/bash', 07:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:34:19 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:19 INFO - 'USER': 'cltbld', 07:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:19 INFO - 'XPC_FLAGS': '0x0', 07:34:19 INFO - 'XPC_SERVICE_NAME': '0', 07:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:19 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:19 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 07:34:19 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 07:34:19 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 07:34:19 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 07:34:19 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 07:34:19 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 07:34:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:23 INFO - Downloading docopt-0.6.1.tar.gz 07:34:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:23 INFO - Running setup.py install for blobuploader 07:34:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:23 INFO - Running setup.py install for requests 07:34:24 INFO - Running setup.py install for docopt 07:34:24 INFO - Successfully installed blobuploader requests docopt 07:34:24 INFO - Cleaning up... 07:34:24 INFO - Return code: 0 07:34:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:24 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')]} 07:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:24 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')]} 07:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:24 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 0x1100f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd990614ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, '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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:34:24 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 07:34:24 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 07:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:24 INFO - 'HOME': '/Users/cltbld', 07:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:24 INFO - 'LOGNAME': 'cltbld', 07:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:24 INFO - 'MOZ_NO_REMOTE': '1', 07:34:24 INFO - 'NO_EM_RESTART': '1', 07:34:24 INFO - 'PAGER': '/bin/cat', 07:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:24 INFO - 'PWD': '/builds/slave/test', 07:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:24 INFO - 'SHELL': '/bin/bash', 07:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:34:24 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:24 INFO - 'USER': 'cltbld', 07:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:24 INFO - 'XPC_FLAGS': '0x0', 07:34:24 INFO - 'XPC_SERVICE_NAME': '0', 07:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:24 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-Lfntol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:24 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-CHFCe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-6EDEvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-fZsfW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-TeLMtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-uPngPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-iQ8TeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-5lZwHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-XM4CV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:25 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-lOxGmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:26 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-NxtyyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:26 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-5OK0oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:26 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-Nk4crE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:26 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-sd0taD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:26 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-mAD2NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:26 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-aRMyxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:26 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-bksGXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:26 INFO - Running setup.py install for manifestparser 07:34:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Running setup.py install for mozcrash 07:34:27 INFO - Running setup.py install for mozdebug 07:34:27 INFO - Running setup.py install for mozdevice 07:34:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Running setup.py install for mozfile 07:34:27 INFO - Running setup.py install for mozhttpd 07:34:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Running setup.py install for mozinfo 07:34:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Running setup.py install for mozInstall 07:34:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Running setup.py install for mozleak 07:34:28 INFO - Running setup.py install for mozlog 07:34:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Running setup.py install for moznetwork 07:34:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Running setup.py install for mozprocess 07:34:28 INFO - Running setup.py install for mozprofile 07:34:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozrunner 07:34:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozscreenshot 07:34:29 INFO - Running setup.py install for moztest 07:34:29 INFO - Running setup.py install for mozversion 07:34:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:29 INFO - Cleaning up... 07:34:29 INFO - Return code: 0 07:34:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:29 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')]} 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 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')]} 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 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 0x1100f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd990614ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, '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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:34:29 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 07:34:29 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 07:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:29 INFO - 'HOME': '/Users/cltbld', 07:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:29 INFO - 'LOGNAME': 'cltbld', 07:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:29 INFO - 'MOZ_NO_REMOTE': '1', 07:34:29 INFO - 'NO_EM_RESTART': '1', 07:34:29 INFO - 'PAGER': '/bin/cat', 07:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:29 INFO - 'PWD': '/builds/slave/test', 07:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:29 INFO - 'SHELL': '/bin/bash', 07:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:34:29 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:29 INFO - 'USER': 'cltbld', 07:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:29 INFO - 'XPC_FLAGS': '0x0', 07:34:29 INFO - 'XPC_SERVICE_NAME': '0', 07:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:30 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-DE4nzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:30 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-qjoJus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:30 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-1d_cI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:30 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-IZpvlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:30 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-U8sEOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:30 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-ksiu8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-wOqFzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-nkePM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-FdSDEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-oG8WMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-GlBDA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-DVc96m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-wO_9LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:31 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-RWTIGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:32 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-E__qTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:32 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-qtbl3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:32 INFO - Running setup.py (path:/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/pip-OmkfPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:34 INFO - Downloading blessings-1.5.1.tar.gz 07:34:34 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 07:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:35 INFO - Installing collected packages: blessings 07:34:35 INFO - Running setup.py install for blessings 07:34:35 INFO - Successfully installed blessings 07:34:35 INFO - Cleaning up... 07:34:35 INFO - Return code: 0 07:34:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:35 INFO - Reading from file tmpfile_stdout 07:34:35 INFO - Current package versions: 07:34:35 INFO - blessings == 1.5.1 07:34:35 INFO - blobuploader == 1.2.4 07:34:35 INFO - docopt == 0.6.1 07:34:35 INFO - manifestparser == 1.1 07:34:35 INFO - mozInstall == 1.12 07:34:35 INFO - mozcrash == 0.16 07:34:35 INFO - mozdebug == 0.1 07:34:35 INFO - mozdevice == 0.47 07:34:35 INFO - mozfile == 1.2 07:34:35 INFO - mozhttpd == 0.7 07:34:35 INFO - mozinfo == 0.9 07:34:35 INFO - mozleak == 0.1 07:34:35 INFO - mozlog == 3.0 07:34:35 INFO - moznetwork == 0.27 07:34:35 INFO - mozprocess == 0.22 07:34:35 INFO - mozprofile == 0.27 07:34:35 INFO - mozrunner == 6.11 07:34:35 INFO - mozscreenshot == 0.1 07:34:35 INFO - mozsystemmonitor == 0.0 07:34:35 INFO - moztest == 0.7 07:34:35 INFO - mozversion == 1.4 07:34:35 INFO - psutil == 3.1.1 07:34:35 INFO - requests == 1.2.3 07:34:35 INFO - wsgiref == 0.1.2 07:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:35 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')]} 07:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:35 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')]} 07:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:35 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 0x1100f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd990614ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, '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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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 07:34:35 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 07:34:35 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 07:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:35 INFO - 'HOME': '/Users/cltbld', 07:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:35 INFO - 'LOGNAME': 'cltbld', 07:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:35 INFO - 'MOZ_NO_REMOTE': '1', 07:34:35 INFO - 'NO_EM_RESTART': '1', 07:34:35 INFO - 'PAGER': '/bin/cat', 07:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:35 INFO - 'PWD': '/builds/slave/test', 07:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:35 INFO - 'SHELL': '/bin/bash', 07:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:34:35 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:35 INFO - 'USER': 'cltbld', 07:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:35 INFO - 'XPC_FLAGS': '0x0', 07:34:35 INFO - 'XPC_SERVICE_NAME': '0', 07:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 INFO - Cleaning up... 07:34:35 INFO - Return code: 0 07:34:35 INFO - Running post-action listener: _resource_record_post_action 07:34:35 INFO - Running post-action listener: _start_resource_monitoring 07:34:35 INFO - Starting resource monitoring. 07:34:35 INFO - ##### 07:34:35 INFO - ##### Running install step. 07:34:35 INFO - ##### 07:34:35 INFO - Running pre-action listener: _resource_record_pre_action 07:34:35 INFO - Running main action method: install 07:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:36 INFO - Reading from file tmpfile_stdout 07:34:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:36 INFO - Reading from file tmpfile_stdout 07:34:36 INFO - Output received: 07:34:36 INFO - Usage: mozinstall [options] installer 07:34:36 INFO - Options: 07:34:36 INFO - -h, --help show this help message and exit 07:34:36 INFO - -d DEST, --destination=DEST 07:34:36 INFO - Directory to install application into. [default: 07:34:36 INFO - "/builds/slave/test"] 07:34:36 INFO - --app=APP Application being installed. [default: firefox] 07:34:36 INFO - mkdir: /builds/slave/test/build/application 07:34:36 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'] 07:34:36 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 07:35:14 INFO - Reading from file tmpfile_stdout 07:35:14 INFO - Output received: 07:35:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:35:14 INFO - Running post-action listener: _resource_record_post_action 07:35:14 INFO - ##### 07:35:14 INFO - ##### Running run-tests step. 07:35:14 INFO - ##### 07:35:14 INFO - Running pre-action listener: _resource_record_pre_action 07:35:14 INFO - Running main action method: run_tests 07:35:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:14 INFO - 2015-11-18 07:35:14.169 screenresolution[1627:7743] starting screenresolution argv=screenresolution get 07:35:14 INFO - 2015-11-18 07:35:14.173 screenresolution[1627:7743] Display 0: 1600x1200x32@60 07:35:14 INFO - 2015-11-18 07:35:14.179 screenresolution[1628:7745] starting screenresolution argv=screenresolution list 07:35:14 INFO - Available Modes on Display 0 07:35:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:14 INFO - Intel HD Graphics 3000: 07:35:14 INFO - Chipset Model: Intel HD Graphics 3000 07:35:14 INFO - Type: GPU 07:35:14 INFO - Bus: Built-In 07:35:14 INFO - VRAM (Total): 512 MB 07:35:14 INFO - VRAM (Dynamic, Max): 10 07:35:14 INFO - Vendor: Intel (0x8086) 07:35:14 INFO - Device ID: 0x0116 07:35:14 INFO - Revision ID: 0x0009 07:35:14 INFO - Displays: 07:35:14 INFO - Display: 07:35:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:14 INFO - Display Serial Number: 1600x1200 60 07:35:14 INFO - Main Display: Yes 07:35:14 INFO - Mirror: Off 07:35:14 INFO - Online: Yes 07:35:14 INFO - Rotation: Supported 07:35:14 INFO - Return code: 0 07:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:14 INFO - Python 2.7.3 07:35:14 INFO - Return code: 0 07:35:14 INFO - grabbing minidump binary from tooltool 07:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:14 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 0x1100189f0>, '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 0x10fd77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11000b8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:14 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 07:35:14 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 07:35:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:14 INFO - Return code: 0 07:35:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:35:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:35:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:14 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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0046', '--webServer', 'localhost'] in /builds/slave/test/build 07:35:14 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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0046 --webServer localhost 07:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RKBFV9i6KP/Render', 07:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:14 INFO - 'HOME': '/Users/cltbld', 07:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:14 INFO - 'LOGNAME': 'cltbld', 07:35:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:14 INFO - 'MOZ_NO_REMOTE': '1', 07:35:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:14 INFO - 'NO_EM_RESTART': '1', 07:35:14 INFO - 'PAGER': '/bin/cat', 07:35:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:14 INFO - 'PWD': '/builds/slave/test', 07:35:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:14 INFO - 'SHELL': '/bin/bash', 07:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQcPDgvvg/Listeners', 07:35:14 INFO - 'TMPDIR': '/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/', 07:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:14 INFO - 'USER': 'cltbld', 07:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:14 INFO - 'XPC_FLAGS': '0x0', 07:35:14 INFO - 'XPC_SERVICE_NAME': '0', 07:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:35:14 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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0046', '--webServer', 'localhost'] with output_timeout 3600 07:35:14 INFO - mozversion INFO | application_buildid: 20151118055225 07:35:14 INFO - mozversion INFO | application_changeset: 7b0d3fa99e655643a36575b8714e5c7420d29588 07:35:14 INFO - mozversion INFO | application_display_name: Nightly 07:35:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:14 INFO - mozversion INFO | application_name: Firefox 07:35:14 INFO - mozversion INFO | application_remotingname: firefox 07:35:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:35:14 INFO - mozversion INFO | application_vendor: Mozilla 07:35:14 INFO - mozversion INFO | application_version: 45.0a1 07:35:14 INFO - mozversion INFO | platform_buildid: 20151118055225 07:35:14 INFO - mozversion INFO | platform_changeset: 7b0d3fa99e655643a36575b8714e5c7420d29588 07:35:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:35:14 INFO - mozversion INFO | platform_version: 45.0a1 07:35:14 INFO - 2015-11-18 07:35:14,846 DEBUG : using testdate: 1447860914 07:35:14 INFO - 2015-11-18 07:35:14,846 DEBUG : actual date: 1447860914 07:35:14 INFO - 2015-11-18 07:35:14,928 INFO : starting webserver on 'localhost:49253' 07:35:14 INFO - 2015-11-18 07:35:14,929 INFO : Starting test suite t-yosemite-r5-0046 07:35:14 INFO - 2015-11-18 07:35:14,929 INFO : Starting test dromaeo_css 07:35:14 INFO - 2015-11-18 07:35:14,929 DEBUG : operating with platform_type : mac_ 07:35:14 INFO - 2015-11-18 07:35:14,930 INFO : Initialising browser for dromaeo_css test... 07:35:14 INFO - 2015-11-18 07:35:14,956 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/tmp4du7__/profile http://localhost:49253/getInfo.html 07:35:18 INFO - 2015-11-18 07:35:18,288 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:35:18 INFO - 2015-11-18 07:35:18,288 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:35:18 INFO - 2015-11-18 07:35:18,288 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:35:18 INFO - 2015-11-18 07:35:18,288 DEBUG : BROWSER_OUTPUT: __metrics 07:35:18 INFO - 2015-11-18 07:35:18,304 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:19 INFO - 2015-11-18 07:35:19,043 INFO : Browser initialized. 07:35:19 INFO - 2015-11-18 07:35:19,044 INFO : Running cycle 1/1 for dromaeo_css test... 07:35:19 INFO - 2015-11-18 07:35:19,044 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/tmp4du7__/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:35:31 INFO - 2015-11-18 07:35:31,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 229953536 07:35:31 INFO - 2015-11-18 07:35:31,039 DEBUG : BROWSER_OUTPUT: 07:36:22 INFO - 2015-11-18 07:36:22,206 DEBUG : BROWSER_OUTPUT: 1447860982203 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] 07:38:32 INFO - 2015-11-18 07:38:32,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49253/tests/dromaeo/cssquery-ext.html) 07:38:34 INFO - 2015-11-18 07:38:34,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 463085568 07:38:34 INFO - 2015-11-18 07:38:34,317 DEBUG : BROWSER_OUTPUT: 07:41:37 INFO - 2015-11-18 07:41:37,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-ext.html (next: http://localhost:49253/tests/dromaeo/cssquery-jquery.html) 07:41:37 INFO - 2015-11-18 07:41:37,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 374280192 07:41:37 INFO - 2015-11-18 07:41:37,727 DEBUG : BROWSER_OUTPUT: 07:44:40 INFO - 2015-11-18 07:44:40,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49253/tests/dromaeo/cssquery-mootools.html) 07:44:40 INFO - 2015-11-18 07:44:40,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 358645760 07:44:40 INFO - 2015-11-18 07:44:40,573 DEBUG : BROWSER_OUTPUT: 07:47:42 INFO - 2015-11-18 07:47:42,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49253/tests/dromaeo/cssquery-prototype.html) 07:47:43 INFO - 2015-11-18 07:47:43,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 337891328 07:47:43 INFO - 2015-11-18 07:47:43,192 DEBUG : BROWSER_OUTPUT: 07:50:46 INFO - 2015-11-18 07:50:46,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49253/tests/dromaeo/cssquery-yui.html) 07:50:47 INFO - 2015-11-18 07:50:47,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 336592896 07:50:47 INFO - 2015-11-18 07:50:47,019 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-yui.html (next: http://localhost:49253/tests/dromaeo/cssquery-dojo.html) 07:53:50 INFO - 2015-11-18 07:53:50,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 375529472 07:53:50 INFO - 2015-11-18 07:53:50,287 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,287 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:53:50 INFO - 2015-11-18 07:53:50,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:53:50 INFO - 2015-11-18 07:53:50,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:53:50 INFO - 2015-11-18 07:53:50,287 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:53:50 INFO - 2015-11-18 07:53:50,288 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3079.122450101721;3185.936281274373;3211.646718860925;3230.6607806180336;3240.465323221669;5174.586033117351;5263.921041184385;5313.495217954293;5406.648567843093;5479.095949168387;5306.867328316794;5312.442193569677;5317.096093664077;5349.090654588719;5356.785728570862;4887.437944636359;4893.094777466163;4951.158303088475;4961.08219979305;4963.528464795857;4927.1870141426625;5021.723805190713;5059.544640982311;5073.315102461157;5100.719460429675;5002.399712034543;5022.146235140017;5047.722375269359;5050.368703912011;5063.898722025558;533.2280778840675;4672.929906051412;4890.902181956341;4946.851594452136;4985.750712464399;4843.9515604843855;4930.728809915453;4932.827351042696;4939.851804445872;4965.801367945278;5170.302009228743;5170.948290517084;5172.508611681922;5213.895722085575;5272.815451459181;5380.381256155514;5480.479354461319;5522.944770552283;5602.719864006784;5625;5635.520980716644;5652.265205523297;5655.604107712462;5685.971570142165;5694.914576281359;5300.1519756838725;5307.734613269321;5340.225667278261;5347.25138480613;5352.357717073898;5473.28847249863;5539.058360078796;5547.278853748987;5713.742881570256;5756.453136951983;5409.972950135303;5466.535344495683;5502.504774570308;5537.058700021006;5547.362053363915;5637.492625663628;5639.154126880919;5639.238702775155;5677.63095398806;5707.800226992118;5425.755840987165;5483.616146869681;5484;5537.501624853702;5558.055130627722;5482.533984611273;5561.304836895388;5602.747876345574;5615.578831587647;5634.943650563524;4431.091626216617;4445.199864024442;4459.643228541709;4476.664250181249;4496.797644106023;3920.5295364556437;4006.198760247904;4050.41269015991;4067.1255680028344;4102.815373308149;5169.612279079084;5205.323307970016;5225.712585807817;5273.947260527422;5281.894362112736;5605.5795815313195;5686.829395118153;5693.174489699053;5731.254936858265;5741.88516229673;5097.592192624581;5225;5235.39792923811;5293.391260005072;5356.651817631841;4888.584470320063;4989.600831933437;4999.200127979506;5004.774785134678;5068.290439338495;5761.423857614289;5777.046787280052;5816.389279125716;5834.124881267844;5872.970635146797;5605;5632.127020311858;5650.208970744017;5697.145428185805;5717.3996730342715;5602.85992850182;5759.769609215752;5767.134929760569;5771.105478650816;5819.76720931175;5429.18562215655;5458.4541545845095;5487.067198576172;5554.888902222014;5600.439956004367;5640.830775076754;5653.406392328746;5668.26312579362;5669.206311116364;5689.260396148474;5269.077911365419;5348.6523375982;5510.586705997146;5526.198701188225;5570.359408668055;5475.780968761205;5488;5491.862703432446;5568.276124103841;5573.1918871762555;5420.864478388072;5426.077566813572;5439.401665816836;5471.2887324647545;5503.449655034625;5550.694711790728;5573.108302671553;5599.636023658449;5603.467670571289;5613.298337707786;5289.233061206027;5411.864703382447;5459.808906688406;5502.422245664147;5521.2270282161335 07:53:50 INFO - 2015-11-18 07:53:50,289 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.748954225827;557.111407305348;565.0619970848393;568.1534513574774;573.3377948469516;31105.06684799454;31792.20519487014;38100.80949595248;38926.80536597313;38941.805290973505;42207;42635;42809.78595107028;42840;42846.14307713844;8200.630971606262;9181.862272065924;9350.906490935105;9360.391574547666;9361.017093205217;8321.791955201108;8431.873521897176;8432;8432.198941100585;8449.23956843884;11137.276077054965;11296.322220666745;11308.773824523505;11311;11341.943290283538;10952.233343665946;11018.669439916815;11045.226834121615;11066;11117.777644447066;8413.326933845277;8553.101924297922;10816.188785841015;10943.06983906369;10990.890091099067;39055;39491;39533.20933581341;39549.60450395488;39574.80212598918;2951.011411177258;3014.593029940952;3054.266975925784;3197.6642452542383;3439.8968030959113;27504.862475687492;27551.173464796088;27826;27830;28213.858930705213;2306.215886598548;2323.047550504302;2360.1739391212936;2368.9881550592136;2485.6644353012475;284394;286435.56782216165;286608;286647;287002;58232.708836455546;58578.414215858145;58597;58739.118913216334;58813.41186588165;62540;62688.37311626917;62780;62849;62868.68565657234;16651.333946642;17174.33797761349;17194.31222751076;17196.31214751421;17218.827811721723;12904.93547532275;13005.804912926315;13012.804807927889;13059.020573457028;13093.083484156208;18606.06119874448;19182.232710691416;19214.13536390866;19238.422847314603;19274.518137046685;7995.920040799634;8223.712170074139;8231.711890083818;8233.8353232935;8248.370716884672;944.2210176604328;1023.8259495885568;1129.3788416370962;1145.8854114588642;1167.206299716201;27953;28385.148445546667;28565;28917.710822891502;28937.85531072373;929.3958926697701;1010.8180527505119;1036.5853658536646;1048.5411709541265;1062.866355502919;13897.444102235797;13962.232077235849;14017.439302427993;14024.789628155382;14095.436182552789;345234;346417;351125;351860;352243;44291.778541107735;44990.775046125214;44996.55003449923;50602.74698626557;51872.221916670525;1338.5248236875768;1359.7348517039081;1362.50949658123;1377.9724405512034;1394.0450791208054;25957.870210648827;26004;26067.869660651577;26138;27147.321316967234;42814;43524.12951741011;51347.48652513576;52850.471495286096;52931.470685294196;198477;202991;203000;203144;203381;30013.69986300109;30407.847960760053;30421.543676844423;30433;30439.239019023815;38662.22675546417;39059.218815624095;39327.41008884812;39540.80229598949;39941.2011759769;33823.49264760981;33910.15224619404;34212.31575368528;34428.3521724564;34447.4832877512;33793.15517112092;34417.31165376728;34418.48372274368;34715.30569388548;34723;34720.82639586786;34814;35071.47392789059;35247.29505409929;35324.82337588296;30345.848270758506;30485.54271685971;30500.694993049787;30503.389932201677;30552.236194094436;23263.76736232684;23522.882385587964;23584.764152358257;23999;24518.264452066465 07:53:50 INFO - 2015-11-18 07:53:50,291 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.24187473497807;334.29630627529053;334.50994293360225;337.50386931211114;338.17822690861203;14282.571522854305;14696.779548306784;17093.145342732874;17177.914110429447;18060.367887123968;14237.786433203484;15608.219589020531;17931.82068179318;18159.909200453978;19016.809831901675;5520.779168833242;5664.490195882369;5665.971670141644;5670.4896559309655;5682.7442765075675;4026.516817981846;4153.02403935075;4764.499727528611;6105.481034112106;6118.235220597426;5883.382244864292;6003.969980150093;6053.818385448421;6061.727222274986;6062.151298818169;5633.690147041891;5652.434756524356;5659.60382773206;5660.85847853807;6025.186599809035;5239.266502689627;5321.547668448186;5325.094733895247;5332.200169974496;5335.733213339317;16156.676866462605;16193.59516012109;21125.3662390127;21537.353879383645;21800.89099554508;2060.464279287381;2197.165077270643;2379.1553998330514;2545.1219329331534;2691.3944362518278;13114.672133196651;13406.731865362735;13414.128081674757;13706.862931370659;13745.24401157936;1665.192381694877;1684.2084220416384;1696.3723422333692;1742.5992021834923;1750.711132663109;55496.72251638756;56020.71989640067;56478.717606412116;56770.716146419414;56811;9502.714918552454;9649;9825.263105267133;9828.852567211497;9899.208063354914;12160.878391215974;12166.81749773754;12175.0868684849;12180.57367992116;12194.39028048594;5248.9737551312;5295.073362161684;5346.759395827119;5438;7889.250521200477;5675.914861277084;5695.8860822784145;5723.422696434502;5747.770089196469;5798.420157984252;2886.581445690405;2921.7954743167775;2933.398653276073;2936.295289130636;2946.8231906085703;984.0651381187901;1017.2116609627598;1052.4211683574003;1073.1790180511914;1080.0873262093519;424.35074336265563;425.7126439653222;440.87655456472237;442.78967490441784;460.8916904527433;10434.321769084985;11177.273477223955;11335.263207891461;11743.11926605508;11916.702082447835;410.5483967635577;454.20967516521677;455.78350283615015;463.5063657205066;480.4474853918022;5953.22608060958;6142.477889379453;6388.7125079371535;6422.42198202164;6423.068655044993;547164;553622;555282;557648;558914;66005.66997164984;67417.32582674209;67596.93023023194;67605.66197168983;67802.66098669475;501.490986648552;503.92693059506166;506.8099462701487;507.9517445842639;508.0271280497805;10693.786124277627;10867.402292873969;10970.506327215135;11014.284071535645;11038.337699738042;32218.516722249653;32763.836180818944;32856.83571582127;33031.50452743259;33650.66349336475;41615;44450.333245001995;45239;45330.773346134374;46204;6067.878642427215;6145.139680444652;6215.06773983888;6260.718267678057;6265.15420418256;11534.94232528832;11676.241044332091;11769.47037383337;11775.646730598095;11782.293062416282;9903.752406189615;9987.750306242402;10164.288499805238;10202.846957295795;10333.586656533655;9688.854667179858;9704.563294651898;9825.361351512129;9899.307048506535;10220.02909723575;10212.846807298045;10237.129843963048;10377.792444151226;10381.429021403896;10506.054455099078;6129.448349648553;6136.539759518143;6139.4781443577795;6140.907886381798;6226.40849119333;9940.502974851373;10001.799964000826;10038.749031274276;10122.291439599452;10291.794164116825 07:53:50 INFO - 2015-11-18 07:53:50,294 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1284.9357532123393;1472.852714728527;1538.6845696632192;1685.511201751492;1818.1000404799618;6619.238787539434;6889.896651550224;7109.644517774103;7317.817054573638;7326.633668316589;7041.718331266756;7211.7836464906;7226.096737907762;7226.963865180666;7277.6725047372865;1849.2972670385234;1891.3947536788164;2074.71991281177;2096.821770149539;2096.937091887246;2091.44576687178;2113.0596884386455;2118.5233322502468;2134.6691262854283;2146.2809958663865;2048.7439070116234;2078.948026299347;2094.675325324577;2098.202682980473;2121.4378189779723;1799.3792141711153;1844.3452574336052;2045.3966080006435;2069.4722845674332;2101.5796840631783;2087.7077209190725;2112.86266392684;2127.659574468093;2133.5306232628795;2143.110609097223;7251.5286506376915;7252.129744430702;7335.376492998102;7349.853002939964;7362.153352364493;4298.570142985708;4349.956500435019;4382.868513944587;4387.16643837673;4388.648908087345;2764.14311563416;2791.330080780618;2820.4218135282217;2825.717428257178;2871.770258379325;913.2100732866023;941.0965473145789;943.7499062748377;966.5360626899057;975.4634950777045;9431;9537.046295370477;9538.9523052385;9560.139587437094;9564.66523671668;3846.4614953905916;3893.5911729268587;3901.902452438655;3926.6662333701956;3979.303621866162;8256.463329883538;8350.707725229588;8353.665853365797;8358.83282334362;8365;4451.132029254264;4458.799354029076;4461.7992190351515;4461.955380446219;4463.352813841975;4071.226466971266;4115.1975364804175;4126.277901367249;4126.66986641068;4137.855175068858;3298.6371499135075;3355;3422.281320922584;3423.657634236606;3430.485427185892;1065.1265961911158;1080.7460246841986;1102.3165637304921;1105.165599972016;1114.5207560748793;1272.5864094169433;1290.5741105435184;1310.541310541303;1326.1711430356027;1330.9134906231257;6812.216595091529;7116.964415177891;7120.537165084253;7128.180259270147;7140.07179066718;1130.4347826086957;1140.5836869542557;1144.4506636814376;1157.2767020612118;1166.125405945541;5500.669959802344;5512.2558454608115;5557.944420555743;5565.193047008162;5575.107982722826;8464;8492.278156356655;8697.521636309937;8707.172818582225;8754.69358572447;8530.488170709777;8532.658693652184;8559.186877246651;8594.828103438022;8619.1811777881;6612.801615951529;6712.597244165366;6781.898271525931;6796.150481189851;6844.589324640637;6538.084668146558;6539.967300163659;6543.70553325111;6546.116274302908;6564.573302735307;7278.053852999076;7490.588017659081;7499.362554182955;7534.962325188339;7579.5073320234005;7485.588292643739;7507.1607456171405;7616.581088040211;7627.694892204249;7761.805954851174;6102.328743838263;6104.6642434664745;6144.754209831557;6188.257409110935;6196.0705894116245;6592.901106483502;6742;6747.257801641914;6754.020667003355;6766.120404347404;6179.969100154471;6331.746730130927;6346.333634968262;6370.936290637034;6417.101605775289;5726.341470730919;5804.593678442468;5957.91063134062;6192.783252586138;6365.586236894587;6509.772157974448;6560.639164845979;6635.701393437211;6635.966820165868;6640.136782218281;5725.08398656213;5763.9135412968;5802.709864506842;5815.2149459822385;5826.82519524415;6097.451229389376;6142.570020098729;6169;6171.444569988723;6181.783637572664 07:53:50 INFO - 2015-11-18 07:53:50,295 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.60344457372275;317.1785076651472;317.5078628126403;317.7839069432786;319.3612774451098;6121.540884433669;6128.6322820630685;6318.968405157973;6325.493960483162;6337.36626337366;6042.8489287767825;6155.722992465338;6256.84357891053;6273.52948528861;6316.336784637604;4869.074875773609;4888.73111978841;4926.18717911546;4931.630127740415;4952.653314268003;4689.7655117244;4775.856724298259;4819;4840.806367745286;4940.827071052514;4681.204195286809;4705.811767529295;4786.760661966905;4814.085323788487;4829.492903245161;4743.881402964919;4758.262469317261;4844.806207751686;4848.17581011229;4859.854204373839;4125.133721918401;4146.834126634961;4164.979175104136;4178.811953462102;4191.287481128215;5830.533557315404;6016;6027.397260273981;6035.879282414371;6121.908171377433;5280.894382112375;5302.708351040691;5355.196720491957;5368.489993450616;5369.677819330853;6158.137860699506;6428.389303016206;6540.084388185658;6577;6588.670566471657;4226.682998775073;4300.978495107535;4323.4163387942535;4353.521112677603;4355.738655680638;6829.93170068298;6834.179898412172;6844.28135045823;6891.241963384024;6899.0341352210735;4403.383526306319;4413.1394378095965;4420.8673739787855;4451.354553589711;4490.977545112253;4390.07808360248;4468.754218518013;4515.14212299662;4542.931856022163;4544.931826022612;5263.289455923401;5268.894622107537;5269.657472264291;5325.147976323769;5347.438518955453;6490.188726409199;6508.926027205458;6523.7064332105165;6531.673416329165;6552.049952756919;1575.322611277139;1583.3429126912433;1585.191552308331;1590.9738218848777;1606.1567676969685;1000.4997501249376;1017.7404761785697;1022.6471867205802;1027.3476342522551;1048.5596049659162;6060.939390606126;6130.080487926846;6173.81478555644;6205.410486003822;6209.223847019122;6746.460283177334;6771.052052712625;6787.117674702257;6789.796306110825;6798.320167983261;6052.284335636446;6111.113888486145;6185.907211391833;6195.19462469876;6198;3629.256002519477;3632.1282892105705;3646.3801153803915;3682.6869716073898;3688.55737311519;6846.5892046477375;6853.246142924274;6942.062821519131;6973.51185417026;6973.895391569131;6856.725730970706;6874.553154044971;6878.037074809531;6925.995730619032;6941.375276225164;7068.798304288283;7072.115985501812;7139.643017849191;7160.248173941661;7174.784756457315;6581.3418658133805;6652.966735166487;6720.798376048726;6776.390124888783;6847.760328388483;6663.5002374821115;6717.832054198684;6747.291534388818;6769.796906092825;6804.081449004519;7048.083749112582;7058;7132.215456299699;7154.642267886481;7156.821079473055;4309.806058727428;4477.597016268422;4486.977565112154;4501.842435514741;4557.111363284261;6772.11962444879;6784.559003664746;6803.557768745016;6863.965680171567;6894.517383783087;6554.934450655624;6561.40947314744;6606.174228221473;6610.8347291318105;6619.867602647823;6400.135981642418;6513.674316284072;6532.020196970492;6578.572392794645;6625.933740662532;6363.204599425072;6374.203224596926;6405.711742971671;6458.483321334376;6479;6362.713677884413;6571.441427478718;6572.572782769104;6602.570832895846;6626.83432914181;6426.742930282923;6431.099646049651;6501;6503;6528.21661400635 07:53:50 INFO - 2015-11-18 07:53:50,296 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.8071099736576;702.599518274583;705.6224919667977;758.4766511107335;781.3788038509383;11961.940190299058;14279.857201427996;14448.06087604305;14495.49265775698;14528.63678408039;12985;13058.151220170683;13066.477340906376;13072.150310229828;13086;690.0684076496715;691.9031335613018;853.6884037326362;883.1609970527992;883.6465413834453;888.1961824548762;901.5537309032038;902.1204325782343;904.2404380320529;909;936.8501039833628;945.394947233771;946.1059298962483;946.1768261612373;961.1301771896445;742.4988133010196;742.617551960738;921.7833809054866;924.3668087360113;927.3554879358849;693.9132608423947;694.0179645801185;694.2120693013466;701.8350687588413;713.1228588835709;12515.123941324111;12637.115401921868;12651.367431628381;12663.873361266362;12696.238225706395;10837.349759014485;10984.835227471594;11065.557377704883;11137.665870023913;11241.550337986471;8417.873731894026;8744.256738177262;9383.061693830563;9469.289803264714;9744.951275243578;3353.3293341331832;3362.1090411041096;3380.5436266104252;3385.6783605557434;3404.3021180657906;46930.76534617339;47267.29099063517;47286.29070563944;47336;47406;8758.12418758119;8801.955990220007;8934.28525717941;8939.642414303486;9366.344355895159;17924.28302867897;18013;18049.368272110412;18055.097245137953;18072;6967.059446974695;7065.0815393998455;7111.715531378791;7224.277572242734;7293.124825021031;3807.314683357022;3823.2926908522013;3823.6749876260274;3985.3623420253202;3992.6207010333974;3198.296374797541;3240.238543942172;3276.19733165376;3286.063471910494;3286.8192249426033;432.23062947952695;437.0864892374952;448.5424866636013;453.4354728363209;453.75043725950593;542.5740793477102;586.8708884045503;591.3967752892027;602.9909551356645;614.8467104707671;7513.737019204302;7664.233576642291;7878.448508604457;7959.44283900133;8312.168783121639;454.8408057180027;575.9683217423081;609.5093449772976;610.1701685707434;664.8936170212743;3459.4810778383444;3507.877224297137;3636.5272514572935;3757.605451427615;3833.5974722654278;55472.6131846699;55983;56132.158017629765;56342.71828640831;56390.436095639336;48564;49771;49909.50090499121;49985;50198.24702629464;44271.557284427385;44997.55002449934;45564.544354556696;45912.54087459216;46129.308060379124;7644.273793989562;7675.078990521173;7703.768886933401;7717.768466946;7842.647080881488;33915.66084339224;34065.31869362648;34430;34540;35577.644223557436;42780.78609606932;44505.77747111244;44801.10397791961;44938.77530612457;45047.17099046618;6820.522563420513;7011.6494175292055;7079;7122.394596459359;7333.559986400833;10418.426986515511;10533.42066186367;10656.680299591024;11042.17183711241;11092.556297748322;10116.443595602312;10141.847872281774;10143.239257055899;10251.897481025393;10267.435291058764;10174.745631359276;10469.057784799405;10630.893691062991;10641.414722190353;10932.453377331261;10104.595816167272;10247.692569222936;10279.17766578657;10318;10365.585376584851;8619.1811777881;8665.653373865227;8705.651773928972;8929.05341237403;9068.22920051803;8166.673333066611;8267.793305167179;8470.407071504935;8487.108853570286;8596.828063438821 07:53:50 INFO - 2015-11-18 07:53:50,297 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:53:50 INFO - 2015-11-18 07:53:50,298 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:53:50 INFO - 2015-11-18 07:53:50,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1865 07:53:50 INFO - 2015-11-18 07:53:50,298 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:53:50 INFO - 2015-11-18 07:53:50,298 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862030284__endTimestamp 07:53:50 INFO - 2015-11-18 07:53:50,298 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,299 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:53:50 INFO - 2015-11-18 07:53:50,299 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:53:50 INFO - 2015-11-18 07:53:50,299 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,299 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5236.57 Median:5426.08 stddev:645.19 (11.9%) stddev-sans-first:624.58 07:53:50 INFO - 2015-11-18 07:53:50,299 DEBUG : BROWSER_OUTPUT: Values: 3079.1 3185.9 3211.6 3230.7 3240.5 5174.6 5263.9 5313.5 5406.6 5479.1 5306.9 5312.4 5317.1 5349.1 5356.8 4887.4 4893.1 4951.2 4961.1 4963.5 4927.2 5021.7 5059.5 5073.3 5100.7 5002.4 5022.1 5047.7 5050.4 5063.9 533.2 4672.9 4890.9 4946.9 4985.8 4844.0 4930.7 4932.8 4939.9 4965.8 5170.3 5170.9 5172.5 5213.9 5272.8 5380.4 5480.5 5522.9 5602.7 5625.0 5635.5 5652.3 5655.6 5686.0 5694.9 5300.2 5307.7 5340.2 5347.3 5352.4 5473.3 5539.1 5547.3 5713.7 5756.5 5410.0 5466.5 5502.5 5537.1 5547.4 5637.5 5639.2 5639.2 5677.6 5707.8 5425.8 5483.6 5484.0 5537.5 5558.1 5482.5 5561.3 5602.7 5615.6 5634.9 4431.1 4445.2 4459.6 4476.7 4496.8 3920.5 4006.2 4050.4 4067.1 4102.8 5169.6 5205.3 5225.7 5273.9 5281.9 5605.6 5686.8 5693.2 5731.3 5741.9 5097.6 5225.0 5235.4 5293.4 5356.7 4888.6 4989.6 4999.2 5004.8 5068.3 5761.4 5777.0 5816.4 5834.1 5873.0 5605.0 5632.1 5650.2 5697.1 5717.4 5602.9 5759.8 5767.1 5771.1 5819.8 5429.2 5458.5 5487.1 5554.9 5600.4 5640.8 5653.4 5668.3 5669.2 5689.3 5269.1 5348.7 5510.6 5526.2 5570.4 5475.8 5488.0 5491.9 5568.3 5573.2 5420.9 5426.1 5439.4 5471.3 5503.4 5550.7 5573.1 5599.6 5603.5 5613.3 5289.2 5411.9 5459.8 5502.4 5521.2 07:53:50 INFO - 2015-11-18 07:53:50,300 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,300 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44829.47 Median:30502.04 stddev:74863.86 (245.4%) stddev-sans-first:75000.05 07:53:50 INFO - 2015-11-18 07:53:50,301 DEBUG : BROWSER_OUTPUT: Values: 551.7 557.1 565.1 568.2 573.3 31105.1 31792.2 38100.8 38926.8 38941.8 42207.0 42635.0 42809.8 42840.0 42846.1 8200.6 9181.9 9350.9 9360.4 9361.0 8321.8 8431.9 8432.0 8432.2 8449.2 11137.3 11296.3 11308.8 11311.0 11341.9 10952.2 11018.7 11045.2 11066.0 11117.8 8413.3 8553.1 10816.2 10943.1 10990.9 39055.0 39491.0 39533.2 39549.6 39574.8 2951.0 3014.6 3054.3 3197.7 3439.9 27504.9 27551.2 27826.0 27830.0 28213.9 2306.2 2323.0 2360.2 2369.0 2485.7 284394.0 286435.6 286608.0 286647.0 287002.0 58232.7 58578.4 58597.0 58739.1 58813.4 62540.0 62688.4 62780.0 62849.0 62868.7 16651.3 17174.3 17194.3 17196.3 17218.8 12904.9 13005.8 13012.8 13059.0 13093.1 18606.1 19182.2 19214.1 19238.4 19274.5 7995.9 8223.7 8231.7 8233.8 8248.4 944.2 1023.8 1129.4 1145.9 1167.2 27953.0 28385.1 28565.0 28917.7 28937.9 929.4 1010.8 1036.6 1048.5 1062.9 13897.4 13962.2 14017.4 14024.8 14095.4 345234.0 346417.0 351125.0 351860.0 352243.0 44291.8 44990.8 44996.6 50602.7 51872.2 1338.5 1359.7 1362.5 1378.0 1394.0 25957.9 26004.0 26067.9 26138.0 27147.3 42814.0 43524.1 51347.5 52850.5 52931.5 198477.0 202991.0 203000.0 203144.0 203381.0 30013.7 30407.8 30421.5 30433.0 30439.2 38662.2 39059.2 39327.4 39540.8 39941.2 33823.5 33910.2 34212.3 34428.4 34447.5 33793.2 34417.3 34418.5 34715.3 34723.0 34720.8 34814.0 35071.5 35247.3 35324.8 30345.8 30485.5 30500.7 30503.4 30552.2 23263.8 23522.9 23584.8 23999.0 24518.3 07:53:50 INFO - 2015-11-18 07:53:50,301 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,301 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27379.25 Median:44844.67 stddev:90593.43 (202.0%) stddev-sans-first:90824.81 07:53:50 INFO - 2015-11-18 07:53:50,303 DEBUG : BROWSER_OUTPUT: Values: 333.2 334.3 334.5 337.5 338.2 14282.6 14696.8 17093.1 17177.9 18060.4 14237.8 15608.2 17931.8 18159.9 19016.8 5520.8 5664.5 5666.0 5670.5 5682.7 4026.5 4153.0 4764.5 6105.5 6118.2 5883.4 6004.0 6053.8 6061.7 6062.2 5633.7 5652.4 5659.6 5660.9 6025.2 5239.3 5321.5 5325.1 5332.2 5335.7 16156.7 16193.6 21125.4 21537.4 21800.9 2060.5 2197.2 2379.2 2545.1 2691.4 13114.7 13406.7 13414.1 13706.9 13745.2 1665.2 1684.2 1696.4 1742.6 1750.7 55496.7 56020.7 56478.7 56770.7 56811.0 9502.7 9649.0 9825.3 9828.9 9899.2 12160.9 12166.8 12175.1 12180.6 12194.4 5249.0 5295.1 5346.8 5438.0 7889.3 5675.9 5695.9 5723.4 5747.8 5798.4 2886.6 2921.8 2933.4 2936.3 2946.8 984.1 1017.2 1052.4 1073.2 1080.1 424.4 425.7 440.9 442.8 460.9 10434.3 11177.3 11335.3 11743.1 11916.7 410.5 454.2 455.8 463.5 480.4 5953.2 6142.5 6388.7 6422.4 6423.1 547164.0 553622.0 555282.0 557648.0 558914.0 66005.7 67417.3 67596.9 67605.7 67802.7 501.5 503.9 506.8 508.0 508.0 10693.8 10867.4 10970.5 11014.3 11038.3 32218.5 32763.8 32856.8 33031.5 33650.7 41615.0 44450.3 45239.0 45330.8 46204.0 6067.9 6145.1 6215.1 6260.7 6265.2 11534.9 11676.2 11769.5 11775.6 11782.3 9903.8 9987.8 10164.3 10202.8 10333.6 9688.9 9704.6 9825.4 9899.3 10220.0 10212.8 10237.1 10377.8 10381.4 10506.1 6129.4 6136.5 6139.5 6140.9 6226.4 9940.5 10001.8 10038.7 10122.3 10291.8 07:53:50 INFO - 2015-11-18 07:53:50,303 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,303 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5020.55 Median:6123.62 stddev:2544.81 (41.6%) stddev-sans-first:2536.46 07:53:50 INFO - 2015-11-18 07:53:50,305 DEBUG : BROWSER_OUTPUT: Values: 1284.9 1472.9 1538.7 1685.5 1818.1 6619.2 6889.9 7109.6 7317.8 7326.6 7041.7 7211.8 7226.1 7227.0 7277.7 1849.3 1891.4 2074.7 2096.8 2096.9 2091.4 2113.1 2118.5 2134.7 2146.3 2048.7 2078.9 2094.7 2098.2 2121.4 1799.4 1844.3 2045.4 2069.5 2101.6 2087.7 2112.9 2127.7 2133.5 2143.1 7251.5 7252.1 7335.4 7349.9 7362.2 4298.6 4350.0 4382.9 4387.2 4388.6 2764.1 2791.3 2820.4 2825.7 2871.8 913.2 941.1 943.7 966.5 975.5 9431.0 9537.0 9539.0 9560.1 9564.7 3846.5 3893.6 3901.9 3926.7 3979.3 8256.5 8350.7 8353.7 8358.8 8365.0 4451.1 4458.8 4461.8 4462.0 4463.4 4071.2 4115.2 4126.3 4126.7 4137.9 3298.6 3355.0 3422.3 3423.7 3430.5 1065.1 1080.7 1102.3 1105.2 1114.5 1272.6 1290.6 1310.5 1326.2 1330.9 6812.2 7117.0 7120.5 7128.2 7140.1 1130.4 1140.6 1144.5 1157.3 1166.1 5500.7 5512.3 5557.9 5565.2 5575.1 8464.0 8492.3 8697.5 8707.2 8754.7 8530.5 8532.7 8559.2 8594.8 8619.2 6612.8 6712.6 6781.9 6796.2 6844.6 6538.1 6540.0 6543.7 6546.1 6564.6 7278.1 7490.6 7499.4 7535.0 7579.5 7485.6 7507.2 7616.6 7627.7 7761.8 6102.3 6104.7 6144.8 6188.3 6196.1 6592.9 6742.0 6747.3 6754.0 6766.1 6180.0 6331.7 6346.3 6370.9 6417.1 5726.3 5804.6 5957.9 6192.8 6365.6 6509.8 6560.6 6635.7 6636.0 6640.1 5725.1 5763.9 5802.7 5815.2 5826.8 6097.5 6142.6 6169.0 6171.4 6181.8 07:53:50 INFO - 2015-11-18 07:53:50,305 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,305 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5462.67 Median:6190.55 stddev:1677.40 (27.1%) stddev-sans-first:1636.89 07:53:50 INFO - 2015-11-18 07:53:50,305 DEBUG : BROWSER_OUTPUT: Values: 308.6 317.2 317.5 317.8 319.4 6121.5 6128.6 6319.0 6325.5 6337.4 6042.8 6155.7 6256.8 6273.5 6316.3 4869.1 4888.7 4926.2 4931.6 4952.7 4689.8 4775.9 4819.0 4840.8 4940.8 4681.2 4705.8 4786.8 4814.1 4829.5 4743.9 4758.3 4844.8 4848.2 4859.9 4125.1 4146.8 4165.0 4178.8 4191.3 5830.5 6016.0 6027.4 6035.9 6121.9 5280.9 5302.7 5355.2 5368.5 5369.7 6158.1 6428.4 6540.1 6577.0 6588.7 4226.7 4301.0 4323.4 4353.5 4355.7 6829.9 6834.2 6844.3 6891.2 6899.0 4403.4 4413.1 4420.9 4451.4 4491.0 4390.1 4468.8 4515.1 4542.9 4544.9 5263.3 5268.9 5269.7 5325.1 5347.4 6490.2 6508.9 6523.7 6531.7 6552.0 1575.3 1583.3 1585.2 1591.0 1606.2 1000.5 1017.7 1022.6 1027.3 1048.6 6060.9 6130.1 6173.8 6205.4 6209.2 6746.5 6771.1 6787.1 6789.8 6798.3 6052.3 6111.1 6185.9 6195.2 6198.0 3629.3 3632.1 3646.4 3682.7 3688.6 6846.6 6853.2 6942.1 6973.5 6973.9 6856.7 6874.6 6878.0 6926.0 6941.4 7068.8 7072.1 7139.6 7160.2 7174.8 6581.3 6653.0 6720.8 6776.4 6847.8 6663.5 6717.8 6747.3 6769.8 6804.1 7048.1 7058.0 7132.2 7154.6 7156.8 4309.8 4477.6 4487.0 4501.8 4557.1 6772.1 6784.6 6803.6 6864.0 6894.5 6554.9 6561.4 6606.2 6610.8 6619.9 6400.1 6513.7 6532.0 6578.6 6625.9 6363.2 6374.2 6405.7 6458.5 6479.0 6362.7 6571.4 6572.6 6602.6 6626.8 6426.7 6431.1 6501.0 6503.0 6528.2 07:53:50 INFO - 2015-11-18 07:53:50,305 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,305 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13154.37 Median:47985.00 stddev:15711.93 (32.7%) stddev-sans-first:15728.06 07:53:50 INFO - 2015-11-18 07:53:50,306 DEBUG : BROWSER_OUTPUT: Values: 676.8 702.6 705.6 758.5 781.4 11961.9 14279.9 14448.1 14495.5 14528.6 12985.0 13058.2 13066.5 13072.2 13086.0 690.1 691.9 853.7 883.2 883.6 888.2 901.6 902.1 904.2 909.0 936.9 945.4 946.1 946.2 961.1 742.5 742.6 921.8 924.4 927.4 693.9 694.0 694.2 701.8 713.1 12515.1 12637.1 12651.4 12663.9 12696.2 10837.3 10984.8 11065.6 11137.7 11241.6 8417.9 8744.3 9383.1 9469.3 9745.0 3353.3 3362.1 3380.5 3385.7 3404.3 46930.8 47267.3 47286.3 47336.0 47406.0 8758.1 8802.0 8934.3 8939.6 9366.3 17924.3 18013.0 18049.4 18055.1 18072.0 6967.1 7065.1 7111.7 7224.3 7293.1 3807.3 3823.3 3823.7 3985.4 3992.6 3198.3 3240.2 3276.2 3286.1 3286.8 432.2 437.1 448.5 453.4 453.8 542.6 586.9 591.4 603.0 614.8 7513.7 7664.2 7878.4 7959.4 8312.2 454.8 576.0 609.5 610.2 664.9 3459.5 3507.9 3636.5 3757.6 3833.6 55472.6 55983.0 56132.2 56342.7 56390.4 48564.0 49771.0 49909.5 49985.0 50198.2 44271.6 44997.6 45564.5 45912.5 46129.3 7644.3 7675.1 7703.8 7717.8 7842.6 33915.7 34065.3 34430.0 34540.0 35577.6 42780.8 44505.8 44801.1 44938.8 45047.2 6820.5 7011.6 7079.0 7122.4 7333.6 10418.4 10533.4 10656.7 11042.2 11092.6 10116.4 10141.8 10143.2 10251.9 10267.4 10174.7 10469.1 10630.9 10641.4 10932.5 10104.6 10247.7 10279.2 10318.0 10365.6 8619.2 8665.7 8705.7 8929.1 9068.2 8166.7 8267.8 8470.4 8487.1 8596.8 07:53:50 INFO - 2015-11-18 07:53:50,307 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:53:50 INFO - 2015-11-18 07:53:50,307 DEBUG : BROWSER_OUTPUT: 07:53:50 INFO - 2015-11-18 07:53:50,974 INFO : Browser exited with error code: 0 07:53:51 INFO - 2015-11-18 07:53:51,000 INFO : Completed test dromaeo_css (00:18:36) 07:53:51 INFO - 2015-11-18 07:53:51,001 INFO : Starting test kraken 07:53:51 INFO - 2015-11-18 07:53:51,001 DEBUG : operating with platform_type : mac_ 07:53:51 INFO - 2015-11-18 07:53:51,001 INFO : Initialising browser for kraken test... 07:53:51 INFO - 2015-11-18 07:53:51,014 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/tmpCfXebe/profile http://localhost:49253/getInfo.html 07:53:53 INFO - 2015-11-18 07:53:53,212 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:53:53 INFO - 2015-11-18 07:53:53,212 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:53:53 INFO - 2015-11-18 07:53:53,212 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:53:53 INFO - 2015-11-18 07:53:53,212 DEBUG : BROWSER_OUTPUT: __metrics 07:53:53 INFO - 2015-11-18 07:53:53,220 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:53 INFO - 2015-11-18 07:53:53,903 INFO : Browser initialized. 07:53:53 INFO - 2015-11-18 07:53:53,904 INFO : Running cycle 1/1 for kraken test... 07:53:53 INFO - 2015-11-18 07:53:53,904 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/tmpCfXebe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:54:05 INFO - 2015-11-18 07:54:05,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 229335040 07:54:05 INFO - 2015-11-18 07:54:05,827 DEBUG : BROWSER_OUTPUT: 07:54:08 INFO - 2015-11-18 07:54:08,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:09 INFO - 2015-11-18 07:54:09,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 287457280 07:54:09 INFO - 2015-11-18 07:54:09,052 DEBUG : BROWSER_OUTPUT: 07:54:11 INFO - 2015-11-18 07:54:11,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-dft) 07:54:12 INFO - 2015-11-18 07:54:12,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 299245568 07:54:12 INFO - 2015-11-18 07:54:12,273 DEBUG : BROWSER_OUTPUT: 07:54:15 INFO - 2015-11-18 07:54:15,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-fft) 07:54:15 INFO - 2015-11-18 07:54:15,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 282374144 07:54:15 INFO - 2015-11-18 07:54:15,843 DEBUG : BROWSER_OUTPUT: 07:54:17 INFO - 2015-11-18 07:54:17,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator) 07:54:18 INFO - 2015-11-18 07:54:18,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 283029504 07:54:18 INFO - 2015-11-18 07:54:18,459 DEBUG : BROWSER_OUTPUT: 07:54:20 INFO - 2015-11-18 07:54:20,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:21 INFO - 2015-11-18 07:54:21,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 285487104 07:54:21 INFO - 2015-11-18 07:54:21,210 DEBUG : BROWSER_OUTPUT: 07:54:24 INFO - 2015-11-18 07:54:24,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:24 INFO - 2015-11-18 07:54:24,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 285540352 07:54:24 INFO - 2015-11-18 07:54:24,826 DEBUG : BROWSER_OUTPUT: 07:54:28 INFO - 2015-11-18 07:54:28,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:28 INFO - 2015-11-18 07:54:28,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 285163520 07:54:28 INFO - 2015-11-18 07:54:28,590 DEBUG : BROWSER_OUTPUT: 07:54:31 INFO - 2015-11-18 07:54:31,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial) 07:54:31 INFO - 2015-11-18 07:54:31,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 284749824 07:54:31 INFO - 2015-11-18 07:54:31,960 DEBUG : BROWSER_OUTPUT: 07:54:33 INFO - 2015-11-18 07:54:33,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:34 INFO - 2015-11-18 07:54:34,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 319823872 07:54:34 INFO - 2015-11-18 07:54:34,118 DEBUG : BROWSER_OUTPUT: 07:54:35 INFO - 2015-11-18 07:54:35,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:36 INFO - 2015-11-18 07:54:36,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 321626112 07:54:36 INFO - 2015-11-18 07:54:36,590 DEBUG : BROWSER_OUTPUT: 07:54:38 INFO - 2015-11-18 07:54:38,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:39 INFO - 2015-11-18 07:54:39,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 327999488 07:54:39 INFO - 2015-11-18 07:54:39,275 DEBUG : BROWSER_OUTPUT: 07:54:41 INFO - 2015-11-18 07:54:41,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:42 INFO - 2015-11-18 07:54:42,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 330133504 07:54:42 INFO - 2015-11-18 07:54:42,430 DEBUG : BROWSER_OUTPUT: 07:54:45 INFO - 2015-11-18 07:54:45,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:45 INFO - 2015-11-18 07:54:45,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 328491008 07:54:45 INFO - 2015-11-18 07:54:45,654 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49253/tests/kraken/driver.html?testName=ai-astar) 07:54:47 INFO - 2015-11-18 07:54:47,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 387760128 07:54:47 INFO - 2015-11-18 07:54:47,638 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,639 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:54:47 INFO - 2015-11-18 07:54:47,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:54:47 INFO - 2015-11-18 07:54:47,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:54:47 INFO - 2015-11-18 07:54:47,639 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:54:47 INFO - 2015-11-18 07:54:47,639 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;105;108;109;109;101;110;113;109 07:54:47 INFO - 2015-11-18 07:54:47,640 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;129;151;166;128;148;147;126;167;127 07:54:47 INFO - 2015-11-18 07:54:47,640 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;162;162;163;163;163;163;161;161 07:54:47 INFO - 2015-11-18 07:54:47,640 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;82;88;86;68;70;71;80;82;66 07:54:47 INFO - 2015-11-18 07:54:47,640 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;98;132;89;90;89;126;88;87;130 07:54:47 INFO - 2015-11-18 07:54:47,640 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;120;114;119;120;114;114;114;115;120 07:54:47 INFO - 2015-11-18 07:54:47,640 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;126;125;125;126;126;125;125;125 07:54:47 INFO - 2015-11-18 07:54:47,641 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;93;100;93;93;92;101;93;93;93 07:54:47 INFO - 2015-11-18 07:54:47,641 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;58;59;59;59;68;57;59 07:54:47 INFO - 2015-11-18 07:54:47,641 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;70;70;70;70;70;71 07:54:47 INFO - 2015-11-18 07:54:47,641 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;85;85;85;85;86;88;86;85 07:54:47 INFO - 2015-11-18 07:54:47,641 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;134;124;126;122;125;120;130;133;127 07:54:47 INFO - 2015-11-18 07:54:47,641 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;153;153;154;157;141;153;152;152;152 07:54:47 INFO - 2015-11-18 07:54:47,642 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;70;71;71;70;70;72;72;71 07:54:47 INFO - 2015-11-18 07:54:47,642 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:54:47 INFO - 2015-11-18 07:54:47,642 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:54:47 INFO - 2015-11-18 07:54:47,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 07:54:47 INFO - 2015-11-18 07:54:47,642 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:54:47 INFO - 2015-11-18 07:54:47,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862087637__endTimestamp 07:54:47 INFO - 2015-11-18 07:54:47,643 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,644 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:54:47 INFO - 2015-11-18 07:54:47,644 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:54:47 INFO - 2015-11-18 07:54:47,644 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,644 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.18 (2.9%) stddev-sans-first:3.37 07:54:47 INFO - 2015-11-18 07:54:47,644 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 105.0 108.0 109.0 109.0 101.0 110.0 113.0 109.0 07:54:47 INFO - 2015-11-18 07:54:47,645 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,645 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:149.50 stddev:16.15 (10.8%) stddev-sans-first:16.49 07:54:47 INFO - 2015-11-18 07:54:47,645 DEBUG : BROWSER_OUTPUT: Values: 157.0 129.0 151.0 166.0 128.0 148.0 147.0 126.0 167.0 127.0 07:54:47 INFO - 2015-11-18 07:54:47,645 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,645 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 07:54:47 INFO - 2015-11-18 07:54:47,645 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 162.0 162.0 163.0 163.0 163.0 163.0 161.0 161.0 07:54:47 INFO - 2015-11-18 07:54:47,646 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,646 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.80 Median:81.00 stddev:7.83 (9.7%) stddev-sans-first:8.28 07:54:47 INFO - 2015-11-18 07:54:47,646 DEBUG : BROWSER_OUTPUT: Values: 75.0 82.0 88.0 86.0 68.0 70.0 71.0 80.0 82.0 66.0 07:54:47 INFO - 2015-11-18 07:54:47,646 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,646 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:88.50 stddev:18.78 (21.2%) stddev-sans-first:19.89 07:54:47 INFO - 2015-11-18 07:54:47,646 DEBUG : BROWSER_OUTPUT: Values: 100.0 98.0 132.0 89.0 90.0 89.0 126.0 88.0 87.0 130.0 07:54:47 INFO - 2015-11-18 07:54:47,647 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,647 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:119.50 stddev:2.98 (2.5%) stddev-sans-first:2.96 07:54:47 INFO - 2015-11-18 07:54:47,647 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 114.0 119.0 120.0 114.0 114.0 114.0 115.0 120.0 07:54:47 INFO - 2015-11-18 07:54:47,647 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,647 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.30 Median:125.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:54:47 INFO - 2015-11-18 07:54:47,647 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 126.0 125.0 125.0 126.0 126.0 125.0 125.0 125.0 07:54:47 INFO - 2015-11-18 07:54:47,647 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,648 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.50 Median:93.00 stddev:3.21 (3.4%) stddev-sans-first:3.40 07:54:47 INFO - 2015-11-18 07:54:47,648 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 100.0 93.0 93.0 92.0 101.0 93.0 93.0 93.0 07:54:47 INFO - 2015-11-18 07:54:47,648 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,650 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:3.03 (5.1%) stddev-sans-first:3.20 07:54:47 INFO - 2015-11-18 07:54:47,650 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 58.0 59.0 59.0 59.0 68.0 57.0 59.0 07:54:47 INFO - 2015-11-18 07:54:47,650 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,650 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 07:54:47 INFO - 2015-11-18 07:54:47,650 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 70.0 70.0 70.0 70.0 70.0 71.0 07:54:47 INFO - 2015-11-18 07:54:47,650 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,650 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:1.00 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 85.0 85.0 85.0 85.0 86.0 88.0 86.0 85.0 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.00 stddev:4.55 (3.6%) stddev-sans-first:4.76 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: Values: 129.0 134.0 124.0 126.0 122.0 125.0 120.0 130.0 133.0 127.0 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:153.00 stddev:4.12 (2.7%) stddev-sans-first:4.37 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: Values: 152.0 153.0 153.0 154.0 157.0 141.0 153.0 152.0 152.0 152.0 07:54:47 INFO - 2015-11-18 07:54:47,651 DEBUG : BROWSER_OUTPUT: 07:54:47 INFO - 2015-11-18 07:54:47,652 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 07:54:47 INFO - 2015-11-18 07:54:47,652 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 71.0 71.0 70.0 70.0 72.0 72.0 71.0 07:54:47 INFO - 2015-11-18 07:54:47,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:54:47 INFO - 2015-11-18 07:54:47,652 DEBUG : BROWSER_OUTPUT: 07:54:48 INFO - 2015-11-18 07:54:48,280 INFO : Browser exited with error code: 0 07:54:48 INFO - 2015-11-18 07:54:48,326 INFO : Completed test kraken (00:00:57) 07:54:48 INFO - 2015-11-18 07:54:48,327 INFO : Starting test v8_7 07:54:48 INFO - 2015-11-18 07:54:48,327 DEBUG : operating with platform_type : mac_ 07:54:48 INFO - 2015-11-18 07:54:48,327 INFO : Initialising browser for v8_7 test... 07:54:48 INFO - 2015-11-18 07:54:48,339 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/tmphA6Ykp/profile http://localhost:49253/getInfo.html 07:54:50 INFO - 2015-11-18 07:54:50,492 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:54:50 INFO - 2015-11-18 07:54:50,492 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:54:50 INFO - 2015-11-18 07:54:50,492 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:54:50 INFO - 2015-11-18 07:54:50,492 DEBUG : BROWSER_OUTPUT: __metrics 07:54:50 INFO - 2015-11-18 07:54:50,508 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:51 INFO - 2015-11-18 07:54:51,174 INFO : Browser initialized. 07:54:51 INFO - 2015-11-18 07:54:51,175 INFO : Running cycle 1/1 for v8_7 test... 07:54:51 INFO - 2015-11-18 07:54:51,175 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/T/tmphA6Ykp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:55:03 INFO - 2015-11-18 07:55:03,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 228564992 07:55:03 INFO - 2015-11-18 07:55:03,067 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49253/tests/v8_7/run.html (next: http://localhost:49253/tests/v8_7/run.html) 07:55:24 INFO - 2015-11-18 07:55:24,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 697286656 07:55:24 INFO - 2015-11-18 07:55:24,800 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,800 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:55:24 INFO - 2015-11-18 07:55:24,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:55:24 INFO - 2015-11-18 07:55:24,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:55:24 INFO - 2015-11-18 07:55:24,800 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:55:24 INFO - 2015-11-18 07:55:24,800 DEBUG : BROWSER_OUTPUT: |0;Richards;168.23687752355318 07:55:24 INFO - 2015-11-18 07:55:24,801 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.38755980861245 07:55:24 INFO - 2015-11-18 07:55:24,801 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.4149040026033 07:55:24 INFO - 2015-11-18 07:55:24,801 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5742.857142857143 07:55:24 INFO - 2015-11-18 07:55:24,801 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2109.7046413502107 07:55:24 INFO - 2015-11-18 07:55:24,801 DEBUG : BROWSER_OUTPUT: |5;Earley;903.342366757001 07:55:24 INFO - 2015-11-18 07:55:24,803 DEBUG : BROWSER_OUTPUT: |6;Boyer;13360 07:55:24 INFO - 2015-11-18 07:55:24,803 DEBUG : BROWSER_OUTPUT: |7;RegExp;30264.70588235294 07:55:24 INFO - 2015-11-18 07:55:24,803 DEBUG : BROWSER_OUTPUT: |8;Splay;647.7784932388925 07:55:24 INFO - 2015-11-18 07:55:24,803 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 07:55:24 INFO - 2015-11-18 07:55:24,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:55:24 INFO - 2015-11-18 07:55:24,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862124799__endTimestamp 07:55:24 INFO - 2015-11-18 07:55:24,804 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:55:24 INFO - 2015-11-18 07:55:24,804 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:55:24 INFO - 2015-11-18 07:55:24,804 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,804 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.24 Median:168.24 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,804 DEBUG : BROWSER_OUTPUT: Values: 168.2 07:55:24 INFO - 2015-11-18 07:55:24,805 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,805 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,805 DEBUG : BROWSER_OUTPUT: Values: 191.4 07:55:24 INFO - 2015-11-18 07:55:24,805 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,805 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.41 Median:325.41 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,805 DEBUG : BROWSER_OUTPUT: Values: 325.4 07:55:24 INFO - 2015-11-18 07:55:24,805 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5742.86 Median:5742.86 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: Values: 5742.9 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2109.70 Median:2109.70 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: Values: 2109.7 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:903.34 Median:903.34 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: Values: 903.3 07:55:24 INFO - 2015-11-18 07:55:24,806 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13360.00 Median:13360.00 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: Values: 13360.0 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30264.71 Median:30264.71 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: Values: 30264.7 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:647.78 Median:647.78 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,807 DEBUG : BROWSER_OUTPUT: Values: 647.8 07:55:24 INFO - 2015-11-18 07:55:24,808 DEBUG : BROWSER_OUTPUT: 07:55:24 INFO - 2015-11-18 07:55:24,808 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 07:55:24 INFO - 2015-11-18 07:55:24,808 DEBUG : BROWSER_OUTPUT: Values: 5803.5 07:55:24 INFO - 2015-11-18 07:55:24,808 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:55:24 INFO - 2015-11-18 07:55:24,808 DEBUG : BROWSER_OUTPUT: 07:55:25 INFO - 2015-11-18 07:55:25,459 INFO : Browser exited with error code: 0 07:55:25 INFO - 2015-11-18 07:55:25,478 INFO : Completed test v8_7 (00:00:37) 07:55:25 INFO - 2015-11-18 07:55:25,923 INFO : Completed test suite (00:20:10) 07:55:25 INFO - 2015-11-18 07:55:25,923 DEBUG : Working with test: dromaeo_css 07:55:25 INFO - 2015-11-18 07:55:25,924 DEBUG : Generating results file: dromaeo_css 07:55:25 INFO - 2015-11-18 07:55:25,924 DEBUG : Working with test: kraken 07:55:25 INFO - 2015-11-18 07:55:25,924 DEBUG : Generating results file: kraken 07:55:25 INFO - 2015-11-18 07:55:25,924 INFO : javascript benchmark 07:55:25 INFO - 2015-11-18 07:55:25,925 DEBUG : Working with test: v8_7 07:55:25 INFO - 2015-11-18 07:55:25,925 DEBUG : Generating results file: v8_7 07:55:25 INFO - 2015-11-18 07:55:25,925 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:55:25 INFO - 2015-11-18 07:55:25,980 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 07:55:25 INFO - 2015-11-18 07:55:25,981 DEBUG : process_Request line: dromaeo_css 6595.03 graph.html#tests=[[72,63,55]] 07:55:25 INFO - 2015-11-18 07:55:25,981 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:55:26 INFO - 2015-11-18 07:55:26,009 DEBUG : process_Request line: kraken 1495.90 graph.html#tests=[[232,63,55]] 07:55:26 INFO - 2015-11-18 07:55:26,009 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:55:26 INFO - 2015-11-18 07:55:26,038 DEBUG : process_Request line: v8_7 18008.67 graph.html#tests=[[230,63,55]] 07:55:26 INFO - 2015-11-18 07:55:26,039 INFO : javascript benchmark 07:55:26 INFO - 2015-11-18 07:55:26,041 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3079.122450101721, 3185.936281274373, 3211.646718860925, 3230.6607806180336, 3240.465323221669, 5174.586033117351, 5263.921041184385, 5313.495217954293, 5406.648567843093, 5479.095949168387, 5306.867328316794, 5312.442193569677, 5317.096093664077, 5349.090654588719, 5356.785728570862, 4887.437944636359, 4893.094777466163, 4951.158303088475, 4961.08219979305, 4963.528464795857, 4927.1870141426625, 5021.723805190713, 5059.544640982311, 5073.315102461157, 5100.719460429675, 5002.399712034543, 5022.146235140017, 5047.722375269359, 5050.368703912011, 5063.898722025558, 533.2280778840675, 4672.929906051412, 4890.902181956341, 4946.851594452136, 4985.750712464399, 4843.9515604843855, 4930.728809915453, 4932.827351042696, 4939.851804445872, 4965.801367945278, 5170.302009228743, 5170.948290517084, 5172.508611681922, 5213.895722085575, 5272.815451459181, 5380.381256155514, 5480.479354461319, 5522.944770552283, 5602.719864006784, 5625.0, 5635.520980716644, 5652.265205523297, 5655.604107712462, 5685.971570142165, 5694.914576281359, 5300.1519756838725, 5307.734613269321, 5340.225667278261, 5347.25138480613, 5352.357717073898, 5473.28847249863, 5539.058360078796, 5547.278853748987, 5713.742881570256, 5756.453136951983, 5409.972950135303, 5466.535344495683, 5502.504774570308, 5537.058700021006, 5547.362053363915, 5637.492625663628, 5639.154126880919, 5639.238702775155, 5677.63095398806, 5707.800226992118, 5425.755840987165, 5483.616146869681, 5484.0, 5537.501624853702, 5558.055130627722, 5482.533984611273, 5561.304836895388, 5602.747876345574, 5615.578831587647, 5634.943650563524, 4431.091626216617, 4445.199864024442, 4459.643228541709, 4476.664250181249, 4496.797644106023, 3920.5295364556437, 4006.198760247904, 4050.41269015991, 4067.1255680028344, 4102.815373308149, 5169.612279079084, 5205.323307970016, 5225.712585807817, 5273.947260527422, 5281.894362112736, 5605.5795815313195, 5686.829395118153, 5693.174489699053, 5731.254936858265, 5741.88516229673, 5097.592192624581, 5225.0, 5235.39792923811, 5293.391260005072, 5356.651817631841, 4888.584470320063, 4989.600831933437, 4999.200127979506, 5004.774785134678, 5068.290439338495, 5761.423857614289, 5777.046787280052, 5816.389279125716, 5834.124881267844, 5872.970635146797, 5605.0, 5632.127020311858, 5650.208970744017, 5697.145428185805, 5717.3996730342715, 5602.85992850182, 5759.769609215752, 5767.134929760569, 5771.105478650816, 5819.76720931175, 5429.18562215655, 5458.4541545845095, 5487.067198576172, 5554.888902222014, 5600.439956004367, 5640.830775076754, 5653.406392328746, 5668.26312579362, 5669.206311116364, 5689.260396148474, 5269.077911365419, 5348.6523375982, 5510.586705997146, 5526.198701188225, 5570.359408668055, 5475.780968761205, 5488.0, 5491.862703432446, 5568.276124103841, 5573.1918871762555, 5420.864478388072, 5426.077566813572, 5439.401665816836, 5471.2887324647545, 5503.449655034625, 5550.694711790728, 5573.108302671553, 5599.636023658449, 5603.467670571289, 5613.298337707786, 5289.233061206027, 5411.864703382447, 5459.808906688406, 5502.422245664147, 5521.2270282161335], "unit": "ms", "name": "dojo.html", "value": 5200.246745070084}, {"lowerIsBetter": false, "replicates": [551.748954225827, 557.111407305348, 565.0619970848393, 568.1534513574774, 573.3377948469516, 31105.06684799454, 31792.20519487014, 38100.80949595248, 38926.80536597313, 38941.805290973505, 42207.0, 42635.0, 42809.78595107028, 42840.0, 42846.14307713844, 8200.630971606262, 9181.862272065924, 9350.906490935105, 9360.391574547666, 9361.017093205217, 8321.791955201108, 8431.873521897176, 8432.0, 8432.198941100585, 8449.23956843884, 11137.276077054965, 11296.322220666745, 11308.773824523505, 11311.0, 11341.943290283538, 10952.233343665946, 11018.669439916815, 11045.226834121615, 11066.0, 11117.777644447066, 8413.326933845277, 8553.101924297922, 10816.188785841015, 10943.06983906369, 10990.890091099067, 39055.0, 39491.0, 39533.20933581341, 39549.60450395488, 39574.80212598918, 2951.011411177258, 3014.593029940952, 3054.266975925784, 3197.6642452542383, 3439.8968030959113, 27504.862475687492, 27551.173464796088, 27826.0, 27830.0, 28213.858930705213, 2306.215886598548, 2323.047550504302, 2360.1739391212936, 2368.9881550592136, 2485.6644353012475, 284394.0, 286435.56782216165, 286608.0, 286647.0, 287002.0, 58232.708836455546, 58578.414215858145, 58597.0, 58739.118913216334, 58813.41186588165, 62540.0, 62688.37311626917, 62780.0, 62849.0, 62868.68565657234, 16651.333946642, 17174.33797761349, 17194.31222751076, 17196.31214751421, 17218.827811721723, 12904.93547532275, 13005.804912926315, 13012.804807927889, 13059.020573457028, 13093.083484156208, 18606.06119874448, 19182.232710691416, 19214.13536390866, 19238.422847314603, 19274.518137046685, 7995.920040799634, 8223.712170074139, 8231.711890083818, 8233.8353232935, 8248.370716884672, 944.2210176604328, 1023.8259495885568, 1129.3788416370962, 1145.8854114588642, 1167.206299716201, 27953.0, 28385.148445546667, 28565.0, 28917.710822891502, 28937.85531072373, 929.3958926697701, 1010.8180527505119, 1036.5853658536646, 1048.5411709541265, 1062.866355502919, 13897.444102235797, 13962.232077235849, 14017.439302427993, 14024.789628155382, 14095.436182552789, 345234.0, 346417.0, 351125.0, 351860.0, 352243.0, 44291.778541107735, 44990.775046125214, 44996.55003449923, 50602.74698626557, 51872.221916670525, 1338.5248236875768, 1359.7348517039081, 1362.50949658123, 1377.9724405512034, 1394.0450791208054, 25957.870210648827, 26004.0, 26067.869660651577, 26138.0, 27147.321316967234, 42814.0, 43524.12951741011, 51347.48652513576, 52850.471495286096, 52931.470685294196, 198477.0, 202991.0, 203000.0, 203144.0, 203381.0, 30013.69986300109, 30407.847960760053, 30421.543676844423, 30433.0, 30439.239019023815, 38662.22675546417, 39059.218815624095, 39327.41008884812, 39540.80229598949, 39941.2011759769, 33823.49264760981, 33910.15224619404, 34212.31575368528, 34428.3521724564, 34447.4832877512, 33793.15517112092, 34417.31165376728, 34418.48372274368, 34715.30569388548, 34723.0, 34720.82639586786, 34814.0, 35071.47392789059, 35247.29505409929, 35324.82337588296, 30345.848270758506, 30485.54271685971, 30500.694993049787, 30503.389932201677, 30552.236194094436, 23263.76736232684, 23522.882385587964, 23584.764152358257, 23999.0, 24518.264452066465], "unit": "ms", "name": "ext.html", "value": 18183.022948901962}, {"lowerIsBetter": false, "replicates": [333.24187473497807, 334.29630627529053, 334.50994293360225, 337.50386931211114, 338.17822690861203, 14282.571522854305, 14696.779548306784, 17093.145342732874, 17177.914110429447, 18060.367887123968, 14237.786433203484, 15608.219589020531, 17931.82068179318, 18159.909200453978, 19016.809831901675, 5520.779168833242, 5664.490195882369, 5665.971670141644, 5670.4896559309655, 5682.7442765075675, 4026.516817981846, 4153.02403935075, 4764.499727528611, 6105.481034112106, 6118.235220597426, 5883.382244864292, 6003.969980150093, 6053.818385448421, 6061.727222274986, 6062.151298818169, 5633.690147041891, 5652.434756524356, 5659.60382773206, 5660.85847853807, 6025.186599809035, 5239.266502689627, 5321.547668448186, 5325.094733895247, 5332.200169974496, 5335.733213339317, 16156.676866462605, 16193.59516012109, 21125.3662390127, 21537.353879383645, 21800.89099554508, 2060.464279287381, 2197.165077270643, 2379.1553998330514, 2545.1219329331534, 2691.3944362518278, 13114.672133196651, 13406.731865362735, 13414.128081674757, 13706.862931370659, 13745.24401157936, 1665.192381694877, 1684.2084220416384, 1696.3723422333692, 1742.5992021834923, 1750.711132663109, 55496.72251638756, 56020.71989640067, 56478.717606412116, 56770.716146419414, 56811.0, 9502.714918552454, 9649.0, 9825.263105267133, 9828.852567211497, 9899.208063354914, 12160.878391215974, 12166.81749773754, 12175.0868684849, 12180.57367992116, 12194.39028048594, 5248.9737551312, 5295.073362161684, 5346.759395827119, 5438.0, 7889.250521200477, 5675.914861277084, 5695.8860822784145, 5723.422696434502, 5747.770089196469, 5798.420157984252, 2886.581445690405, 2921.7954743167775, 2933.398653276073, 2936.295289130636, 2946.8231906085703, 984.0651381187901, 1017.2116609627598, 1052.4211683574003, 1073.1790180511914, 1080.0873262093519, 424.35074336265563, 425.7126439653222, 440.87655456472237, 442.78967490441784, 460.8916904527433, 10434.321769084985, 11177.273477223955, 11335.263207891461, 11743.11926605508, 11916.702082447835, 410.5483967635577, 454.20967516521677, 455.78350283615015, 463.5063657205066, 480.4474853918022, 5953.22608060958, 6142.477889379453, 6388.7125079371535, 6422.42198202164, 6423.068655044993, 547164.0, 553622.0, 555282.0, 557648.0, 558914.0, 66005.66997164984, 67417.32582674209, 67596.93023023194, 67605.66197168983, 67802.66098669475, 501.490986648552, 503.92693059506166, 506.8099462701487, 507.9517445842639, 508.0271280497805, 10693.786124277627, 10867.402292873969, 10970.506327215135, 11014.284071535645, 11038.337699738042, 32218.516722249653, 32763.836180818944, 32856.83571582127, 33031.50452743259, 33650.66349336475, 41615.0, 44450.333245001995, 45239.0, 45330.773346134374, 46204.0, 6067.878642427215, 6145.139680444652, 6215.06773983888, 6260.718267678057, 6265.15420418256, 11534.94232528832, 11676.241044332091, 11769.47037383337, 11775.646730598095, 11782.293062416282, 9903.752406189615, 9987.750306242402, 10164.288499805238, 10202.846957295795, 10333.586656533655, 9688.854667179858, 9704.563294651898, 9825.361351512129, 9899.307048506535, 10220.02909723575, 10212.846807298045, 10237.129843963048, 10377.792444151226, 10381.429021403896, 10506.054455099078, 6129.448349648553, 6136.539759518143, 6139.4781443577795, 6140.907886381798, 6226.40849119333, 9940.502974851373, 10001.799964000826, 10038.749031274276, 10122.291439599452, 10291.794164116825], "unit": "ms", "name": "jquery.html", "value": 7189.2534657229635}, {"lowerIsBetter": false, "replicates": [1284.9357532123393, 1472.852714728527, 1538.6845696632192, 1685.511201751492, 1818.1000404799618, 6619.238787539434, 6889.896651550224, 7109.644517774103, 7317.817054573638, 7326.633668316589, 7041.718331266756, 7211.7836464906, 7226.096737907762, 7226.963865180666, 7277.6725047372865, 1849.2972670385234, 1891.3947536788164, 2074.71991281177, 2096.821770149539, 2096.937091887246, 2091.44576687178, 2113.0596884386455, 2118.5233322502468, 2134.6691262854283, 2146.2809958663865, 2048.7439070116234, 2078.948026299347, 2094.675325324577, 2098.202682980473, 2121.4378189779723, 1799.3792141711153, 1844.3452574336052, 2045.3966080006435, 2069.4722845674332, 2101.5796840631783, 2087.7077209190725, 2112.86266392684, 2127.659574468093, 2133.5306232628795, 2143.110609097223, 7251.5286506376915, 7252.129744430702, 7335.376492998102, 7349.853002939964, 7362.153352364493, 4298.570142985708, 4349.956500435019, 4382.868513944587, 4387.16643837673, 4388.648908087345, 2764.14311563416, 2791.330080780618, 2820.4218135282217, 2825.717428257178, 2871.770258379325, 913.2100732866023, 941.0965473145789, 943.7499062748377, 966.5360626899057, 975.4634950777045, 9431.0, 9537.046295370477, 9538.9523052385, 9560.139587437094, 9564.66523671668, 3846.4614953905916, 3893.5911729268587, 3901.902452438655, 3926.6662333701956, 3979.303621866162, 8256.463329883538, 8350.707725229588, 8353.665853365797, 8358.83282334362, 8365.0, 4451.132029254264, 4458.799354029076, 4461.7992190351515, 4461.955380446219, 4463.352813841975, 4071.226466971266, 4115.1975364804175, 4126.277901367249, 4126.66986641068, 4137.855175068858, 3298.6371499135075, 3355.0, 3422.281320922584, 3423.657634236606, 3430.485427185892, 1065.1265961911158, 1080.7460246841986, 1102.3165637304921, 1105.165599972016, 1114.5207560748793, 1272.5864094169433, 1290.5741105435184, 1310.541310541303, 1326.1711430356027, 1330.9134906231257, 6812.216595091529, 7116.964415177891, 7120.537165084253, 7128.180259270147, 7140.07179066718, 1130.4347826086957, 1140.5836869542557, 1144.4506636814376, 1157.2767020612118, 1166.125405945541, 5500.669959802344, 5512.2558454608115, 5557.944420555743, 5565.193047008162, 5575.107982722826, 8464.0, 8492.278156356655, 8697.521636309937, 8707.172818582225, 8754.69358572447, 8530.488170709777, 8532.658693652184, 8559.186877246651, 8594.828103438022, 8619.1811777881, 6612.801615951529, 6712.597244165366, 6781.898271525931, 6796.150481189851, 6844.589324640637, 6538.084668146558, 6539.967300163659, 6543.70553325111, 6546.116274302908, 6564.573302735307, 7278.053852999076, 7490.588017659081, 7499.362554182955, 7534.962325188339, 7579.5073320234005, 7485.588292643739, 7507.1607456171405, 7616.581088040211, 7627.694892204249, 7761.805954851174, 6102.328743838263, 6104.6642434664745, 6144.754209831557, 6188.257409110935, 6196.0705894116245, 6592.901106483502, 6742.0, 6747.257801641914, 6754.020667003355, 6766.120404347404, 6179.969100154471, 6331.746730130927, 6346.333634968262, 6370.936290637034, 6417.101605775289, 5726.341470730919, 5804.593678442468, 5957.91063134062, 6192.783252586138, 6365.586236894587, 6509.772157974448, 6560.639164845979, 6635.701393437211, 6635.966820165868, 6640.136782218281, 5725.08398656213, 5763.9135412968, 5802.709864506842, 5815.2149459822385, 5826.82519524415, 6097.451229389376, 6142.570020098729, 6169.0, 6171.444569988723, 6181.783637572664], "unit": "ms", "name": "mootools.html", "value": 4170.539418588393}, {"lowerIsBetter": false, "replicates": [308.60344457372275, 317.1785076651472, 317.5078628126403, 317.7839069432786, 319.3612774451098, 6121.540884433669, 6128.6322820630685, 6318.968405157973, 6325.493960483162, 6337.36626337366, 6042.8489287767825, 6155.722992465338, 6256.84357891053, 6273.52948528861, 6316.336784637604, 4869.074875773609, 4888.73111978841, 4926.18717911546, 4931.630127740415, 4952.653314268003, 4689.7655117244, 4775.856724298259, 4819.0, 4840.806367745286, 4940.827071052514, 4681.204195286809, 4705.811767529295, 4786.760661966905, 4814.085323788487, 4829.492903245161, 4743.881402964919, 4758.262469317261, 4844.806207751686, 4848.17581011229, 4859.854204373839, 4125.133721918401, 4146.834126634961, 4164.979175104136, 4178.811953462102, 4191.287481128215, 5830.533557315404, 6016.0, 6027.397260273981, 6035.879282414371, 6121.908171377433, 5280.894382112375, 5302.708351040691, 5355.196720491957, 5368.489993450616, 5369.677819330853, 6158.137860699506, 6428.389303016206, 6540.084388185658, 6577.0, 6588.670566471657, 4226.682998775073, 4300.978495107535, 4323.4163387942535, 4353.521112677603, 4355.738655680638, 6829.93170068298, 6834.179898412172, 6844.28135045823, 6891.241963384024, 6899.0341352210735, 4403.383526306319, 4413.1394378095965, 4420.8673739787855, 4451.354553589711, 4490.977545112253, 4390.07808360248, 4468.754218518013, 4515.14212299662, 4542.931856022163, 4544.931826022612, 5263.289455923401, 5268.894622107537, 5269.657472264291, 5325.147976323769, 5347.438518955453, 6490.188726409199, 6508.926027205458, 6523.7064332105165, 6531.673416329165, 6552.049952756919, 1575.322611277139, 1583.3429126912433, 1585.191552308331, 1590.9738218848777, 1606.1567676969685, 1000.4997501249376, 1017.7404761785697, 1022.6471867205802, 1027.3476342522551, 1048.5596049659162, 6060.939390606126, 6130.080487926846, 6173.81478555644, 6205.410486003822, 6209.223847019122, 6746.460283177334, 6771.052052712625, 6787.117674702257, 6789.796306110825, 6798.320167983261, 6052.284335636446, 6111.113888486145, 6185.907211391833, 6195.19462469876, 6198.0, 3629.256002519477, 3632.1282892105705, 3646.3801153803915, 3682.6869716073898, 3688.55737311519, 6846.5892046477375, 6853.246142924274, 6942.062821519131, 6973.51185417026, 6973.895391569131, 6856.725730970706, 6874.553154044971, 6878.037074809531, 6925.995730619032, 6941.375276225164, 7068.798304288283, 7072.115985501812, 7139.643017849191, 7160.248173941661, 7174.784756457315, 6581.3418658133805, 6652.966735166487, 6720.798376048726, 6776.390124888783, 6847.760328388483, 6663.5002374821115, 6717.832054198684, 6747.291534388818, 6769.796906092825, 6804.081449004519, 7048.083749112582, 7058.0, 7132.215456299699, 7154.642267886481, 7156.821079473055, 4309.806058727428, 4477.597016268422, 4486.977565112154, 4501.842435514741, 4557.111363284261, 6772.11962444879, 6784.559003664746, 6803.557768745016, 6863.965680171567, 6894.517383783087, 6554.934450655624, 6561.40947314744, 6606.174228221473, 6610.8347291318105, 6619.867602647823, 6400.135981642418, 6513.674316284072, 6532.020196970492, 6578.572392794645, 6625.933740662532, 6363.204599425072, 6374.203224596926, 6405.711742971671, 6458.483321334376, 6479.0, 6362.713677884413, 6571.441427478718, 6572.572782769104, 6602.570832895846, 6626.83432914181, 6426.742930282923, 6431.099646049651, 6501.0, 6503.0, 6528.21661400635], "unit": "ms", "name": "prototype.html", "value": 4898.4941175957}, {"lowerIsBetter": false, "replicates": [676.8071099736576, 702.599518274583, 705.6224919667977, 758.4766511107335, 781.3788038509383, 11961.940190299058, 14279.857201427996, 14448.06087604305, 14495.49265775698, 14528.63678408039, 12985.0, 13058.151220170683, 13066.477340906376, 13072.150310229828, 13086.0, 690.0684076496715, 691.9031335613018, 853.6884037326362, 883.1609970527992, 883.6465413834453, 888.1961824548762, 901.5537309032038, 902.1204325782343, 904.2404380320529, 909.0, 936.8501039833628, 945.394947233771, 946.1059298962483, 946.1768261612373, 961.1301771896445, 742.4988133010196, 742.617551960738, 921.7833809054866, 924.3668087360113, 927.3554879358849, 693.9132608423947, 694.0179645801185, 694.2120693013466, 701.8350687588413, 713.1228588835709, 12515.123941324111, 12637.115401921868, 12651.367431628381, 12663.873361266362, 12696.238225706395, 10837.349759014485, 10984.835227471594, 11065.557377704883, 11137.665870023913, 11241.550337986471, 8417.873731894026, 8744.256738177262, 9383.061693830563, 9469.289803264714, 9744.951275243578, 3353.3293341331832, 3362.1090411041096, 3380.5436266104252, 3385.6783605557434, 3404.3021180657906, 46930.76534617339, 47267.29099063517, 47286.29070563944, 47336.0, 47406.0, 8758.12418758119, 8801.955990220007, 8934.28525717941, 8939.642414303486, 9366.344355895159, 17924.28302867897, 18013.0, 18049.368272110412, 18055.097245137953, 18072.0, 6967.059446974695, 7065.0815393998455, 7111.715531378791, 7224.277572242734, 7293.124825021031, 3807.314683357022, 3823.2926908522013, 3823.6749876260274, 3985.3623420253202, 3992.6207010333974, 3198.296374797541, 3240.238543942172, 3276.19733165376, 3286.063471910494, 3286.8192249426033, 432.23062947952695, 437.0864892374952, 448.5424866636013, 453.4354728363209, 453.75043725950593, 542.5740793477102, 586.8708884045503, 591.3967752892027, 602.9909551356645, 614.8467104707671, 7513.737019204302, 7664.233576642291, 7878.448508604457, 7959.44283900133, 8312.168783121639, 454.8408057180027, 575.9683217423081, 609.5093449772976, 610.1701685707434, 664.8936170212743, 3459.4810778383444, 3507.877224297137, 3636.5272514572935, 3757.605451427615, 3833.5974722654278, 55472.6131846699, 55983.0, 56132.158017629765, 56342.71828640831, 56390.436095639336, 48564.0, 49771.0, 49909.50090499121, 49985.0, 50198.24702629464, 44271.557284427385, 44997.55002449934, 45564.544354556696, 45912.54087459216, 46129.308060379124, 7644.273793989562, 7675.078990521173, 7703.768886933401, 7717.768466946, 7842.647080881488, 33915.66084339224, 34065.31869362648, 34430.0, 34540.0, 35577.644223557436, 42780.78609606932, 44505.77747111244, 44801.10397791961, 44938.77530612457, 45047.17099046618, 6820.522563420513, 7011.6494175292055, 7079.0, 7122.394596459359, 7333.559986400833, 10418.426986515511, 10533.42066186367, 10656.680299591024, 11042.17183711241, 11092.556297748322, 10116.443595602312, 10141.847872281774, 10143.239257055899, 10251.897481025393, 10267.435291058764, 10174.745631359276, 10469.057784799405, 10630.893691062991, 10641.414722190353, 10932.453377331261, 10104.595816167272, 10247.692569222936, 10279.17766578657, 10318.0, 10365.585376584851, 8619.1811777881, 8665.653373865227, 8705.651773928972, 8929.05341237403, 9068.22920051803, 8166.673333066611, 8267.793305167179, 8470.407071504935, 8487.108853570286, 8596.828063438821], "unit": "ms", "name": "yui.html", "value": 5924.2685521065305}], "name": "dromaeo_css", "value": 6595.033861868597}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 108.0, 109.0, 109.0, 101.0, 110.0, 113.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 151.0, 166.0, 128.0, 148.0, 147.0, 126.0, 167.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [75.0, 82.0, 88.0, 86.0, 68.0, 70.0, 71.0, 80.0, 82.0, 66.0], "unit": "ms", "name": "audio-fft", "value": 76.8}, {"lowerIsBetter": true, "replicates": [100.0, 98.0, 132.0, 89.0, 90.0, 89.0, 126.0, 88.0, 87.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 102.9}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 114.0, 119.0, 120.0, 114.0, 114.0, 114.0, 115.0, 120.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 126.0, 125.0, 125.0, 126.0, 126.0, 125.0, 125.0, 125.0], "unit": "ms", "name": "imaging-darkroom", "value": 125.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 100.0, 93.0, 93.0, 92.0, 101.0, 93.0, 93.0, 93.0], "unit": "ms", "name": "imaging-desaturate", "value": 94.5}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 68.0, 57.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 85.0, 85.0, 85.0, 85.0, 86.0, 88.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [129.0, 134.0, 124.0, 126.0, 122.0, 125.0, 120.0, 130.0, 133.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [152.0, 153.0, 153.0, 154.0, 157.0, 141.0, 153.0, 152.0, 152.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 71.0, 71.0, 70.0, 70.0, 72.0, 72.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1495.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.23687752355318], "unit": "score", "name": "Richards", "value": 209.83508800000004}, {"lowerIsBetter": false, "replicates": [191.38755980861245], "unit": "score", "name": "DeltaBlue", "value": 345.4665499999999}, {"lowerIsBetter": false, "replicates": [325.4149040026033], "unit": "score", "name": "Encrypt", "value": 817.9742130000002}, {"lowerIsBetter": false, "replicates": [5742.857142857143], "unit": "score", "name": "Decrypt", "value": 46.349925373134326}, {"lowerIsBetter": false, "replicates": [2109.7046413502107], "unit": "score", "name": "RayTrace", "value": 350.7547860000002}, {"lowerIsBetter": false, "replicates": [903.342366757001], "unit": "score", "name": "Earley", "value": 737.7745410000001}, {"lowerIsBetter": false, "replicates": [13360.0], "unit": "score", "name": "Boyer", "value": 49.88495508982038}, {"lowerIsBetter": false, "replicates": [30264.70588235294], "unit": "score", "name": "RegExp", "value": 30.100573372206025}, {"lowerIsBetter": false, "replicates": [647.7784932388925], "unit": "score", "name": "Splay", "value": 125.80071868787279}, {"lowerIsBetter": false, "replicates": [5803.468208092486], "unit": "score", "name": "NavierStokes", "value": 255.70916334661337}], "name": "v8_7", "value": 18008.674151925545}]} 07:55:26 INFO - RETURN: dromaeo_css: 6595.03 07:55:26 INFO - RETURN: kraken: 1495.90 07:55:26 INFO - RETURN: v8_7: 18008.67 07:55:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "18008.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1495.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "6595.03"}}} 07:55:26 INFO - Return code: 0 07:55:26 INFO - # TBPL SUCCESS # 07:55:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:26 INFO - 2015-11-18 07:55:26.149 screenresolution[1654:9913] starting screenresolution argv=screenresolution get 07:55:26 INFO - 2015-11-18 07:55:26.153 screenresolution[1654:9913] Display 0: 1600x1200x32@60 07:55:26 INFO - 2015-11-18 07:55:26.159 screenresolution[1655:9916] starting screenresolution argv=screenresolution list 07:55:26 INFO - Available Modes on Display 0 07:55:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:26 INFO - Intel HD Graphics 3000: 07:55:26 INFO - Chipset Model: Intel HD Graphics 3000 07:55:26 INFO - Type: GPU 07:55:26 INFO - Bus: Built-In 07:55:26 INFO - VRAM (Total): 512 MB 07:55:26 INFO - VRAM (Dynamic, Max): 10 07:55:26 INFO - Vendor: Intel (0x8086) 07:55:26 INFO - Device ID: 0x0116 07:55:26 INFO - Revision ID: 0x0009 07:55:26 INFO - Displays: 07:55:26 INFO - Display: 07:55:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:26 INFO - Display Serial Number: 1600x1200 60 07:55:26 INFO - Main Display: Yes 07:55:26 INFO - Mirror: Off 07:55:26 INFO - Online: Yes 07:55:26 INFO - Rotation: Supported 07:55:26 INFO - Return code: 0 07:55:26 INFO - Running post-action listener: _resource_record_post_action 07:55:26 INFO - Running post-run listener: _resource_record_post_run 07:55:27 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 38544384; Write bytes: 684846080; Read time: 4985; Write time: 72796 07:55:27 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 342919680; Write bytes: 344545280; Read time: 33537; Write time: 5264 07:55:27 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 36471808; Write bytes: 338437120; Read time: 4418; Write time: 67270 07:55:27 INFO - Running post-run listener: _upload_blobber_files 07:55:27 INFO - Blob upload gear active. 07:55:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:55:27 INFO - Copying logs to upload dir... 07:55:27 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1326.305939 ========= master_lag: 2.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-18 07:55:29.962355) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:29.965802) ========= 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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010220 build_url: 'https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.03 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:30.001486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:30.002263) ========= 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.RKBFV9i6KP/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.gIQcPDgvvg/Listeners TMPDIR=/var/folders/1c/td_x4v897hjb9tp0xwkxvnym00000w/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.005278 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:30.053913) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:55:30.054463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:55:30.055198) ========= ========= Total master_lag: 2.93 =========