builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1448371762.52 results: success (0) buildid: 20151124030554 builduid: 36a9e66d186840abb728eb130731057a revision: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.523277) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.523668) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.523939) ========= 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.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005506 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.543517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.543811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.557967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.558319) ========= 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.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.606045) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.606351) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.606691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.606957) ========= 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.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-24 05:29:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.1M=0.001s 2015-11-24 05:29:22 (21.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.810509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.810839) ========= 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.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.018560 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:22.859269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 05:29:22.859625) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c7500d7c6de994c6263912a0a558b3b9c3308c2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2c7500d7c6de994c6263912a0a558b3b9c3308c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-24 05:29:22,937 truncating revision to first 12 chars 2015-11-24 05:29:22,937 Setting DEBUG logging. 2015-11-24 05:29:22,937 attempt 1/10 2015-11-24 05:29:22,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c7500d7c6de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 05:29:24,099 unpacking tar archive at: fx-team-2c7500d7c6de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.396672 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 05:29:24.270381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:24.270742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:24.281563) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:24.281935) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:29:24.282408) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-24 05:29:24.282770) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:29:24 INFO - MultiFileLogger online at 20151124 05:29:24 in /builds/slave/test 05:29:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:29:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:24 INFO - {'append_to_log': False, 05:29:24 INFO - 'base_work_dir': '/builds/slave/test', 05:29:24 INFO - 'blob_upload_branch': 'Fx-Team', 05:29:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:24 INFO - 'branch': 'Fx-Team', 05:29:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:24 INFO - 'config_files': ('talos/mac_config.py',), 05:29:24 INFO - 'default_actions': ('clobber', 05:29:24 INFO - 'read-buildbot-config', 05:29:24 INFO - 'download-and-extract', 05:29:24 INFO - 'populate-webroot', 05:29:24 INFO - 'create-virtualenv', 05:29:24 INFO - 'install', 05:29:24 INFO - 'run-tests'), 05:29:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:24 INFO - 'download_minidump_stackwalk': True, 05:29:24 INFO - 'download_symbols': 'ondemand', 05:29:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:24 INFO - 'installer_path': 'installer.exe', 05:29:24 INFO - 'log_level': 'info', 05:29:24 INFO - 'log_name': 'talos', 05:29:24 INFO - 'log_to_console': True, 05:29:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:24 INFO - 'opt_config_files': (), 05:29:24 INFO - 'pip_index': False, 05:29:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:24 INFO - 'cmd': ('bash', 05:29:24 INFO - '-c', 05:29:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:24 INFO - 'enabled': True, 05:29:24 INFO - 'halt_on_failure': False, 05:29:24 INFO - 'name': 'check_screen_resolution'},), 05:29:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:24 INFO - 'cmd': ('bash', 05:29:24 INFO - '-c', 05:29:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:24 INFO - 'enabled': True, 05:29:24 INFO - 'halt_on_failure': False, 05:29:24 INFO - 'name': 'check_screen_resolution'},), 05:29:24 INFO - 'run_cmd_checks_enabled': True, 05:29:24 INFO - 'sps_profile': False, 05:29:24 INFO - 'sps_profile_interval': 0, 05:29:24 INFO - 'suite': 'dromaeojs-e10s', 05:29:24 INFO - 'system_bits': '64', 05:29:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:24 INFO - 'title': 't-yosemite-r7-0018', 05:29:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:24 INFO - 'use_talos_json': True, 05:29:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:24 INFO - 'work_dir': 'build'} 05:29:24 INFO - ##### 05:29:24 INFO - ##### Running clobber step. 05:29:24 INFO - ##### 05:29:24 INFO - Running pre-action listener: _resource_record_pre_action 05:29:24 INFO - Running main action method: clobber 05:29:24 INFO - rmtree: /builds/slave/test/build 05:29:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:25 INFO - Running post-action listener: _resource_record_post_action 05:29:25 INFO - ##### 05:29:25 INFO - ##### Running read-buildbot-config step. 05:29:25 INFO - ##### 05:29:25 INFO - Running pre-action listener: _resource_record_pre_action 05:29:25 INFO - Running main action method: read_buildbot_config 05:29:25 INFO - Using buildbot properties: 05:29:25 INFO - { 05:29:25 INFO - "properties": { 05:29:25 INFO - "buildnumber": 26, 05:29:25 INFO - "product": "firefox", 05:29:25 INFO - "script_repo_revision": "production", 05:29:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:29:25 INFO - "repository": "", 05:29:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:29:25 INFO - "buildid": "20151124030554", 05:29:25 INFO - "slavename": "t-yosemite-r7-0018", 05:29:25 INFO - "pgo_build": "False", 05:29:25 INFO - "basedir": "/builds/slave/test", 05:29:25 INFO - "project": "", 05:29:25 INFO - "platform": "yosemite_r7", 05:29:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:29:25 INFO - "slavebuilddir": "test", 05:29:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:29:25 INFO - "branch": "fx-team", 05:29:25 INFO - "repo_path": "integration/fx-team", 05:29:25 INFO - "stage_platform": "macosx64", 05:29:25 INFO - "builduid": "36a9e66d186840abb728eb130731057a", 05:29:25 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 05:29:25 INFO - }, 05:29:25 INFO - "sourcestamp": { 05:29:25 INFO - "repository": "", 05:29:25 INFO - "hasPatch": false, 05:29:25 INFO - "project": "", 05:29:25 INFO - "branch": "fx-team-macosx64-talos", 05:29:25 INFO - "changes": [ 05:29:25 INFO - { 05:29:25 INFO - "category": null, 05:29:25 INFO - "files": [ 05:29:25 INFO - { 05:29:25 INFO - "url": null, 05:29:25 INFO - "name": "https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:29:25 INFO - } 05:29:25 INFO - ], 05:29:25 INFO - "repository": "", 05:29:25 INFO - "rev": "2c7500d7c6de994c6263912a0a558b3b9c3308c2", 05:29:25 INFO - "who": "mratcliffe@mozilla.com", 05:29:25 INFO - "when": 1448369348, 05:29:25 INFO - "number": 6700000, 05:29:25 INFO - "comments": "Bug 1225289 - Make eslint plugin code conform to .eslintrc r=pbrosset\n\nAdded use strict statements now that we are no longer set up for ES6 modules.", 05:29:25 INFO - "project": "", 05:29:25 INFO - "at": "Tue 24 Nov 2015 04:49:08", 05:29:25 INFO - "branch": "fx-team-macosx64-talos", 05:29:25 INFO - "revlink": "", 05:29:25 INFO - "properties": [ 05:29:25 INFO - [ 05:29:25 INFO - "buildid", 05:29:25 INFO - "20151124030554", 05:29:25 INFO - "Change" 05:29:25 INFO - ], 05:29:25 INFO - [ 05:29:25 INFO - "builduid", 05:29:25 INFO - "36a9e66d186840abb728eb130731057a", 05:29:25 INFO - "Change" 05:29:25 INFO - ], 05:29:25 INFO - [ 05:29:25 INFO - "pgo_build", 05:29:25 INFO - "False", 05:29:25 INFO - "Change" 05:29:25 INFO - ] 05:29:25 INFO - ], 05:29:25 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 05:29:25 INFO - } 05:29:25 INFO - ], 05:29:25 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 05:29:25 INFO - } 05:29:25 INFO - } 05:29:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:29:25 INFO - Running post-action listener: _resource_record_post_action 05:29:25 INFO - ##### 05:29:25 INFO - ##### Running download-and-extract step. 05:29:25 INFO - ##### 05:29:25 INFO - Running pre-action listener: _resource_record_pre_action 05:29:25 INFO - Running main action method: download_and_extract 05:29:25 INFO - mkdir: /builds/slave/test/build/tests 05:29: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')]} 05:29:25 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:29:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json 05:29:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json 05:29:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:29:26 INFO - Downloaded 1149 bytes. 05:29:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:29:26 INFO - Using the following test package requirements: 05:29:26 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:26 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:29:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:26 INFO - u'jsshell-mac.zip'], 05:29:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:26 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:29:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:26 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:29:26 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:26 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:29:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:26 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:29:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:26 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:29:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:29:26 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')]} 05:29:26 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:29:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:29:27 INFO - Downloaded 17526959 bytes. 05:29:27 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 05:29:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:29:30 INFO - Return code: 0 05:29:30 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 05:29:30 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')]} 05:29:30 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:29:31 INFO - Downloaded 17526959 bytes. 05:29:31 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 05:29:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:29:34 INFO - Return code: 0 05:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:34 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:29:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:29:35 INFO - Downloaded 11130997 bytes. 05:29:35 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 05:29:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:29:35 INFO - Return code: 0 05:29: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')]} 05:29:35 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:29:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:29:38 INFO - Downloaded 109910450 bytes. 05:29:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:38 INFO - mkdir: /builds/slave/test/properties 05:29:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:38 INFO - Contents: 05:29:38 INFO - build_url:https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:38 INFO - Running post-action listener: _resource_record_post_action 05:29:38 INFO - Running post-action listener: set_extra_try_arguments 05:29:38 INFO - ##### 05:29:38 INFO - ##### Running populate-webroot step. 05:29:38 INFO - ##### 05:29:38 INFO - Running pre-action listener: _resource_record_pre_action 05:29:38 INFO - Running main action method: populate_webroot 05:29:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:29:38 INFO - '../fennec_ids.txt'], 05:29:38 INFO - 'tests': ['tcheck2']}, 05:29:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:38 INFO - '--tppagecycles', 05:29:38 INFO - '7'], 05:29:38 INFO - 'tests': ['tsvgm']}}, 05:29:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:29:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'tests': ['damp', 'tps']}, 05:29:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['damp', 'tps']}, 05:29:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:29:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:38 INFO - 'other': {'tests': ['a11yr', 05:29:38 INFO - 'ts_paint', 05:29:38 INFO - 'tpaint', 05:29:38 INFO - 'sessionrestore', 05:29:38 INFO - 'sessionrestore_no_auto_restore']}, 05:29:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['a11yr', 05:29:38 INFO - 'ts_paint', 05:29:38 INFO - 'tpaint', 05:29:38 INFO - 'sessionrestore', 05:29:38 INFO - 'sessionrestore_no_auto_restore']}, 05:29:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['a11yr', 05:29:38 INFO - 'ts_paint', 05:29:38 INFO - 'tpaint', 05:29:38 INFO - 'sessionrestore', 05:29:38 INFO - 'sessionrestore_no_auto_restore']}, 05:29:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['a11yr', 05:29:38 INFO - 'ts_paint', 05:29:38 INFO - 'tpaint', 05:29:38 INFO - 'sessionrestore', 05:29:38 INFO - 'sessionrestore_no_auto_restore']}, 05:29:38 INFO - 'other_l64': {'tests': ['a11yr', 05:29:38 INFO - 'ts_paint', 05:29:38 INFO - 'tpaint', 05:29:38 INFO - 'sessionrestore', 05:29:38 INFO - 'sessionrestore_no_auto_restore']}, 05:29:38 INFO - 'other_nol64': {'tests': ['a11yr', 05:29:38 INFO - 'ts_paint', 05:29:38 INFO - 'tpaint', 05:29:38 INFO - 'sessionrestore', 05:29:38 INFO - 'sessionrestore_no_auto_restore']}, 05:29:38 INFO - 'svgr': {'tests': ['tsvgx', 05:29:38 INFO - 'tsvgr_opacity', 05:29:38 INFO - 'tart', 05:29:38 INFO - 'tscrollx', 05:29:38 INFO - 'cart']}, 05:29:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['tsvgx', 05:29:38 INFO - 'tsvgr_opacity', 05:29:38 INFO - 'tart', 05:29:38 INFO - 'tscrollx', 05:29:38 INFO - 'cart']}, 05:29:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'tests': ['tp5o']}, 05:29:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'talos_options': ['--e10s'], 05:29:38 INFO - 'tests': ['tp5o']}, 05:29:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'talos_options': ['--xperf_path', 05:29:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:38 INFO - 'tests': ['tp5n']}, 05:29:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:38 INFO - 'talos_options': ['--e10s', 05:29:38 INFO - '--xperf_path', 05:29:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:38 INFO - 'tests': ['tp5n']}}, 05:29:38 INFO - 'talos.zip': {'path': '', 05:29:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:38 INFO - Running post-action listener: _resource_record_post_action 05:29:38 INFO - ##### 05:29:38 INFO - ##### Running create-virtualenv step. 05:29:38 INFO - ##### 05:29:38 INFO - Running pre-action listener: _resource_record_pre_action 05:29:38 INFO - Running main action method: create_virtualenv 05:29:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:29:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:38 INFO - Using real prefix '/tools/python27' 05:29:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:42 INFO - Installing pip.................done. 05:29:42 INFO - Return code: 0 05:29:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f52b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad7acd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:29:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:29:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:42 INFO - 'HOME': '/Users/cltbld', 05:29:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:42 INFO - 'LOGNAME': 'cltbld', 05:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:42 INFO - 'MOZ_NO_REMOTE': '1', 05:29:42 INFO - 'NO_EM_RESTART': '1', 05:29:42 INFO - 'PAGER': '/bin/cat', 05:29:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:42 INFO - 'PWD': '/builds/slave/test', 05:29:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:42 INFO - 'SHELL': '/bin/bash', 05:29:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:29:42 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:29:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:42 INFO - 'USER': 'cltbld', 05:29:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:42 INFO - 'XPC_FLAGS': '0x0', 05:29:42 INFO - 'XPC_SERVICE_NAME': '0', 05:29:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:29:42 INFO - Cleaning up... 05:29:42 INFO - Return code: 0 05:29:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f52b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad7acd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:29:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:29:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:42 INFO - 'HOME': '/Users/cltbld', 05:29:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:42 INFO - 'LOGNAME': 'cltbld', 05:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:42 INFO - 'MOZ_NO_REMOTE': '1', 05:29:42 INFO - 'NO_EM_RESTART': '1', 05:29:42 INFO - 'PAGER': '/bin/cat', 05:29:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:42 INFO - 'PWD': '/builds/slave/test', 05:29:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:42 INFO - 'SHELL': '/bin/bash', 05:29:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:29:42 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:29:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:42 INFO - 'USER': 'cltbld', 05:29:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:42 INFO - 'XPC_FLAGS': '0x0', 05:29:42 INFO - 'XPC_SERVICE_NAME': '0', 05:29:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:42 INFO - Downloading/unpacking psutil>=0.7.1 05:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:45 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:29:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:45 INFO - Installing collected packages: psutil 05:29:45 INFO - Running setup.py install for psutil 05:29:45 INFO - building 'psutil._psutil_osx' extension 05:29:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:29:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:29:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:29:45 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 05:29:45 INFO - building 'psutil._psutil_posix' extension 05:29:45 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 05:29:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:29:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:29:45 INFO - ^ 05:29:45 INFO - 1 warning generated. 05:29:45 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 05:29:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:46 INFO - Successfully installed psutil 05:29:46 INFO - Cleaning up... 05:29:46 INFO - Return code: 0 05:29:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f52b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad7acd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:29:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:29:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:46 INFO - 'HOME': '/Users/cltbld', 05:29:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:46 INFO - 'LOGNAME': 'cltbld', 05:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:46 INFO - 'MOZ_NO_REMOTE': '1', 05:29:46 INFO - 'NO_EM_RESTART': '1', 05:29:46 INFO - 'PAGER': '/bin/cat', 05:29:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:46 INFO - 'PWD': '/builds/slave/test', 05:29:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:46 INFO - 'SHELL': '/bin/bash', 05:29:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:29:46 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:29:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:46 INFO - 'USER': 'cltbld', 05:29:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:46 INFO - 'XPC_FLAGS': '0x0', 05:29:46 INFO - 'XPC_SERVICE_NAME': '0', 05:29:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:29:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:29:48 INFO - Installing collected packages: mozsystemmonitor 05:29:48 INFO - Running setup.py install for mozsystemmonitor 05:29:48 INFO - Successfully installed mozsystemmonitor 05:29:48 INFO - Cleaning up... 05:29:48 INFO - Return code: 0 05:29:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:29:48 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')]} 05:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:48 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')]} 05:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:48 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 0x10f52b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad7acd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:29:48 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 05:29:48 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 05:29:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:29:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:48 INFO - 'HOME': '/Users/cltbld', 05:29:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:48 INFO - 'LOGNAME': 'cltbld', 05:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:48 INFO - 'MOZ_NO_REMOTE': '1', 05:29:48 INFO - 'NO_EM_RESTART': '1', 05:29:48 INFO - 'PAGER': '/bin/cat', 05:29:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:48 INFO - 'PWD': '/builds/slave/test', 05:29:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:48 INFO - 'SHELL': '/bin/bash', 05:29:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:29:48 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:29:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:48 INFO - 'USER': 'cltbld', 05:29:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:48 INFO - 'XPC_FLAGS': '0x0', 05:29:48 INFO - 'XPC_SERVICE_NAME': '0', 05:29:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:52 INFO - Downloading docopt-0.6.1.tar.gz 05:29:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:52 INFO - Running setup.py install for blobuploader 05:29:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:52 INFO - Running setup.py install for requests 05:29:53 INFO - Running setup.py install for docopt 05:29:53 INFO - Successfully installed blobuploader requests docopt 05:29:53 INFO - Cleaning up... 05:29:53 INFO - Return code: 0 05:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f52b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad7acd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:29:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:29:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:53 INFO - 'HOME': '/Users/cltbld', 05:29:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:53 INFO - 'LOGNAME': 'cltbld', 05:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:53 INFO - 'MOZ_NO_REMOTE': '1', 05:29:53 INFO - 'NO_EM_RESTART': '1', 05:29:53 INFO - 'PAGER': '/bin/cat', 05:29:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:53 INFO - 'PWD': '/builds/slave/test', 05:29:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:53 INFO - 'SHELL': '/bin/bash', 05:29:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:29:53 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:29:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:53 INFO - 'USER': 'cltbld', 05:29:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:53 INFO - 'XPC_FLAGS': '0x0', 05:29:53 INFO - 'XPC_SERVICE_NAME': '0', 05:29:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:53 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-47yuUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:53 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-KdnJry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:53 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-CtJGeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:53 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-MupqSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:53 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-ATseYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-_xPfQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Ee_b1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-soCH4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-4mjsTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-C0hkSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-4xfu45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-jo6Uc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-gbJyh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:54 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-iM1Syx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:55 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-E9tSiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:55 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-a8QzJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:55 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-vkGTyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:55 INFO - Running setup.py install for manifestparser 05:29:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:29:55 INFO - Running setup.py install for mozcrash 05:29:55 INFO - Running setup.py install for mozdebug 05:29:55 INFO - Running setup.py install for mozdevice 05:29:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:29:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:55 INFO - Running setup.py install for mozfile 05:29:56 INFO - Running setup.py install for mozhttpd 05:29:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Running setup.py install for mozinfo 05:29:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Running setup.py install for mozInstall 05:29:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Running setup.py install for mozleak 05:29:56 INFO - Running setup.py install for mozlog 05:29:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Running setup.py install for moznetwork 05:29:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:29:56 INFO - Running setup.py install for mozprocess 05:29:57 INFO - Running setup.py install for mozprofile 05:29:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:29:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:29:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:29:57 INFO - Running setup.py install for mozrunner 05:29:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:29:57 INFO - Running setup.py install for mozscreenshot 05:29:57 INFO - Running setup.py install for moztest 05:29:57 INFO - Running setup.py install for mozversion 05:29:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:29:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:57 INFO - Cleaning up... 05:29:57 INFO - Return code: 0 05:29:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:57 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')]} 05:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:57 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')]} 05:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:57 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 0x10f52b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad7acd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:29:57 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 05:29:57 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 05:29:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:29:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:57 INFO - 'HOME': '/Users/cltbld', 05:29:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:57 INFO - 'LOGNAME': 'cltbld', 05:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:57 INFO - 'MOZ_NO_REMOTE': '1', 05:29:57 INFO - 'NO_EM_RESTART': '1', 05:29:57 INFO - 'PAGER': '/bin/cat', 05:29:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:57 INFO - 'PWD': '/builds/slave/test', 05:29:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:57 INFO - 'SHELL': '/bin/bash', 05:29:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:29:57 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:29:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:57 INFO - 'USER': 'cltbld', 05:29:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:57 INFO - 'XPC_FLAGS': '0x0', 05:29:57 INFO - 'XPC_SERVICE_NAME': '0', 05:29:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-hGNiLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-r1SGlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Uhwpwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-1f9CSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:58 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)) 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-lwQG9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:58 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)) 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-c3KyO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:58 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)) 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-nVDgPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:58 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)) 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-hKg6nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-pdODUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-JwLCH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-CI7wSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-D7VA5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-VjyLaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-eiEZLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:59 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)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-YpBHDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:59 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)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-viqie5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:59 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)) 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:59 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-7_F6Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:59 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)) 05:29:59 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)) 05:29:59 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)) 05:29:59 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)) 05:29:59 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)) 05:29:59 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)) 05:29:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:02 INFO - Downloading blessings-1.5.1.tar.gz 05:30:02 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:02 INFO - Installing collected packages: blessings 05:30:02 INFO - Running setup.py install for blessings 05:30:02 INFO - Successfully installed blessings 05:30:02 INFO - Cleaning up... 05:30:02 INFO - Return code: 0 05:30:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:02 INFO - Reading from file tmpfile_stdout 05:30:02 INFO - Current package versions: 05:30:02 INFO - blessings == 1.5.1 05:30:02 INFO - blobuploader == 1.2.4 05:30:02 INFO - docopt == 0.6.1 05:30:02 INFO - manifestparser == 1.1 05:30:02 INFO - mozInstall == 1.12 05:30:02 INFO - mozcrash == 0.16 05:30:02 INFO - mozdebug == 0.1 05:30:02 INFO - mozdevice == 0.47 05:30:02 INFO - mozfile == 1.2 05:30:02 INFO - mozhttpd == 0.7 05:30:02 INFO - mozinfo == 0.9 05:30:02 INFO - mozleak == 0.1 05:30:02 INFO - mozlog == 3.1 05:30:02 INFO - moznetwork == 0.27 05:30:02 INFO - mozprocess == 0.22 05:30:02 INFO - mozprofile == 0.27 05:30:02 INFO - mozrunner == 6.11 05:30:02 INFO - mozscreenshot == 0.1 05:30:02 INFO - mozsystemmonitor == 0.0 05:30:02 INFO - moztest == 0.7 05:30:02 INFO - mozversion == 1.4 05:30:02 INFO - psutil == 3.1.1 05:30:02 INFO - requests == 1.2.3 05:30:02 INFO - wsgiref == 0.1.2 05:30:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10f52b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad7acd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/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.uZDKeRyRvs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:02 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 05:30:02 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 05:30:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:30:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:02 INFO - 'HOME': '/Users/cltbld', 05:30:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:02 INFO - 'LOGNAME': 'cltbld', 05:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:02 INFO - 'MOZ_NO_REMOTE': '1', 05:30:02 INFO - 'NO_EM_RESTART': '1', 05:30:02 INFO - 'PAGER': '/bin/cat', 05:30:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:02 INFO - 'PWD': '/builds/slave/test', 05:30:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:02 INFO - 'SHELL': '/bin/bash', 05:30:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:30:02 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:30:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:02 INFO - 'USER': 'cltbld', 05:30:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:02 INFO - 'XPC_FLAGS': '0x0', 05:30:02 INFO - 'XPC_SERVICE_NAME': '0', 05:30:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:03 INFO - Cleaning up... 05:30:03 INFO - Return code: 0 05:30:03 INFO - Running post-action listener: _resource_record_post_action 05:30:03 INFO - Running post-action listener: _start_resource_monitoring 05:30:03 INFO - Starting resource monitoring. 05:30:03 INFO - ##### 05:30:03 INFO - ##### Running install step. 05:30:03 INFO - ##### 05:30:03 INFO - Running pre-action listener: _resource_record_pre_action 05:30:03 INFO - Running main action method: install 05:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:03 INFO - Reading from file tmpfile_stdout 05:30:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:03 INFO - Reading from file tmpfile_stdout 05:30:03 INFO - Output received: 05:30:03 INFO - Usage: mozinstall [options] installer 05:30:03 INFO - Options: 05:30:03 INFO - -h, --help show this help message and exit 05:30:03 INFO - -d DEST, --destination=DEST 05:30:03 INFO - Directory to install application into. [default: 05:30:03 INFO - "/builds/slave/test"] 05:30:03 INFO - --app=APP Application being installed. [default: firefox] 05:30:03 INFO - mkdir: /builds/slave/test/build/application 05:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:30:33 INFO - Reading from file tmpfile_stdout 05:30:33 INFO - Output received: 05:30:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:30:33 INFO - Running post-action listener: _resource_record_post_action 05:30:33 INFO - ##### 05:30:33 INFO - ##### Running run-tests step. 05:30:33 INFO - ##### 05:30:33 INFO - Running pre-action listener: _resource_record_pre_action 05:30:33 INFO - Running main action method: run_tests 05:30:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:33 INFO - 2015-11-24 05:30:33.983 screenresolution[1974:13838] starting screenresolution argv=screenresolution get 05:30:33 INFO - 2015-11-24 05:30:33.986 screenresolution[1974:13838] Display 0: 1600x1200x32@60 05:30:33 INFO - 2015-11-24 05:30:33.992 screenresolution[1975:13841] starting screenresolution argv=screenresolution list 05:30:33 INFO - Available Modes on Display 0 05:30:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:34 INFO - Intel Iris: 05:30:34 INFO - Chipset Model: Intel Iris 05:30:34 INFO - Type: GPU 05:30:34 INFO - Bus: Built-In 05:30:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:30:34 INFO - Vendor: Intel (0x8086) 05:30:34 INFO - Device ID: 0x0a2e 05:30:34 INFO - Revision ID: 0x0009 05:30:34 INFO - Displays: 05:30:34 INFO - Display: 05:30:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:34 INFO - Display Serial Number: 1600x1200 60 05:30:34 INFO - Main Display: Yes 05:30:34 INFO - Mirror: Off 05:30:34 INFO - Online: Yes 05:30:34 INFO - Rotation: Supported 05:30:34 INFO - Return code: 0 05:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:34 INFO - Python 2.7.3 05:30:34 INFO - Return code: 0 05:30:34 INFO - grabbing minidump binary from tooltool 05:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f44f9f0>, '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 0x10f1aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4428c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:30:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:30:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:34 INFO - Return code: 0 05:30:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:30:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:30:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] in /builds/slave/test/build 05:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --webServer localhost 05:30:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C8GOLO21NY/Render', 05:30:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:34 INFO - 'HOME': '/Users/cltbld', 05:30:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:34 INFO - 'LOGNAME': 'cltbld', 05:30:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:34 INFO - 'MOZ_NO_REMOTE': '1', 05:30:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:34 INFO - 'NO_EM_RESTART': '1', 05:30:34 INFO - 'PAGER': '/bin/cat', 05:30:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:34 INFO - 'PWD': '/builds/slave/test', 05:30:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:34 INFO - 'SHELL': '/bin/bash', 05:30:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZDKeRyRvs/Listeners', 05:30:34 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:30:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:34 INFO - 'USER': 'cltbld', 05:30:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:34 INFO - 'XPC_FLAGS': '0x0', 05:30:34 INFO - 'XPC_SERVICE_NAME': '0', 05:30:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] with output_timeout 3600 05:30:34 INFO - mozversion INFO | application_buildid: 20151124030554 05:30:34 INFO - mozversion INFO | application_changeset: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 05:30:34 INFO - mozversion INFO | application_display_name: Nightly 05:30:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:34 INFO - mozversion INFO | application_name: Firefox 05:30:34 INFO - mozversion INFO | application_remotingname: firefox 05:30:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:30:34 INFO - mozversion INFO | application_vendor: Mozilla 05:30:34 INFO - mozversion INFO | application_version: 45.0a1 05:30:34 INFO - mozversion INFO | platform_buildid: 20151124030554 05:30:34 INFO - mozversion INFO | platform_changeset: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 05:30:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:30:34 INFO - mozversion INFO | platform_version: 45.0a1 05:30:34 INFO - 2015-11-24 05:30:34,533 DEBUG : using testdate: 1448371834 05:30:34 INFO - 2015-11-24 05:30:34,533 DEBUG : actual date: 1448371834 05:30:34 INFO - 2015-11-24 05:30:34,610 INFO : starting webserver on 'localhost:49534' 05:30:34 INFO - 2015-11-24 05:30:34,611 INFO : Starting test suite t-yosemite-r7-0018.e 05:30:34 INFO - 2015-11-24 05:30:34,611 INFO : Starting test dromaeo_css 05:30:34 INFO - 2015-11-24 05:30:34,611 DEBUG : operating with platform_type : mac_ 05:30:34 INFO - 2015-11-24 05:30:34,612 INFO : Initialising browser for dromaeo_css test... 05:30:34 INFO - 2015-11-24 05:30:34,624 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmp8A3_Ub/profile http://localhost:49534/getInfo.html 05:30:37 INFO - 2015-11-24 05:30:37,235 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:37 INFO - 2015-11-24 05:30:37,236 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:37 INFO - 2015-11-24 05:30:37,236 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:30:37 INFO - 2015-11-24 05:30:37,236 DEBUG : BROWSER_OUTPUT: __metrics 05:30:37 INFO - 2015-11-24 05:30:37,810 INFO : Browser initialized. 05:30:37 INFO - 2015-11-24 05:30:37,810 INFO : Running cycle 1/1 for dromaeo_css test... 05:30:37 INFO - 2015-11-24 05:30:37,810 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmp8A3_Ub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:49 INFO - 2015-11-24 05:30:49,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 236400640 05:30:49 INFO - 2015-11-24 05:30:49,920 DEBUG : BROWSER_OUTPUT: 05:31:39 INFO - 2015-11-24 05:31:39,647 DEBUG : BROWSER_OUTPUT: 1448371899644 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] 05:33:49 INFO - 2015-11-24 05:33:49,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49534/tests/dromaeo/cssquery-ext.html) 05:33:51 INFO - 2015-11-24 05:33:51,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 253923328 05:33:51 INFO - 2015-11-24 05:33:51,172 DEBUG : BROWSER_OUTPUT: 05:36:53 INFO - 2015-11-24 05:36:53,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/dromaeo/cssquery-ext.html (next: http://localhost:49534/tests/dromaeo/cssquery-jquery.html) 05:36:53 INFO - 2015-11-24 05:36:53,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 263221248 05:36:53 INFO - 2015-11-24 05:36:53,884 DEBUG : BROWSER_OUTPUT: 05:39:55 INFO - 2015-11-24 05:39:55,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49534/tests/dromaeo/cssquery-mootools.html) 05:39:56 INFO - 2015-11-24 05:39:56,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 264040448 05:39:56 INFO - 2015-11-24 05:39:56,016 DEBUG : BROWSER_OUTPUT: 05:42:57 INFO - 2015-11-24 05:42:57,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49534/tests/dromaeo/cssquery-prototype.html) 05:42:58 INFO - 2015-11-24 05:42:58,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 266661888 05:42:58 INFO - 2015-11-24 05:42:58,247 DEBUG : BROWSER_OUTPUT: 05:46:00 INFO - 2015-11-24 05:46:00,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49534/tests/dromaeo/cssquery-yui.html) 05:46:01 INFO - 2015-11-24 05:46:01,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 269377536 05:46:01 INFO - 2015-11-24 05:46:01,384 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/dromaeo/cssquery-yui.html (next: http://localhost:49534/tests/dromaeo/cssquery-dojo.html) 05:49:03 INFO - 2015-11-24 05:49:03,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 272519168 05:49:03 INFO - 2015-11-24 05:49:03,869 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,869 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:49:03 INFO - 2015-11-24 05:49:03,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:49:03 INFO - 2015-11-24 05:49:03,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:49:03 INFO - 2015-11-24 05:49:03,870 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:49:03 INFO - 2015-11-24 05:49:03,871 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3425.7430692698044;3463.2034632034647;3479.1650003999034;3480.095175254433;3517.243792584594;5825.446582574654;5842.415758424161;5870.70646467677;5880.647161170333;5890.88218235635;5595.18869763884;5729.770809167629;5733.397993210715;5746.913796293059;5747.2528571285775;4361.738295702252;5130.846074617767;5161.483851614846;5187.9740601297035;5281.630285879971;5318.946810531903;5348.358197016363;5356.91964620531;5366.436524164965;5379.031774280628;698.1594173448979;5234.502722241381;5235.816746413857;5317.787288508455;5396.19057141428;4682.438107427097;5281.524662780368;5296.285001524822;5301.787928482856;5323.254744335796;5231.494110353378;5233.9738301308635;5235.764390602432;5276.7889284428575;5307.628466007381;5347.598930080259;5428.104362780136;5670.206171136044;5830.300363956352;5870.823875283749;6242.6878656067465;6252.2809876864285;6258.030005349178;6262.561620686553;6268.216472940882;6293.559450838443;6295.2760432550385;6301.779437719703;6314.210723659543;6318.905216421757;5772.480476757112;5923.792667256668;5935.910961335583;5948.851278718023;6051.243594550681;6269.435750782452;6273.560850740496;6402;6402.423781859655;6429.9678501607195;6234.5635805494085;6242.28213755424;6244.063390491372;6271.059341098871;6288.779892703734;6131.50947924165;6209.254889413209;6246.469050130699;6266.561340706198;6295.842603934847;6161.599496032743;6268.749250030039;6284.057391391328;6285.43431091204;6302.527310451735;6131;6136.110264011693;6147.538934579924;6151.5386346024225;6161.599496032743;4877.878053048702;4899.191633380524;4917.459079501252;4966.056449274626;4975.179095449283;4467.262901621196;4490.887727806766;4492.034212644232;4499.842505512292;4520.61574766142;5863.0325996211;5865.501432378211;5904.852378690567;5933.1396947443245;5934.673592952343;6118.527810132473;6152.538559608047;6243.219597550306;6252.906206406908;6304.810855674337;5747.913781293284;5763.337216220189;5767.134929760486;5776.451237132465;5919.792807251725;5434.538064264502;5437.891242175135;5447.455254474521;5447.754851031713;5460.6996615186545;6215.627062376272;6246.281677607042;6307;6337.112804207322;6359.618422894641;6254.374562543891;6260.311365749672;6267.686615669107;6296.401841825019;6303.684815759286;6129.389354848233;6310.432061114522;6354;6365.61806291624;6377.936220637735;6163.96918015407;6226.159468471698;6245.219347581552;6262.123302737529;6281.842953926006;5250.317458730493;5845.88928103659;6223.37766223374;6232.688365581612;6246.718897649525;5262.394824595221;6042.1843051187525;6083.117947897618;6109.877802444015;6133.539984501091;5417.7268341938825;5901.380355062828;6160.476359509492;6164;6184.81445556616;5612.607117501736;5986.790462333797;6001.459868611846;6009.098635204754;6078.54410919174;5267.552258058108;6018.699065046642;6144.692765361625;6159.07613857907;6160.969195153995;5547.5007249347755;6097.97841994295;6111.834843226386;6122.001753127839;6135.263289243823 05:49:03 INFO - 2015-11-24 05:49:03,876 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.4814158054315;544.3982503419417;607.5079185859457;658.4929604204763;659.7064306383659;42608.36087458687;43009.78495107528;43160.56839431605;43461;43542.12915741687;35236.82381588095;35748.82125589369;44153;44397.55602443975;44639.553604463945;9761.07269809367;9879.407235565854;9897.65358212459;9919.156871665917;9955.651552195675;9766.560504777266;9898.356606820533;9909.108180263775;9921.057499537532;9936.155426788731;9830.164436022947;9885.654002109928;9901.455419951899;9904;9905.158061564776;9801.803963920718;9868.111869931705;9890.258230632659;9892.950535247277;9897.653582124663;9670.951645241728;9723.951380243054;9770.022997700244;9788.951055244679;9804.36271642341;42584.78707606442;42679.93300167489;42849.78575107136;43022.784886075366;43095;3115.8597863096215;3224.9355012899846;3291.193657553915;3346.4645656695056;3386.291781829752;25083.24750257495;29370;29480;30077.849610752026;30099.247518812204;2465.7657522535333;2807.9578806317922;2845.530487469565;2874.583185438121;2885.0623547347195;478723.60638196935;491187;496248;496701;497550;71286.64356678183;71366;71447.64276178586;71536.64231678809;71916;75362;76510.61744691241;76678;76686.61656691681;76756;15074.623134421508;16593.253303601366;16630.417935372203;16667.916660416864;16839.494815155565;11122.833157502644;12689.238645681104;12930.806037909439;12936.353182340845;12946.611601651966;18145.81854181468;21365.931703414768;21871.890640546695;21984.560308793734;22196.77917714541;8094.61707964209;8123;8388.8741668875;8821.38250322484;8822.911770882209;966.2366730283138;994.9602015919282;1058.2750815691277;1082.3235477826358;1188.9240237585;26060.60909086365;30464.695353046187;30610;30945.69054309473;31211.531827022613;1062.3201151263197;1076;1078.577830893331;1081.1080858291941;1255.2970336611527;15241.618959525878;15466;16296.429624963306;16565.58586035359;16722.498325050266;508782;510552;516259;517389;519685.4015729897;62643.686781566714;62933;62959.6852015737;63226;63350.366496335366;1438.3671184678917;1485.5394827603477;1486.710091532141;1494.521753039039;1624.7806546116124;30803.383932321678;31106.533401998535;31271;31523;31566.053018409486;58023;58516.70741646265;58745;59318;59429;472766;473507;475234;475308.6234568805;476143;32099.518507221943;32101.03696889097;32213.677863222005;32454.35091298208;32513.837430812695;45765.39821106246;46632.533674662816;47026.76486617545;47253.52746472491;47428.52571474241;34420.011403922355;35406.468902965964;36969.53399663344;37237.069073273386;37241;37857.62142378541;38032;38304.659336923076;38553.80723096366;38710.41934371043;32164.03507894767;32954.83522582372;37205.069873253386;37328.62671373251;37864.81067594644;32630.673693262765;35352.64647353494;35546.28907421786;35609.82195089111;35939.46090808588;25378.238652840446;25559.74440255648;25588;25998.740012599632;26094.478110438064 05:49:03 INFO - 2015-11-24 05:49:03,876 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.4450912068053;356.7110640381293;359.38903863432154;365.7056069863759;365.8774310605947;16287.674246515093;19849.801501984977;19859.900700496495;20769.9615019249;21498.785012149874;20259.594808103866;20440.897795511002;20937.37187884366;21140.57718845622;21193.046312915918;5764.279465066867;5764.827055188351;5941.435563621449;5954.2259506264345;5966.284045914496;5442.074847275952;5607.831765047055;5618.073017952033;5630.971845140769;5838.824835254949;5082.567981721558;5231.476852314757;5600.943990560103;5990.311114221855;6359.332270111618;6249.531285153632;6278.466330361902;6296.559240853165;6300.653464059475;6331.33520980295;4921.827736029258;5248.8425347239645;5295.814646487393;5463.808766693186;5484.533814625762;12418.937905310415;12445.751084978341;12575.622731318075;12590;12610.74778504434;2016.9596608067757;2033.1765634917733;2056.9272839777323;2082.3961051295105;2126.4258650164525;14848.851511484854;15528;16094;16378.508644740677;16663;1772.1139430284857;1802.7566278552358;1811.4022372617005;1860.1815201311379;1902.6860568006261;76163.09592260183;88975.55512222463;95598;99186.51220231703;105825;18675.533111672317;18843.71734423985;18894.527636808914;18954.715679264824;19079.904600476908;27552.724472755017;27653.86173069162;27933.022344217854;28100;28131.57802632921;10149.492525373702;10162.085412312927;10200.183985281308;10211.642592509226;10249.74375640615;8509.702160424355;8665.046844847062;8722.215000649972;8724.302055835518;8733.737987860375;4254.298040823292;4342.761148136883;8888.37781355312;9076.092390761003;9189.81620367589;1545.5981444824426;1585.9444919427765;1815.9273629054953;1848.2145088337402;1878.4176905159445;875.50096445027;897.9865302020474;913.848550825964;970.9951450242845;1025.8615086963164;14782.556523304318;16338.529532341909;18152.45542633723;20653.89673051625;20815.895920520605;978.7781735460464;991.439836492394;1006.2201793609864;1008.8839783424853;1009.8535712321819;11081.113510919107;11293.94353028246;11325.773484530264;11341.546338146547;11362;689651;698250;708835;764139;776171;118071;119043;120990.18514722286;121935;123476;1155.1682788392345;1162.7325715085578;1165.8251262310553;1168.094726586902;1181.2381014245934;15879.28543215535;18328.17523211432;18335.891372492333;18448.169832357846;18629.534261643566;50871.491285086675;53336.46663533315;53809.46190538044;54971;56177.15734264071;73764;73796.63101684458;73971.63014184895;74182.62908685423;74713;9666.275029372684;9784.559694813608;9870.506474676382;9883.505824708593;9916;16003.839961600235;18483.890966541512;19378.709319360503;19957;20029.899850500653;14948.327325270171;15365.69268614599;15531.76702349443;15671.843281567039;15846.44537441184;12094.943859543722;15183.392664293304;15546.689066218387;15639.748820094594;15671.921640391725;15846.683066338379;16040.235574087075;16711.331546737994;16722.247498862336;17057;9260.768480787765;9675.9032409675;9727.124558789743;9750.219982401533;9898.604055837974;15395.61510962235;15636.374545018527;15901.681966360838;15930.60173495672;16073.35706571724 05:49:03 INFO - 2015-11-24 05:49:03,880 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1572.7404978178602;1607.4454313261924;1883.4255552056625;1960.2257108442175;2005.6089062632793;6950.791476255714;7088.18485874124;7118.572885626866;7800.5709685967395;7942.523448593074;8222.301104406119;8316.2099600538;8452.154784521545;8475.194856488624;8479.236868681817;2313.421644588853;2339.7426283108844;2345.167465549731;2354.8704821234824;2362.598358279097;2350.811935045192;2379.0721618568773;2387.7612238776155;2389.307100940725;2398.5322862041908;2336.7312759032675;2364.598018336887;2386.4988352446007;2389.6415537669313;2400.411899084718;2357.351728274721;2369.751176126499;2378.5837478441204;2385.95228095438;2386.1052105460453;2386.6181410974336;2413.9034438622434;2431.5744744669614;2435.7442468540903;2442.1940759549307;8493.447925884859;8545.658173673046;8576.185262400062;8580.742577722678;8583.399162058658;4650.883727906796;5125.897482050375;5201.375834899836;5224.63427560071;5238.188080847474;3214.983925080383;3415.351083294166;3429.879954201591;3486.6164721880573;3494.196334842975;1024.9846252306222;1029.5212726082407;1055.883852776194;1070.4487189097622;1070.9678709638724;10948.3978381189;11066.336019838835;11081.889181108167;11084.61203857861;11099.945505176995;4668.305874154001;4682.1338052460405;4724.173269677793;4775.474697783241;4786.305985632064;9825.508724563742;9830.557624906753;9830.901690983143;9837.360571562825;9897.703068907944;5207.557357624644;5257.290265814143;5257.8159764408065;5269.762860671279;5270.789168433296;4711.246200607886;4743.217369134054;4746.620270378361;4784.473707892129;4787.832425865078;3746.6628003479273;3804.2201348723447;3805.7145714071003;3820.9426858597144;3857.9421308680394;1263.4946021591254;1277.2464246094662;1283.6790802299424;1289.7420515896858;1289.9806502902463;1117.1732917640886;1147.6614398752388;1165.6211731187398;1169.4854264123758;1177.14068729826;7856.7250146244605;7936.761897143095;7939.563324017235;7948.085970113511;8020.318272946864;1246.4577908609783;1247.5508816825936;1250.1998720818683;1250.762355152518;1261.917975331619;5935.643861368246;6293.96853015732;6323.747050117944;6331.620102793847;6346.428821406095;9771.267154963407;9851.310408271496;9906.356086854332;9954.153896918699;9955.153811926068;9795.461249631197;9812.901870981199;9816.411015339103;9839.508024598741;10139.847902281472;7934.2859142677435;7965.203479651988;8013.038435387907;8017.037955445384;8056.436049476598;7865.488743231672;7893.802654933443;7912.643931023003;7912.802179945547;7920.722774703088;7541.208173141741;9003.51442012087;9083.863742043743;9218.861717074384;9253.982061973044;8154.796130096795;9251.398659087137;9509.476978766234;9570.56932438028;9593.040695930351;7038.894416583653;7104.076470058859;7119.644017799193;7127.928720712726;7139.964300178466;7905.723299684483;8119.39104567148;8167.79580510492;8168.019837619524;8175.427720059539;7412.147603025721;7566.924330756622;7624.161342252459;7779.922200778146;7781.455298129076;7437.702491900263;7459.067616547932;7475.289847464483;7544.698212071675;7625.771226863203;7624.847503049797;7687.5387476751575;7691.769246922601;7694.461387702807;7735.419843511647;6971.093757811452;7025.437964962688;7029.5430796998035;7053.823654408681;7058.894116588358;5389.541888939484;6988.755393561201;7073.469489788389;7090.893636595352;7431.5912624804 05:49:03 INFO - 2015-11-24 05:49:03,880 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.45947564645815;322.247551966159;325.61414723552576;328.65162927297075;331.69981167043835;6835.7607483738075;6924.792256232308;6950.617716025617;7027.437804975602;7036.331548502891;6776.762813301535;6921.411680007205;6952.304769523058;6963.094797676307;6979.162500499934;5089.134847075997;5092.236164575324;5095.923561146567;5105.668131571455;5111.361079865017;4865.343178670887;5095.847124586268;5098.184290513518;5105.489451054883;5109.923351149717;3863.4398012288343;4703.764811759415;4940.827071052514;4962.354893863792;4972.950270497303;4939.110960027194;4947.257911313296;4949;4956.529129732688;4981.701097934099;4015.136745599681;4097.180563887235;4113.382992551112;4185.4977402711565;4211.768352740598;6631.834204144935;6649.434798042173;6656.400923916871;6663.9333606663795;6668.533202675814;5897.557683173779;5933.792317268918;5938.317093534256;5940.584159108864;5944.019236825919;7169.354758071747;7400.925990740077;7403.296686814744;7405.703771849119;7408.666610002563;4724.692894961817;4736.147493451177;4745.406824146981;4761.023990082025;4764.761761911891;7812.218778122199;7876.881846772303;7918.049834019955;7925.247101525403;7927.484713493604;4605.700629459075;4717.150912835654;4738.668293219442;4797.856064318076;4805.687630304019;4850.6362022848425;4866.245731911559;4871.634627402959;4871.806407430202;4885.5358740919555;4292.012837047497;5819.709014549256;5875.11873219012;5882.911756323659;5888.116782482662;7252.948322493209;7491.9625401872645;7511.887321690179;7513.2111128330735;7526.849463010819;1684.839940205703;1695.0423010998745;1696.8133505314406;1697.694415005311;1700.8129105798353;1068.0707784227773;1068.4817863336275;1069.4706120470416;1080.6541906589816;1086.179934149712;6948.062011628466;6962.686679099453;6997.825054373681;7000.264972177848;7002.719891204295;7796.727114550963;7801;7809.101953275333;7813.804654883674;7824.100228473799;6743.662816859138;6929.3070692930305;6945.201301850251;6951.270116637781;6957.547759395623;4032.3951407288555;4044.4135600337786;4106.301928672073;4111.403846442249;4161.10536234711;7979.800504987305;8054.355651547862;8087.47431416956;8092.3121534669035;8113.7565873023905;5935.970320148458;7022.824429389306;8076.111627720946;8106;8113.8782918256275;8064.354851611857;8071.757847264592;8073.717419890276;8083.393745469113;8139.79650508742;7821.92178078212;7838.804029899298;7852.057753069668;7854.2145785421;7870.645820937957;7525.36034437079;7680.423968202295;7691.923080769121;7715.267049630276;7761.922380776346;8150.388720846079;8158.632861521127;8175.141610131089;8180.713675021346;8196.59017049157;4456.286994080931;4565.949831538831;4826.58973987215;4828;4845.127876982177;7572;7810.960945195465;7846.293833555007;7870.488418253024;7873.645685944261;7529.1717911028645;7548.3961283098315;7559.017327747358;7560.054993125859;7560.6219689016425;7252.166000909963;7486.663100160397;7520;7550;7554.602398556284;5903.498202652822;7301.233370496234;7355.154157271768;7372.852542949218;7392.260773922565;6630.370114839083;7135.286471353031;7559.508631938907;7564.697412103455;7564.735234266775;7133.500654954103;7305.379042781423;7308.30571095745;7368.115826100902;7385.150707668472 05:49:03 INFO - 2015-11-24 05:49:03,881 DEBUG : BROWSER_OUTPUT: |5;yui.html;663.4360793325673;714.3499415531867;744.4081954845899;745.8843879198727;779.8947142135817;12534.49862005521;12917.483300667962;15043.924780376097;15525.456609018687;15540.222988850555;13212.603621891334;14317.570472885804;14359.569212923629;14374.281285935687;14383.137011779301;752.0636807175075;763.9579823109726;921.8709380686726;936.6347124621403;961.471190845036;917.4495302818289;938.3572253006678;944.7543638653965;946.6497395963469;953.2516974175273;874.8294082653885;988.6786794291847;998.8801343838713;1003.8694969653972;1004.7337455574278;854.1543871567135;973.7322236385015;988.1452543549849;993.9155171810369;996.4469719305782;739.8446326271489;742.6175519607407;745.1579714922103;746.8991686122413;750;12980.870191298154;14823.703525929528;14917.104973701613;14950.32723527433;14973.1016139032;12567.811482827765;12779.808302875465;12872.356382180948;13070.738585228242;13158.407871645799;10006.385568614909;10275.38347699133;10382.22133339995;10593.364398136137;10903.454827258605;3493.0568746438576;3546.3261980223933;3573.6069032406413;3610.332088563598;3732.0669832541867;66163.00755488672;80742.59628701818;81162.78255826108;82100.58949705273;84148.89627759233;9513.952430237943;9623.663171788954;9693.563789629483;9946.80106397868;10317.9484102579;21952.780472195394;21989.010494527785;22034.779652203593;22058.8970551475;22126.77873221247;7357.705691772377;7422.888656670154;7474.663640136207;7594.734184303634;7662.65518051689;4027.013381721497;4032.4556184915245;4065.1259979104043;4095.3242714952294;4099.877003689894;3403.4724617684296;3448.2930999145115;3451.2062225688233;3468.4623883298127;3470.1151206442196;609.3023488106094;623.9220097487814;624.2353117431111;642.7846671365052;645.502962718704;522.0446582753552;523.3510447045636;553.2558708537011;578.8408187748319;610.6305685060563;8489.36329775257;8604.35467339952;8637.568121593895;8852.468851868909;8897.976732675825;535.4297672978265;553.9750711218005;592.3957563285425;603.2007589943343;620.6958590290725;3901.765894046366;4021.2158629067053;4064.3293856513937;4116.938245926313;4148.8340466381005;73416.26583734094;73476.63261683658;96610.51694741481;98243;99864.5033874159;65187.414692191436;66960;84303.57848210842;86671.13328866757;86974.1302586966;54049.72975135099;69188;72378.2762172382;74584.25415745773;76266.61866690632;7398.556086634819;8994.775130621787;9004.954975225082;9123.178913897782;9166.770830729285;54226.45773542214;55074.62313442196;55372.44627553673;55790.72104639613;55893.720531397084;74986;76842.61578692071;77889.05277367885;78203;78885.8167127482;10927.781444371227;11193.27243729155;11289.20975531705;11367.829482557603;11974.64076077719;11883.82174267404;11988.220765650205;12030.699232519257;12526.749465010831;12684.112112152061;11294.774104518028;11483.138764592855;11595.710107247387;11884.881151188723;12306.692332691397;11257.493412796608;11742.58900938463;11867.287962722265;11916.52333906634;12290.508379664714;10698;11417.029552488131;11452.255603385753;11485.942570287096;12154.392280386122;9274.860877086983;9477.478738669164;9626.90373096288;9725.513724313898;9901.257405694745;8865.512396818236;9939.105480506789;9985.201183905416;9990.484778135924;10056.094951454405 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,338 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: __startTimestamp1448372943868__endTimestamp 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,882 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5734.30 Median:6001.46 stddev:748.51 (12.5%) stddev-sans-first:728.57 05:49:03 INFO - 2015-11-24 05:49:03,884 DEBUG : BROWSER_OUTPUT: Values: 3425.7 3463.2 3479.2 3480.1 3517.2 5825.4 5842.4 5870.7 5880.6 5890.9 5595.2 5729.8 5733.4 5746.9 5747.3 4361.7 5130.8 5161.5 5188.0 5281.6 5318.9 5348.4 5356.9 5366.4 5379.0 698.2 5234.5 5235.8 5317.8 5396.2 4682.4 5281.5 5296.3 5301.8 5323.3 5231.5 5234.0 5235.8 5276.8 5307.6 5347.6 5428.1 5670.2 5830.3 5870.8 6242.7 6252.3 6258.0 6262.6 6268.2 6293.6 6295.3 6301.8 6314.2 6318.9 5772.5 5923.8 5935.9 5948.9 6051.2 6269.4 6273.6 6402.0 6402.4 6430.0 6234.6 6242.3 6244.1 6271.1 6288.8 6131.5 6209.3 6246.5 6266.6 6295.8 6161.6 6268.7 6284.1 6285.4 6302.5 6131.0 6136.1 6147.5 6151.5 6161.6 4877.9 4899.2 4917.5 4966.1 4975.2 4467.3 4490.9 4492.0 4499.8 4520.6 5863.0 5865.5 5904.9 5933.1 5934.7 6118.5 6152.5 6243.2 6252.9 6304.8 5747.9 5763.3 5767.1 5776.5 5919.8 5434.5 5437.9 5447.5 5447.8 5460.7 6215.6 6246.3 6307.0 6337.1 6359.6 6254.4 6260.3 6267.7 6296.4 6303.7 6129.4 6310.4 6354.0 6365.6 6377.9 6164.0 6226.2 6245.2 6262.1 6281.8 5250.3 5845.9 6223.4 6232.7 6246.7 5262.4 6042.2 6083.1 6109.9 6133.5 5417.7 5901.4 6160.5 6164.0 6184.8 5612.6 5986.8 6001.5 6009.1 6078.5 5267.6 6018.7 6144.7 6159.1 6161.0 5547.5 6098.0 6111.8 6122.0 6135.3 05:49:03 INFO - 2015-11-24 05:49:03,884 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,884 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65325.33 Median:42596.57 stddev:131166.44 (307.9%) stddev-sans-first:131444.16 05:49:03 INFO - 2015-11-24 05:49:03,885 DEBUG : BROWSER_OUTPUT: Values: 526.5 544.4 607.5 658.5 659.7 42608.4 43009.8 43160.6 43461.0 43542.1 35236.8 35748.8 44153.0 44397.6 44639.6 9761.1 9879.4 9897.7 9919.2 9955.7 9766.6 9898.4 9909.1 9921.1 9936.2 9830.2 9885.7 9901.5 9904.0 9905.2 9801.8 9868.1 9890.3 9893.0 9897.7 9671.0 9724.0 9770.0 9789.0 9804.4 42584.8 42679.9 42849.8 43022.8 43095.0 3115.9 3224.9 3291.2 3346.5 3386.3 25083.2 29370.0 29480.0 30077.8 30099.2 2465.8 2808.0 2845.5 2874.6 2885.1 478723.6 491187.0 496248.0 496701.0 497550.0 71286.6 71366.0 71447.6 71536.6 71916.0 75362.0 76510.6 76678.0 76686.6 76756.0 15074.6 16593.3 16630.4 16667.9 16839.5 11122.8 12689.2 12930.8 12936.4 12946.6 18145.8 21365.9 21871.9 21984.6 22196.8 8094.6 8123.0 8388.9 8821.4 8822.9 966.2 995.0 1058.3 1082.3 1188.9 26060.6 30464.7 30610.0 30945.7 31211.5 1062.3 1076.0 1078.6 1081.1 1255.3 15241.6 15466.0 16296.4 16565.6 16722.5 508782.0 510552.0 516259.0 517389.0 519685.4 62643.7 62933.0 62959.7 63226.0 63350.4 1438.4 1485.5 1486.7 1494.5 1624.8 30803.4 31106.5 31271.0 31523.0 31566.1 58023.0 58516.7 58745.0 59318.0 59429.0 472766.0 473507.0 475234.0 475308.6 476143.0 32099.5 32101.0 32213.7 32454.4 32513.8 45765.4 46632.5 47026.8 47253.5 47428.5 34420.0 35406.5 36969.5 37237.1 37241.0 37857.6 38032.0 38304.7 38553.8 38710.4 32164.0 32954.8 37205.1 37328.6 37864.8 32630.7 35352.6 35546.3 35609.8 35939.5 25378.2 25559.7 25588.0 25998.7 26094.5 05:49:03 INFO - 2015-11-24 05:49:03,886 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,886 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38801.01 Median:11355.41 stddev:119709.81 (1054.2%) stddev-sans-first:120010.82 05:49:03 INFO - 2015-11-24 05:49:03,886 DEBUG : BROWSER_OUTPUT: Values: 353.4 356.7 359.4 365.7 365.9 16287.7 19849.8 19859.9 20770.0 21498.8 20259.6 20440.9 20937.4 21140.6 21193.0 5764.3 5764.8 5941.4 5954.2 5966.3 5442.1 5607.8 5618.1 5631.0 5838.8 5082.6 5231.5 5600.9 5990.3 6359.3 6249.5 6278.5 6296.6 6300.7 6331.3 4921.8 5248.8 5295.8 5463.8 5484.5 12418.9 12445.8 12575.6 12590.0 12610.7 2017.0 2033.2 2056.9 2082.4 2126.4 14848.9 15528.0 16094.0 16378.5 16663.0 1772.1 1802.8 1811.4 1860.2 1902.7 76163.1 88975.6 95598.0 99186.5 105825.0 18675.5 18843.7 18894.5 18954.7 19079.9 27552.7 27653.9 27933.0 28100.0 28131.6 10149.5 10162.1 10200.2 10211.6 10249.7 8509.7 8665.0 8722.2 8724.3 8733.7 4254.3 4342.8 8888.4 9076.1 9189.8 1545.6 1585.9 1815.9 1848.2 1878.4 875.5 898.0 913.8 971.0 1025.9 14782.6 16338.5 18152.5 20653.9 20815.9 978.8 991.4 1006.2 1008.9 1009.9 11081.1 11293.9 11325.8 11341.5 11362.0 689651.0 698250.0 708835.0 764139.0 776171.0 118071.0 119043.0 120990.2 121935.0 123476.0 1155.2 1162.7 1165.8 1168.1 1181.2 15879.3 18328.2 18335.9 18448.2 18629.5 50871.5 53336.5 53809.5 54971.0 56177.2 73764.0 73796.6 73971.6 74182.6 74713.0 9666.3 9784.6 9870.5 9883.5 9916.0 16003.8 18483.9 19378.7 19957.0 20029.9 14948.3 15365.7 15531.8 15671.8 15846.4 12094.9 15183.4 15546.7 15639.7 15671.9 15846.7 16040.2 16711.3 16722.2 17057.0 9260.8 9675.9 9727.1 9750.2 9898.6 15395.6 15636.4 15901.7 15930.6 16073.4 05:49:03 INFO - 2015-11-24 05:49:03,886 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,886 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5846.08 Median:6339.02 stddev:3000.40 (47.3%) stddev-sans-first:2991.62 05:49:03 INFO - 2015-11-24 05:49:03,887 DEBUG : BROWSER_OUTPUT: Values: 1572.7 1607.4 1883.4 1960.2 2005.6 6950.8 7088.2 7118.6 7800.6 7942.5 8222.3 8316.2 8452.2 8475.2 8479.2 2313.4 2339.7 2345.2 2354.9 2362.6 2350.8 2379.1 2387.8 2389.3 2398.5 2336.7 2364.6 2386.5 2389.6 2400.4 2357.4 2369.8 2378.6 2386.0 2386.1 2386.6 2413.9 2431.6 2435.7 2442.2 8493.4 8545.7 8576.2 8580.7 8583.4 4650.9 5125.9 5201.4 5224.6 5238.2 3215.0 3415.4 3429.9 3486.6 3494.2 1025.0 1029.5 1055.9 1070.4 1071.0 10948.4 11066.3 11081.9 11084.6 11099.9 4668.3 4682.1 4724.2 4775.5 4786.3 9825.5 9830.6 9830.9 9837.4 9897.7 5207.6 5257.3 5257.8 5269.8 5270.8 4711.2 4743.2 4746.6 4784.5 4787.8 3746.7 3804.2 3805.7 3820.9 3857.9 1263.5 1277.2 1283.7 1289.7 1290.0 1117.2 1147.7 1165.6 1169.5 1177.1 7856.7 7936.8 7939.6 7948.1 8020.3 1246.5 1247.6 1250.2 1250.8 1261.9 5935.6 6294.0 6323.7 6331.6 6346.4 9771.3 9851.3 9906.4 9954.2 9955.2 9795.5 9812.9 9816.4 9839.5 10139.8 7934.3 7965.2 8013.0 8017.0 8056.4 7865.5 7893.8 7912.6 7912.8 7920.7 7541.2 9003.5 9083.9 9218.9 9254.0 8154.8 9251.4 9509.5 9570.6 9593.0 7038.9 7104.1 7119.6 7127.9 7140.0 7905.7 8119.4 8167.8 8168.0 8175.4 7412.1 7566.9 7624.2 7779.9 7781.5 7437.7 7459.1 7475.3 7544.7 7625.8 7624.8 7687.5 7691.8 7694.5 7735.4 6971.1 7025.4 7029.5 7053.8 7058.9 5389.5 6988.8 7073.5 7090.9 7431.6 05:49:03 INFO - 2015-11-24 05:49:03,887 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,888 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6065.15 Median:6949.34 stddev:2002.64 (28.8%) stddev-sans-first:1960.94 05:49:03 INFO - 2015-11-24 05:49:03,889 DEBUG : BROWSER_OUTPUT: Values: 299.5 322.2 325.6 328.7 331.7 6835.8 6924.8 6950.6 7027.4 7036.3 6776.8 6921.4 6952.3 6963.1 6979.2 5089.1 5092.2 5095.9 5105.7 5111.4 4865.3 5095.8 5098.2 5105.5 5109.9 3863.4 4703.8 4940.8 4962.4 4973.0 4939.1 4947.3 4949.0 4956.5 4981.7 4015.1 4097.2 4113.4 4185.5 4211.8 6631.8 6649.4 6656.4 6663.9 6668.5 5897.6 5933.8 5938.3 5940.6 5944.0 7169.4 7400.9 7403.3 7405.7 7408.7 4724.7 4736.1 4745.4 4761.0 4764.8 7812.2 7876.9 7918.0 7925.2 7927.5 4605.7 4717.2 4738.7 4797.9 4805.7 4850.6 4866.2 4871.6 4871.8 4885.5 4292.0 5819.7 5875.1 5882.9 5888.1 7252.9 7492.0 7511.9 7513.2 7526.8 1684.8 1695.0 1696.8 1697.7 1700.8 1068.1 1068.5 1069.5 1080.7 1086.2 6948.1 6962.7 6997.8 7000.3 7002.7 7796.7 7801.0 7809.1 7813.8 7824.1 6743.7 6929.3 6945.2 6951.3 6957.5 4032.4 4044.4 4106.3 4111.4 4161.1 7979.8 8054.4 8087.5 8092.3 8113.8 5936.0 7022.8 8076.1 8106.0 8113.9 8064.4 8071.8 8073.7 8083.4 8139.8 7821.9 7838.8 7852.1 7854.2 7870.6 7525.4 7680.4 7691.9 7715.3 7761.9 8150.4 8158.6 8175.1 8180.7 8196.6 4456.3 4565.9 4826.6 4828.0 4845.1 7572.0 7811.0 7846.3 7870.5 7873.6 7529.2 7548.4 7559.0 7560.1 7560.6 7252.2 7486.7 7520.0 7550.0 7554.6 5903.5 7301.2 7355.2 7372.9 7392.3 6630.4 7135.3 7559.5 7564.7 7564.7 7133.5 7305.4 7308.3 7368.1 7385.2 05:49:03 INFO - 2015-11-24 05:49:03,889 DEBUG : BROWSER_OUTPUT: 05:49:03 INFO - 2015-11-24 05:49:03,889 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18618.40 Median:585.62 stddev:26130.08 (4462.0%) stddev-sans-first:26168.60 05:49:03 INFO - 2015-11-24 05:49:03,890 DEBUG : BROWSER_OUTPUT: Values: 663.4 714.3 744.4 745.9 779.9 12534.5 12917.5 15043.9 15525.5 15540.2 13212.6 14317.6 14359.6 14374.3 14383.1 752.1 764.0 921.9 936.6 961.5 917.4 938.4 944.8 946.6 953.3 874.8 988.7 998.9 1003.9 1004.7 854.2 973.7 988.1 993.9 996.4 739.8 742.6 745.2 746.9 750.0 12980.9 14823.7 14917.1 14950.3 14973.1 12567.8 12779.8 12872.4 13070.7 13158.4 10006.4 10275.4 10382.2 10593.4 10903.5 3493.1 3546.3 3573.6 3610.3 3732.1 66163.0 80742.6 81162.8 82100.6 84148.9 9514.0 9623.7 9693.6 9946.8 10317.9 21952.8 21989.0 22034.8 22058.9 22126.8 7357.7 7422.9 7474.7 7594.7 7662.7 4027.0 4032.5 4065.1 4095.3 4099.9 3403.5 3448.3 3451.2 3468.5 3470.1 609.3 623.9 624.2 642.8 645.5 522.0 523.4 553.3 578.8 610.6 8489.4 8604.4 8637.6 8852.5 8898.0 535.4 554.0 592.4 603.2 620.7 3901.8 4021.2 4064.3 4116.9 4148.8 73416.3 73476.6 96610.5 98243.0 99864.5 65187.4 66960.0 84303.6 86671.1 86974.1 54049.7 69188.0 72378.3 74584.3 76266.6 7398.6 8994.8 9005.0 9123.2 9166.8 54226.5 55074.6 55372.4 55790.7 55893.7 74986.0 76842.6 77889.1 78203.0 78885.8 10927.8 11193.3 11289.2 11367.8 11974.6 11883.8 11988.2 12030.7 12526.7 12684.1 11294.8 11483.1 11595.7 11884.9 12306.7 11257.5 11742.6 11867.3 11916.5 12290.5 10698.0 11417.0 11452.3 11485.9 12154.4 9274.9 9477.5 9626.9 9725.5 9901.3 8865.5 9939.1 9985.2 9990.5 10056.1 05:49:03 INFO - 2015-11-24 05:49:03,890 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:49:03 INFO - 2015-11-24 05:49:03,890 DEBUG : BROWSER_OUTPUT: 05:49:04 INFO - 2015-11-24 05:49:04,302 INFO : Browser exited with error code: 0 05:49:04 INFO - 2015-11-24 05:49:04,327 INFO : Completed test dromaeo_css (00:18:29) 05:49:04 INFO - 2015-11-24 05:49:04,327 INFO : Starting test kraken 05:49:04 INFO - 2015-11-24 05:49:04,328 DEBUG : operating with platform_type : mac_ 05:49:04 INFO - 2015-11-24 05:49:04,328 INFO : Initialising browser for kraken test... 05:49:04 INFO - 2015-11-24 05:49:04,340 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpehag2v/profile http://localhost:49534/getInfo.html 05:49:07 INFO - 2015-11-24 05:49:07,007 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:49:07 INFO - 2015-11-24 05:49:07,007 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:49:07 INFO - 2015-11-24 05:49:07,007 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:49:07 INFO - 2015-11-24 05:49:07,008 DEBUG : BROWSER_OUTPUT: __metrics 05:49:07 INFO - 2015-11-24 05:49:07,584 INFO : Browser initialized. 05:49:07 INFO - 2015-11-24 05:49:07,585 INFO : Running cycle 1/1 for kraken test... 05:49:07 INFO - 2015-11-24 05:49:07,585 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpehag2v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:49:19 INFO - 2015-11-24 05:49:19,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 236544000 05:49:19 INFO - 2015-11-24 05:49:19,549 DEBUG : BROWSER_OUTPUT: 05:49:22 INFO - 2015-11-24 05:49:22,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49534/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:22 INFO - 2015-11-24 05:49:22,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 249663488 05:49:22 INFO - 2015-11-24 05:49:22,981 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-24 05:49:25,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49534/tests/kraken/driver.html?testName=audio-dft) 05:49:26 INFO - 2015-11-24 05:49:26,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 259600384 05:49:26 INFO - 2015-11-24 05:49:26,311 DEBUG : BROWSER_OUTPUT: 05:49:29 INFO - 2015-11-24 05:49:29,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49534/tests/kraken/driver.html?testName=audio-fft) 05:49:30 INFO - 2015-11-24 05:49:30,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 262742016 05:49:30 INFO - 2015-11-24 05:49:30,304 DEBUG : BROWSER_OUTPUT: 05:49:32 INFO - 2015-11-24 05:49:32,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49534/tests/kraken/driver.html?testName=audio-oscillator) 05:49:32 INFO - 2015-11-24 05:49:32,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 264548352 05:49:32 INFO - 2015-11-24 05:49:32,766 DEBUG : BROWSER_OUTPUT: 05:49:34 INFO - 2015-11-24 05:49:34,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49534/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:35 INFO - 2015-11-24 05:49:35,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 265486336 05:49:35 INFO - 2015-11-24 05:49:35,438 DEBUG : BROWSER_OUTPUT: 05:49:38 INFO - 2015-11-24 05:49:38,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49534/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:38 INFO - 2015-11-24 05:49:38,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 264183808 05:49:38 INFO - 2015-11-24 05:49:38,887 DEBUG : BROWSER_OUTPUT: 05:49:41 INFO - 2015-11-24 05:49:41,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49534/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:42 INFO - 2015-11-24 05:49:42,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 263995392 05:49:42 INFO - 2015-11-24 05:49:42,407 DEBUG : BROWSER_OUTPUT: 05:49:45 INFO - 2015-11-24 05:49:45,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49534/tests/kraken/driver.html?testName=json-parse-financial) 05:49:45 INFO - 2015-11-24 05:49:45,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 264855552 05:49:45 INFO - 2015-11-24 05:49:45,878 DEBUG : BROWSER_OUTPUT: 05:49:47 INFO - 2015-11-24 05:49:47,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49534/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:49:47 INFO - 2015-11-24 05:49:47,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 265912320 05:49:47 INFO - 2015-11-24 05:49:47,974 DEBUG : BROWSER_OUTPUT: 05:49:49 INFO - 2015-11-24 05:49:49,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:49:50 INFO - 2015-11-24 05:49:50,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 265691136 05:49:50 INFO - 2015-11-24 05:49:50,468 DEBUG : BROWSER_OUTPUT: 05:49:52 INFO - 2015-11-24 05:49:52,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:49:53 INFO - 2015-11-24 05:49:53,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 265650176 05:49:53 INFO - 2015-11-24 05:49:53,090 DEBUG : BROWSER_OUTPUT: 05:49:55 INFO - 2015-11-24 05:49:55,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:56 INFO - 2015-11-24 05:49:56,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 265244672 05:49:56 INFO - 2015-11-24 05:49:56,296 DEBUG : BROWSER_OUTPUT: 05:49:58 INFO - 2015-11-24 05:49:58,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:59 INFO - 2015-11-24 05:49:59,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 265969664 05:49:59 INFO - 2015-11-24 05:49:59,392 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49534/tests/kraken/driver.html?testName=ai-astar) 05:50:01 INFO - 2015-11-24 05:50:01,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 266002432 05:50:01 INFO - 2015-11-24 05:50:01,264 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,264 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:50:01 INFO - 2015-11-24 05:50:01,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:50:01 INFO - 2015-11-24 05:50:01,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;143;167;163;115;127;113;115;119;149 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;129;158;176;132;175;175;156;157;124 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |2;audio-dft;193;224;205;210;267;273;192;222;167;198 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |3;audio-fft;62;66;73;125;56;55;58;58;75;82 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;81;63;127;112;96;63;119;71;84;140 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;127;89;89;75;134;91;93;124;89;90 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;98;96;96;135;95;96;96;118;151;96 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;99;149;151;92;99;91;93;91;91;91 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;60;59;60;59;58;59;66;59;57 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;65;66;80;100;67;97;59;67 05:50:01 INFO - 2015-11-24 05:50:01,265 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;83;85;81;85;82;87;84 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;127;131;119;138;142;131;126;157;130 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;139;141;136;147;130;161;181;141;137 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;68;67;65;66;67;66;67;65 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,828 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373001260__endTimestamp 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,266 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:132.40 Median:135.00 stddev:21.31 (15.8%) stddev-sans-first:21.42 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: Values: 113.0 143.0 167.0 163.0 115.0 127.0 113.0 115.0 119.0 149.0 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.70 Median:157.50 stddev:19.63 (12.5%) stddev-sans-first:20.62 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: Values: 145.0 129.0 158.0 176.0 132.0 175.0 175.0 156.0 157.0 124.0 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:215.10 Median:216.00 stddev:33.21 (15.4%) stddev-sans-first:34.25 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: Values: 193.0 224.0 205.0 210.0 267.0 273.0 192.0 222.0 167.0 198.0 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.00 Median:64.00 stddev:21.03 (32.9%) stddev-sans-first:22.06 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: Values: 62.0 66.0 73.0 125.0 56.0 55.0 58.0 58.0 75.0 82.0 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,267 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:95.60 Median:67.00 stddev:27.59 (41.2%) stddev-sans-first:28.76 05:50:01 INFO - 2015-11-24 05:50:01,268 DEBUG : BROWSER_OUTPUT: Values: 81.0 63.0 127.0 112.0 96.0 63.0 119.0 71.0 84.0 140.0 05:50:01 INFO - 2015-11-24 05:50:01,268 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,268 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:100.10 Median:89.00 stddev:20.22 (22.7%) stddev-sans-first:18.96 05:50:01 INFO - 2015-11-24 05:50:01,268 DEBUG : BROWSER_OUTPUT: Values: 127.0 89.0 89.0 75.0 134.0 91.0 93.0 124.0 89.0 90.0 05:50:01 INFO - 2015-11-24 05:50:01,268 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,269 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:107.70 Median:96.00 stddev:20.18 (21.0%) stddev-sans-first:21.10 05:50:01 INFO - 2015-11-24 05:50:01,269 DEBUG : BROWSER_OUTPUT: Values: 98.0 96.0 96.0 135.0 95.0 96.0 96.0 118.0 151.0 96.0 05:50:01 INFO - 2015-11-24 05:50:01,269 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,269 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:104.70 Median:91.50 stddev:24.08 (26.3%) stddev-sans-first:25.46 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: Values: 99.0 149.0 151.0 92.0 99.0 91.0 93.0 91.0 91.0 91.0 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.00 stddev:2.46 (4.2%) stddev-sans-first:2.55 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: Values: 58.0 60.0 59.0 60.0 59.0 58.0 59.0 66.0 59.0 57.0 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:66.50 stddev:14.27 (21.5%) stddev-sans-first:14.89 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 66.0 80.0 100.0 67.0 97.0 59.0 67.0 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:85.00 stddev:1.76 (2.1%) stddev-sans-first:1.83 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 83.0 85.0 81.0 85.0 82.0 87.0 84.0 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:131.00 stddev:10.84 (8.3%) stddev-sans-first:11.06 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: Values: 124.0 127.0 131.0 119.0 138.0 142.0 131.0 126.0 157.0 130.0 05:50:01 INFO - 2015-11-24 05:50:01,270 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,271 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:141.00 stddev:15.12 (10.7%) stddev-sans-first:15.76 05:50:01 INFO - 2015-11-24 05:50:01,271 DEBUG : BROWSER_OUTPUT: Values: 137.0 139.0 141.0 136.0 147.0 130.0 161.0 181.0 141.0 137.0 05:50:01 INFO - 2015-11-24 05:50:01,271 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,271 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 05:50:01 INFO - 2015-11-24 05:50:01,271 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 68.0 67.0 65.0 66.0 67.0 66.0 67.0 65.0 05:50:01 INFO - 2015-11-24 05:50:01,271 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:50:01 INFO - 2015-11-24 05:50:01,271 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-24 05:50:01,864 INFO : Browser exited with error code: 0 05:50:01 INFO - 2015-11-24 05:50:01,911 INFO : Completed test kraken (00:00:57) 05:50:01 INFO - 2015-11-24 05:50:01,911 INFO : Starting test v8_7 05:50:01 INFO - 2015-11-24 05:50:01,911 DEBUG : operating with platform_type : mac_ 05:50:01 INFO - 2015-11-24 05:50:01,911 INFO : Initialising browser for v8_7 test... 05:50:01 INFO - 2015-11-24 05:50:01,924 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpOw_Nak/profile http://localhost:49534/getInfo.html 05:50:04 INFO - 2015-11-24 05:50:04,831 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:50:04 INFO - 2015-11-24 05:50:04,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:50:04 INFO - 2015-11-24 05:50:04,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:50:04 INFO - 2015-11-24 05:50:04,832 DEBUG : BROWSER_OUTPUT: __metrics 05:50:05 INFO - 2015-11-24 05:50:05,462 INFO : Browser initialized. 05:50:05 INFO - 2015-11-24 05:50:05,462 INFO : Running cycle 1/1 for v8_7 test... 05:50:05 INFO - 2015-11-24 05:50:05,462 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpOw_Nak/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:50:17 INFO - 2015-11-24 05:50:17,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 238415872 05:50:17 INFO - 2015-11-24 05:50:17,317 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49534/tests/v8_7/run.html (next: http://localhost:49534/tests/v8_7/run.html) 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 248147968 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: |0;Richards;176.14937466971992 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;158.60428231562253 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.7380410022779 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4868.9320388349515 05:50:38 INFO - 2015-11-24 05:50:38,988 DEBUG : BROWSER_OUTPUT: |4;RayTrace;943.3962264150944 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: |5;Earley;717.8750897343862 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: |7;RegExp;27162.162162162163 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: |8;Splay;660.9385327164574 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4691.588785046729 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373038981__endTimestamp 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.15 Median:176.15 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: Values: 176.1 05:50:38 INFO - 2015-11-24 05:50:38,989 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:158.60 Median:158.60 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: Values: 158.6 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.74 Median:284.74 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: Values: 284.7 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: Values: 4868.9 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:943.40 Median:943.40 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: Values: 943.4 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.88 Median:717.88 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: Values: 717.9 05:50:38 INFO - 2015-11-24 05:50:38,990 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: Values: 12512.5 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: Values: 27162.2 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:660.94 Median:660.94 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: Values: 660.9 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4691.59 Median:4691.59 stddev:0.00 (0.0%) 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: Values: 4691.6 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:50:38 INFO - 2015-11-24 05:50:38,991 DEBUG : BROWSER_OUTPUT: 05:50:39 INFO - 2015-11-24 05:50:39,719 INFO : Browser exited with error code: 0 05:50:39 INFO - 2015-11-24 05:50:39,737 INFO : Completed test v8_7 (00:00:37) 05:50:40 INFO - 2015-11-24 05:50:40,109 INFO : Completed test suite (00:20:05) 05:50:40 INFO - 2015-11-24 05:50:40,109 DEBUG : Working with test: dromaeo_css 05:50:40 INFO - 2015-11-24 05:50:40,110 DEBUG : Generating results file: dromaeo_css 05:50:40 INFO - 2015-11-24 05:50:40,110 DEBUG : Working with test: kraken 05:50:40 INFO - 2015-11-24 05:50:40,111 DEBUG : Generating results file: kraken 05:50:40 INFO - 2015-11-24 05:50:40,111 INFO : javascript benchmark 05:50:40 INFO - 2015-11-24 05:50:40,111 DEBUG : Working with test: v8_7 05:50:40 INFO - 2015-11-24 05:50:40,111 DEBUG : Generating results file: v8_7 05:50:40 INFO - 2015-11-24 05:50:40,111 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:40 INFO - 2015-11-24 05:50:40,514 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 05:50:40 INFO - 2015-11-24 05:50:40,514 DEBUG : process_Request line: dromaeo_css 7784.23 graph.html#tests=[[72,64,61]] 05:50:40 INFO - 2015-11-24 05:50:40,514 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:40 INFO - 2015-11-24 05:50:40,546 DEBUG : process_Request line: kraken 1540.10 graph.html#tests=[[232,64,61]] 05:50:40 INFO - 2015-11-24 05:50:40,546 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:40 INFO - 2015-11-24 05:50:40,575 DEBUG : process_Request line: v8_7 21646.90 graph.html#tests=[[230,64,61]] 05:50:40 INFO - 2015-11-24 05:50:40,576 INFO : javascript benchmark 05:50:40 INFO - 2015-11-24 05:50:40,578 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3425.7430692698044, 3463.2034632034647, 3479.1650003999034, 3480.095175254433, 3517.243792584594, 5825.446582574654, 5842.415758424161, 5870.70646467677, 5880.647161170333, 5890.88218235635, 5595.18869763884, 5729.770809167629, 5733.397993210715, 5746.913796293059, 5747.2528571285775, 4361.738295702252, 5130.846074617767, 5161.483851614846, 5187.9740601297035, 5281.630285879971, 5318.946810531903, 5348.358197016363, 5356.91964620531, 5366.436524164965, 5379.031774280628, 698.1594173448979, 5234.502722241381, 5235.816746413857, 5317.787288508455, 5396.19057141428, 4682.438107427097, 5281.524662780368, 5296.285001524822, 5301.787928482856, 5323.254744335796, 5231.494110353378, 5233.9738301308635, 5235.764390602432, 5276.7889284428575, 5307.628466007381, 5347.598930080259, 5428.104362780136, 5670.206171136044, 5830.300363956352, 5870.823875283749, 6242.6878656067465, 6252.2809876864285, 6258.030005349178, 6262.561620686553, 6268.216472940882, 6293.559450838443, 6295.2760432550385, 6301.779437719703, 6314.210723659543, 6318.905216421757, 5772.480476757112, 5923.792667256668, 5935.910961335583, 5948.851278718023, 6051.243594550681, 6269.435750782452, 6273.560850740496, 6402.0, 6402.423781859655, 6429.9678501607195, 6234.5635805494085, 6242.28213755424, 6244.063390491372, 6271.059341098871, 6288.779892703734, 6131.50947924165, 6209.254889413209, 6246.469050130699, 6266.561340706198, 6295.842603934847, 6161.599496032743, 6268.749250030039, 6284.057391391328, 6285.43431091204, 6302.527310451735, 6131.0, 6136.110264011693, 6147.538934579924, 6151.5386346024225, 6161.599496032743, 4877.878053048702, 4899.191633380524, 4917.459079501252, 4966.056449274626, 4975.179095449283, 4467.262901621196, 4490.887727806766, 4492.034212644232, 4499.842505512292, 4520.61574766142, 5863.0325996211, 5865.501432378211, 5904.852378690567, 5933.1396947443245, 5934.673592952343, 6118.527810132473, 6152.538559608047, 6243.219597550306, 6252.906206406908, 6304.810855674337, 5747.913781293284, 5763.337216220189, 5767.134929760486, 5776.451237132465, 5919.792807251725, 5434.538064264502, 5437.891242175135, 5447.455254474521, 5447.754851031713, 5460.6996615186545, 6215.627062376272, 6246.281677607042, 6307.0, 6337.112804207322, 6359.618422894641, 6254.374562543891, 6260.311365749672, 6267.686615669107, 6296.401841825019, 6303.684815759286, 6129.389354848233, 6310.432061114522, 6354.0, 6365.61806291624, 6377.936220637735, 6163.96918015407, 6226.159468471698, 6245.219347581552, 6262.123302737529, 6281.842953926006, 5250.317458730493, 5845.88928103659, 6223.37766223374, 6232.688365581612, 6246.718897649525, 5262.394824595221, 6042.1843051187525, 6083.117947897618, 6109.877802444015, 6133.539984501091, 5417.7268341938825, 5901.380355062828, 6160.476359509492, 6164.0, 6184.81445556616, 5612.607117501736, 5986.790462333797, 6001.459868611846, 6009.098635204754, 6078.54410919174, 5267.552258058108, 6018.699065046642, 6144.692765361625, 6159.07613857907, 6160.969195153995, 5547.5007249347755, 6097.97841994295, 6111.834843226386, 6122.001753127839, 6135.263289243823], "unit": "ms", "name": "dojo.html", "value": 5690.400343146279}, {"lowerIsBetter": false, "replicates": [526.4814158054315, 544.3982503419417, 607.5079185859457, 658.4929604204763, 659.7064306383659, 42608.36087458687, 43009.78495107528, 43160.56839431605, 43461.0, 43542.12915741687, 35236.82381588095, 35748.82125589369, 44153.0, 44397.55602443975, 44639.553604463945, 9761.07269809367, 9879.407235565854, 9897.65358212459, 9919.156871665917, 9955.651552195675, 9766.560504777266, 9898.356606820533, 9909.108180263775, 9921.057499537532, 9936.155426788731, 9830.164436022947, 9885.654002109928, 9901.455419951899, 9904.0, 9905.158061564776, 9801.803963920718, 9868.111869931705, 9890.258230632659, 9892.950535247277, 9897.653582124663, 9670.951645241728, 9723.951380243054, 9770.022997700244, 9788.951055244679, 9804.36271642341, 42584.78707606442, 42679.93300167489, 42849.78575107136, 43022.784886075366, 43095.0, 3115.8597863096215, 3224.9355012899846, 3291.193657553915, 3346.4645656695056, 3386.291781829752, 25083.24750257495, 29370.0, 29480.0, 30077.849610752026, 30099.247518812204, 2465.7657522535333, 2807.9578806317922, 2845.530487469565, 2874.583185438121, 2885.0623547347195, 478723.60638196935, 491187.0, 496248.0, 496701.0, 497550.0, 71286.64356678183, 71366.0, 71447.64276178586, 71536.64231678809, 71916.0, 75362.0, 76510.61744691241, 76678.0, 76686.61656691681, 76756.0, 15074.623134421508, 16593.253303601366, 16630.417935372203, 16667.916660416864, 16839.494815155565, 11122.833157502644, 12689.238645681104, 12930.806037909439, 12936.353182340845, 12946.611601651966, 18145.81854181468, 21365.931703414768, 21871.890640546695, 21984.560308793734, 22196.77917714541, 8094.61707964209, 8123.0, 8388.8741668875, 8821.38250322484, 8822.911770882209, 966.2366730283138, 994.9602015919282, 1058.2750815691277, 1082.3235477826358, 1188.9240237585, 26060.60909086365, 30464.695353046187, 30610.0, 30945.69054309473, 31211.531827022613, 1062.3201151263197, 1076.0, 1078.577830893331, 1081.1080858291941, 1255.2970336611527, 15241.618959525878, 15466.0, 16296.429624963306, 16565.58586035359, 16722.498325050266, 508782.0, 510552.0, 516259.0, 517389.0, 519685.4015729897, 62643.686781566714, 62933.0, 62959.6852015737, 63226.0, 63350.366496335366, 1438.3671184678917, 1485.5394827603477, 1486.710091532141, 1494.521753039039, 1624.7806546116124, 30803.383932321678, 31106.533401998535, 31271.0, 31523.0, 31566.053018409486, 58023.0, 58516.70741646265, 58745.0, 59318.0, 59429.0, 472766.0, 473507.0, 475234.0, 475308.6234568805, 476143.0, 32099.518507221943, 32101.03696889097, 32213.677863222005, 32454.35091298208, 32513.837430812695, 45765.39821106246, 46632.533674662816, 47026.76486617545, 47253.52746472491, 47428.52571474241, 34420.011403922355, 35406.468902965964, 36969.53399663344, 37237.069073273386, 37241.0, 37857.62142378541, 38032.0, 38304.659336923076, 38553.80723096366, 38710.41934371043, 32164.03507894767, 32954.83522582372, 37205.069873253386, 37328.62671373251, 37864.81067594644, 32630.673693262765, 35352.64647353494, 35546.28907421786, 35609.82195089111, 35939.46090808588, 25378.238652840446, 25559.74440255648, 25588.0, 25998.740012599632, 26094.478110438064], "unit": "ms", "name": "ext.html", "value": 20526.52935965432}, {"lowerIsBetter": false, "replicates": [353.4450912068053, 356.7110640381293, 359.38903863432154, 365.7056069863759, 365.8774310605947, 16287.674246515093, 19849.801501984977, 19859.900700496495, 20769.9615019249, 21498.785012149874, 20259.594808103866, 20440.897795511002, 20937.37187884366, 21140.57718845622, 21193.046312915918, 5764.279465066867, 5764.827055188351, 5941.435563621449, 5954.2259506264345, 5966.284045914496, 5442.074847275952, 5607.831765047055, 5618.073017952033, 5630.971845140769, 5838.824835254949, 5082.567981721558, 5231.476852314757, 5600.943990560103, 5990.311114221855, 6359.332270111618, 6249.531285153632, 6278.466330361902, 6296.559240853165, 6300.653464059475, 6331.33520980295, 4921.827736029258, 5248.8425347239645, 5295.814646487393, 5463.808766693186, 5484.533814625762, 12418.937905310415, 12445.751084978341, 12575.622731318075, 12590.0, 12610.74778504434, 2016.9596608067757, 2033.1765634917733, 2056.9272839777323, 2082.3961051295105, 2126.4258650164525, 14848.851511484854, 15528.0, 16094.0, 16378.508644740677, 16663.0, 1772.1139430284857, 1802.7566278552358, 1811.4022372617005, 1860.1815201311379, 1902.6860568006261, 76163.09592260183, 88975.55512222463, 95598.0, 99186.51220231703, 105825.0, 18675.533111672317, 18843.71734423985, 18894.527636808914, 18954.715679264824, 19079.904600476908, 27552.724472755017, 27653.86173069162, 27933.022344217854, 28100.0, 28131.57802632921, 10149.492525373702, 10162.085412312927, 10200.183985281308, 10211.642592509226, 10249.74375640615, 8509.702160424355, 8665.046844847062, 8722.215000649972, 8724.302055835518, 8733.737987860375, 4254.298040823292, 4342.761148136883, 8888.37781355312, 9076.092390761003, 9189.81620367589, 1545.5981444824426, 1585.9444919427765, 1815.9273629054953, 1848.2145088337402, 1878.4176905159445, 875.50096445027, 897.9865302020474, 913.848550825964, 970.9951450242845, 1025.8615086963164, 14782.556523304318, 16338.529532341909, 18152.45542633723, 20653.89673051625, 20815.895920520605, 978.7781735460464, 991.439836492394, 1006.2201793609864, 1008.8839783424853, 1009.8535712321819, 11081.113510919107, 11293.94353028246, 11325.773484530264, 11341.546338146547, 11362.0, 689651.0, 698250.0, 708835.0, 764139.0, 776171.0, 118071.0, 119043.0, 120990.18514722286, 121935.0, 123476.0, 1155.1682788392345, 1162.7325715085578, 1165.8251262310553, 1168.094726586902, 1181.2381014245934, 15879.28543215535, 18328.17523211432, 18335.891372492333, 18448.169832357846, 18629.534261643566, 50871.491285086675, 53336.46663533315, 53809.46190538044, 54971.0, 56177.15734264071, 73764.0, 73796.63101684458, 73971.63014184895, 74182.62908685423, 74713.0, 9666.275029372684, 9784.559694813608, 9870.506474676382, 9883.505824708593, 9916.0, 16003.839961600235, 18483.890966541512, 19378.709319360503, 19957.0, 20029.899850500653, 14948.327325270171, 15365.69268614599, 15531.76702349443, 15671.843281567039, 15846.44537441184, 12094.943859543722, 15183.392664293304, 15546.689066218387, 15639.748820094594, 15671.921640391725, 15846.683066338379, 16040.235574087075, 16711.331546737994, 16722.247498862336, 17057.0, 9260.768480787765, 9675.9032409675, 9727.124558789743, 9750.219982401533, 9898.604055837974, 15395.61510962235, 15636.374545018527, 15901.681966360838, 15930.60173495672, 16073.35706571724], "unit": "ms", "name": "jquery.html", "value": 10487.880166632995}, {"lowerIsBetter": false, "replicates": [1572.7404978178602, 1607.4454313261924, 1883.4255552056625, 1960.2257108442175, 2005.6089062632793, 6950.791476255714, 7088.18485874124, 7118.572885626866, 7800.5709685967395, 7942.523448593074, 8222.301104406119, 8316.2099600538, 8452.154784521545, 8475.194856488624, 8479.236868681817, 2313.421644588853, 2339.7426283108844, 2345.167465549731, 2354.8704821234824, 2362.598358279097, 2350.811935045192, 2379.0721618568773, 2387.7612238776155, 2389.307100940725, 2398.5322862041908, 2336.7312759032675, 2364.598018336887, 2386.4988352446007, 2389.6415537669313, 2400.411899084718, 2357.351728274721, 2369.751176126499, 2378.5837478441204, 2385.95228095438, 2386.1052105460453, 2386.6181410974336, 2413.9034438622434, 2431.5744744669614, 2435.7442468540903, 2442.1940759549307, 8493.447925884859, 8545.658173673046, 8576.185262400062, 8580.742577722678, 8583.399162058658, 4650.883727906796, 5125.897482050375, 5201.375834899836, 5224.63427560071, 5238.188080847474, 3214.983925080383, 3415.351083294166, 3429.879954201591, 3486.6164721880573, 3494.196334842975, 1024.9846252306222, 1029.5212726082407, 1055.883852776194, 1070.4487189097622, 1070.9678709638724, 10948.3978381189, 11066.336019838835, 11081.889181108167, 11084.61203857861, 11099.945505176995, 4668.305874154001, 4682.1338052460405, 4724.173269677793, 4775.474697783241, 4786.305985632064, 9825.508724563742, 9830.557624906753, 9830.901690983143, 9837.360571562825, 9897.703068907944, 5207.557357624644, 5257.290265814143, 5257.8159764408065, 5269.762860671279, 5270.789168433296, 4711.246200607886, 4743.217369134054, 4746.620270378361, 4784.473707892129, 4787.832425865078, 3746.6628003479273, 3804.2201348723447, 3805.7145714071003, 3820.9426858597144, 3857.9421308680394, 1263.4946021591254, 1277.2464246094662, 1283.6790802299424, 1289.7420515896858, 1289.9806502902463, 1117.1732917640886, 1147.6614398752388, 1165.6211731187398, 1169.4854264123758, 1177.14068729826, 7856.7250146244605, 7936.761897143095, 7939.563324017235, 7948.085970113511, 8020.318272946864, 1246.4577908609783, 1247.5508816825936, 1250.1998720818683, 1250.762355152518, 1261.917975331619, 5935.643861368246, 6293.96853015732, 6323.747050117944, 6331.620102793847, 6346.428821406095, 9771.267154963407, 9851.310408271496, 9906.356086854332, 9954.153896918699, 9955.153811926068, 9795.461249631197, 9812.901870981199, 9816.411015339103, 9839.508024598741, 10139.847902281472, 7934.2859142677435, 7965.203479651988, 8013.038435387907, 8017.037955445384, 8056.436049476598, 7865.488743231672, 7893.802654933443, 7912.643931023003, 7912.802179945547, 7920.722774703088, 7541.208173141741, 9003.51442012087, 9083.863742043743, 9218.861717074384, 9253.982061973044, 8154.796130096795, 9251.398659087137, 9509.476978766234, 9570.56932438028, 9593.040695930351, 7038.894416583653, 7104.076470058859, 7119.644017799193, 7127.928720712726, 7139.964300178466, 7905.723299684483, 8119.39104567148, 8167.79580510492, 8168.019837619524, 8175.427720059539, 7412.147603025721, 7566.924330756622, 7624.161342252459, 7779.922200778146, 7781.455298129076, 7437.702491900263, 7459.067616547932, 7475.289847464483, 7544.698212071675, 7625.771226863203, 7624.847503049797, 7687.5387476751575, 7691.769246922601, 7694.461387702807, 7735.419843511647, 6971.093757811452, 7025.437964962688, 7029.5430796998035, 7053.823654408681, 7058.894116588358, 5389.541888939484, 6988.755393561201, 7073.469489788389, 7090.893636595352, 7431.5912624804], "unit": "ms", "name": "mootools.html", "value": 4811.19051450011}, {"lowerIsBetter": false, "replicates": [299.45947564645815, 322.247551966159, 325.61414723552576, 328.65162927297075, 331.69981167043835, 6835.7607483738075, 6924.792256232308, 6950.617716025617, 7027.437804975602, 7036.331548502891, 6776.762813301535, 6921.411680007205, 6952.304769523058, 6963.094797676307, 6979.162500499934, 5089.134847075997, 5092.236164575324, 5095.923561146567, 5105.668131571455, 5111.361079865017, 4865.343178670887, 5095.847124586268, 5098.184290513518, 5105.489451054883, 5109.923351149717, 3863.4398012288343, 4703.764811759415, 4940.827071052514, 4962.354893863792, 4972.950270497303, 4939.110960027194, 4947.257911313296, 4949.0, 4956.529129732688, 4981.701097934099, 4015.136745599681, 4097.180563887235, 4113.382992551112, 4185.4977402711565, 4211.768352740598, 6631.834204144935, 6649.434798042173, 6656.400923916871, 6663.9333606663795, 6668.533202675814, 5897.557683173779, 5933.792317268918, 5938.317093534256, 5940.584159108864, 5944.019236825919, 7169.354758071747, 7400.925990740077, 7403.296686814744, 7405.703771849119, 7408.666610002563, 4724.692894961817, 4736.147493451177, 4745.406824146981, 4761.023990082025, 4764.761761911891, 7812.218778122199, 7876.881846772303, 7918.049834019955, 7925.247101525403, 7927.484713493604, 4605.700629459075, 4717.150912835654, 4738.668293219442, 4797.856064318076, 4805.687630304019, 4850.6362022848425, 4866.245731911559, 4871.634627402959, 4871.806407430202, 4885.5358740919555, 4292.012837047497, 5819.709014549256, 5875.11873219012, 5882.911756323659, 5888.116782482662, 7252.948322493209, 7491.9625401872645, 7511.887321690179, 7513.2111128330735, 7526.849463010819, 1684.839940205703, 1695.0423010998745, 1696.8133505314406, 1697.694415005311, 1700.8129105798353, 1068.0707784227773, 1068.4817863336275, 1069.4706120470416, 1080.6541906589816, 1086.179934149712, 6948.062011628466, 6962.686679099453, 6997.825054373681, 7000.264972177848, 7002.719891204295, 7796.727114550963, 7801.0, 7809.101953275333, 7813.804654883674, 7824.100228473799, 6743.662816859138, 6929.3070692930305, 6945.201301850251, 6951.270116637781, 6957.547759395623, 4032.3951407288555, 4044.4135600337786, 4106.301928672073, 4111.403846442249, 4161.10536234711, 7979.800504987305, 8054.355651547862, 8087.47431416956, 8092.3121534669035, 8113.7565873023905, 5935.970320148458, 7022.824429389306, 8076.111627720946, 8106.0, 8113.8782918256275, 8064.354851611857, 8071.757847264592, 8073.717419890276, 8083.393745469113, 8139.79650508742, 7821.92178078212, 7838.804029899298, 7852.057753069668, 7854.2145785421, 7870.645820937957, 7525.36034437079, 7680.423968202295, 7691.923080769121, 7715.267049630276, 7761.922380776346, 8150.388720846079, 8158.632861521127, 8175.141610131089, 8180.713675021346, 8196.59017049157, 4456.286994080931, 4565.949831538831, 4826.58973987215, 4828.0, 4845.127876982177, 7572.0, 7810.960945195465, 7846.293833555007, 7870.488418253024, 7873.645685944261, 7529.1717911028645, 7548.3961283098315, 7559.017327747358, 7560.054993125859, 7560.6219689016425, 7252.166000909963, 7486.663100160397, 7520.0, 7550.0, 7554.602398556284, 5903.498202652822, 7301.233370496234, 7355.154157271768, 7372.852542949218, 7392.260773922565, 6630.370114839083, 7135.286471353031, 7559.508631938907, 7564.697412103455, 7564.735234266775, 7133.500654954103, 7305.379042781423, 7308.30571095745, 7368.115826100902, 7385.150707668472], "unit": "ms", "name": "prototype.html", "value": 5383.257061979315}, {"lowerIsBetter": false, "replicates": [663.4360793325673, 714.3499415531867, 744.4081954845899, 745.8843879198727, 779.8947142135817, 12534.49862005521, 12917.483300667962, 15043.924780376097, 15525.456609018687, 15540.222988850555, 13212.603621891334, 14317.570472885804, 14359.569212923629, 14374.281285935687, 14383.137011779301, 752.0636807175075, 763.9579823109726, 921.8709380686726, 936.6347124621403, 961.471190845036, 917.4495302818289, 938.3572253006678, 944.7543638653965, 946.6497395963469, 953.2516974175273, 874.8294082653885, 988.6786794291847, 998.8801343838713, 1003.8694969653972, 1004.7337455574278, 854.1543871567135, 973.7322236385015, 988.1452543549849, 993.9155171810369, 996.4469719305782, 739.8446326271489, 742.6175519607407, 745.1579714922103, 746.8991686122413, 750.0, 12980.870191298154, 14823.703525929528, 14917.104973701613, 14950.32723527433, 14973.1016139032, 12567.811482827765, 12779.808302875465, 12872.356382180948, 13070.738585228242, 13158.407871645799, 10006.385568614909, 10275.38347699133, 10382.22133339995, 10593.364398136137, 10903.454827258605, 3493.0568746438576, 3546.3261980223933, 3573.6069032406413, 3610.332088563598, 3732.0669832541867, 66163.00755488672, 80742.59628701818, 81162.78255826108, 82100.58949705273, 84148.89627759233, 9513.952430237943, 9623.663171788954, 9693.563789629483, 9946.80106397868, 10317.9484102579, 21952.780472195394, 21989.010494527785, 22034.779652203593, 22058.8970551475, 22126.77873221247, 7357.705691772377, 7422.888656670154, 7474.663640136207, 7594.734184303634, 7662.65518051689, 4027.013381721497, 4032.4556184915245, 4065.1259979104043, 4095.3242714952294, 4099.877003689894, 3403.4724617684296, 3448.2930999145115, 3451.2062225688233, 3468.4623883298127, 3470.1151206442196, 609.3023488106094, 623.9220097487814, 624.2353117431111, 642.7846671365052, 645.502962718704, 522.0446582753552, 523.3510447045636, 553.2558708537011, 578.8408187748319, 610.6305685060563, 8489.36329775257, 8604.35467339952, 8637.568121593895, 8852.468851868909, 8897.976732675825, 535.4297672978265, 553.9750711218005, 592.3957563285425, 603.2007589943343, 620.6958590290725, 3901.765894046366, 4021.2158629067053, 4064.3293856513937, 4116.938245926313, 4148.8340466381005, 73416.26583734094, 73476.63261683658, 96610.51694741481, 98243.0, 99864.5033874159, 65187.414692191436, 66960.0, 84303.57848210842, 86671.13328866757, 86974.1302586966, 54049.72975135099, 69188.0, 72378.2762172382, 74584.25415745773, 76266.61866690632, 7398.556086634819, 8994.775130621787, 9004.954975225082, 9123.178913897782, 9166.770830729285, 54226.45773542214, 55074.62313442196, 55372.44627553673, 55790.72104639613, 55893.720531397084, 74986.0, 76842.61578692071, 77889.05277367885, 78203.0, 78885.8167127482, 10927.781444371227, 11193.27243729155, 11289.20975531705, 11367.829482557603, 11974.64076077719, 11883.82174267404, 11988.220765650205, 12030.699232519257, 12526.749465010831, 12684.112112152061, 11294.774104518028, 11483.138764592855, 11595.710107247387, 11884.881151188723, 12306.692332691397, 11257.493412796608, 11742.58900938463, 11867.287962722265, 11916.52333906634, 12290.508379664714, 10698.0, 11417.029552488131, 11452.255603385753, 11485.942570287096, 12154.392280386122, 9274.860877086983, 9477.478738669164, 9626.90373096288, 9725.513724313898, 9901.257405694745, 8865.512396818236, 9939.105480506789, 9985.201183905416, 9990.484778135924, 10056.094951454405], "unit": "ms", "name": "yui.html", "value": 7011.560770886984}], "name": "dromaeo_css", "value": 7784.23446145751}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 143.0, 167.0, 163.0, 115.0, 127.0, 113.0, 115.0, 119.0, 149.0], "unit": "ms", "name": "ai-astar", "value": 132.4}, {"lowerIsBetter": true, "replicates": [145.0, 129.0, 158.0, 176.0, 132.0, 175.0, 175.0, 156.0, 157.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [193.0, 224.0, 205.0, 210.0, 267.0, 273.0, 192.0, 222.0, 167.0, 198.0], "unit": "ms", "name": "audio-dft", "value": 215.1}, {"lowerIsBetter": true, "replicates": [62.0, 66.0, 73.0, 125.0, 56.0, 55.0, 58.0, 58.0, 75.0, 82.0], "unit": "ms", "name": "audio-fft", "value": 71.0}, {"lowerIsBetter": true, "replicates": [81.0, 63.0, 127.0, 112.0, 96.0, 63.0, 119.0, 71.0, 84.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 95.6}, {"lowerIsBetter": true, "replicates": [127.0, 89.0, 89.0, 75.0, 134.0, 91.0, 93.0, 124.0, 89.0, 90.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 100.1}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 96.0, 135.0, 95.0, 96.0, 96.0, 118.0, 151.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 107.7}, {"lowerIsBetter": true, "replicates": [99.0, 149.0, 151.0, 92.0, 99.0, 91.0, 93.0, 91.0, 91.0, 91.0], "unit": "ms", "name": "imaging-desaturate", "value": 104.7}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 59.0, 60.0, 59.0, 58.0, 59.0, 66.0, 59.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 80.0, 100.0, 67.0, 97.0, 59.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 73.3}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 83.0, 85.0, 81.0, 85.0, 82.0, 87.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [124.0, 127.0, 131.0, 119.0, 138.0, 142.0, 131.0, 126.0, 157.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 132.5}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 141.0, 136.0, 147.0, 130.0, 161.0, 181.0, 141.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 68.0, 67.0, 65.0, 66.0, 67.0, 66.0, 67.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1540.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [176.14937466971992], "unit": "score", "name": "Richards", "value": 200.40945399999995}, {"lowerIsBetter": false, "replicates": [158.60428231562253], "unit": "score", "name": "DeltaBlue", "value": 416.8739899999998}, {"lowerIsBetter": false, "replicates": [284.7380410022779], "unit": "score", "name": "Encrypt", "value": 934.8276720000003}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "Decrypt", "value": 54.669278165503506}, {"lowerIsBetter": false, "replicates": [943.3962264150944], "unit": "score", "name": "RayTrace", "value": 784.3883400000002}, {"lowerIsBetter": false, "replicates": [717.8750897343862], "unit": "score", "name": "Earley", "value": 928.3829590000004}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [27162.162162162163], "unit": "score", "name": "RegExp", "value": 33.538751243781114}, {"lowerIsBetter": false, "replicates": [660.9385327164574], "unit": "score", "name": "Splay", "value": 123.29588300000003}, {"lowerIsBetter": false, "replicates": [4691.588785046729], "unit": "score", "name": "NavierStokes", "value": 316.31075697211134}], "name": "v8_7", "value": 21646.902147130608}]} 05:50:40 INFO - RETURN: dromaeo_css: 7784.23 05:50:40 INFO - RETURN: kraken: 1540.10 05:50:40 INFO - RETURN: v8_7: 21646.90 05:50:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21646.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1540.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7784.23"}}} 05:50:40 INFO - Return code: 0 05:50:40 INFO - # TBPL SUCCESS # 05:50:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:50:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:50:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:50:40 INFO - 2015-11-24 05:50:40.659 screenresolution[2006:16857] starting screenresolution argv=screenresolution get 05:50:40 INFO - 2015-11-24 05:50:40.662 screenresolution[2006:16857] Display 0: 1600x1200x32@60 05:50:40 INFO - 2015-11-24 05:50:40.668 screenresolution[2007:16860] starting screenresolution argv=screenresolution list 05:50:40 INFO - Available Modes on Display 0 05:50:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:50:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:50:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:50:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:50:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:50:40 INFO - Intel Iris: 05:50:40 INFO - Chipset Model: Intel Iris 05:50:40 INFO - Type: GPU 05:50:40 INFO - Bus: Built-In 05:50:40 INFO - VRAM (Dynamic, Max): 1536 MB 05:50:40 INFO - Vendor: Intel (0x8086) 05:50:40 INFO - Device ID: 0x0a2e 05:50:40 INFO - Revision ID: 0x0009 05:50:40 INFO - Displays: 05:50:40 INFO - Display: 05:50:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:50:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:50:40 INFO - Display Serial Number: 1600x1200 60 05:50:40 INFO - Main Display: Yes 05:50:40 INFO - Mirror: Off 05:50:40 INFO - Online: Yes 05:50:40 INFO - Rotation: Supported 05:50:40 INFO - Return code: 0 05:50:40 INFO - Running post-action listener: _resource_record_post_action 05:50:40 INFO - Running post-run listener: _resource_record_post_run 05:50:41 INFO - Total resource usage - Wall time: 1237s; CPU: 54.0%; Read bytes: 1253376; Write bytes: 694108160; Read time: 16; Write time: 2056 05:50:41 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334860800; Write bytes: 338827264; Read time: 26079; Write time: 643 05:50:41 INFO - run-tests - Wall time: 1207s; CPU: 54.0%; Read bytes: 1220608; Write bytes: 344840192; Read time: 15; Write time: 1377 05:50:41 INFO - Running post-run listener: _upload_blobber_files 05:50:41 INFO - Blob upload gear active. 05:50:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:50:41 INFO - Copying logs to upload dir... 05:50:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.707878 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-24 05:50:42.031705) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:50:42.037710) ========= 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.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009577 build_url: 'https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:50:42.065765) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:50:42.066049) ========= 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.C8GOLO21NY/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.uZDKeRyRvs/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005057 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:50:42.115609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 05:50:42.115913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 05:50:42.116332) ========= ========= Total master_lag: 0.22 =========