builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1448282603.67 results: success (0) buildid: 20151123025227 builduid: 7aa31ee9839b4c6280f36d4a4979eddb revision: db77a24c37698b4e71f8ba0fba170a0c157fc1f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.672265) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.672850) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.673182) ========= 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.TUMCy1uNp4/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.OkyVLZkt2E/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.005610 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.698355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.698701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.717329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.718019) ========= 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.TUMCy1uNp4/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.OkyVLZkt2E/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.005420 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.768834) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.771983) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.772496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.772940) ========= 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.TUMCy1uNp4/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.OkyVLZkt2E/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-23 04:43:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-23 04:43:23 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201299 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.988102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:23.988454) ========= 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.TUMCy1uNp4/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.OkyVLZkt2E/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.026302 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:24.036535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:43:24.036939) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev db77a24c37698b4e71f8ba0fba170a0c157fc1f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev db77a24c37698b4e71f8ba0fba170a0c157fc1f9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TUMCy1uNp4/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.OkyVLZkt2E/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-23 04:43:24,108 truncating revision to first 12 chars 2015-11-23 04:43:24,108 Setting DEBUG logging. 2015-11-23 04:43:24,108 attempt 1/10 2015-11-23 04:43:24,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/db77a24c3769?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 04:43:25,422 unpacking tar archive at: mozilla-central-db77a24c3769/testing/mozharness/ program finished with exit code 0 elapsedTime=1.556004 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:43:25.703933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:25.704249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:25.716161) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:25.716410) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:43:25.716800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-23 04:43:25.717097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TUMCy1uNp4/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.OkyVLZkt2E/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 04:43:25 INFO - MultiFileLogger online at 20151123 04:43:25 in /builds/slave/test 04:43:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:43:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:43:25 INFO - {'append_to_log': False, 04:43:25 INFO - 'base_work_dir': '/builds/slave/test', 04:43:25 INFO - 'blob_upload_branch': 'Firefox', 04:43:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:43:25 INFO - 'branch': 'Firefox', 04:43:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:43:25 INFO - 'config_files': ('talos/mac_config.py',), 04:43:25 INFO - 'default_actions': ('clobber', 04:43:25 INFO - 'read-buildbot-config', 04:43:25 INFO - 'download-and-extract', 04:43:25 INFO - 'populate-webroot', 04:43:25 INFO - 'create-virtualenv', 04:43:25 INFO - 'install', 04:43:25 INFO - 'run-tests'), 04:43:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:43:25 INFO - 'download_minidump_stackwalk': True, 04:43:25 INFO - 'download_symbols': 'ondemand', 04:43:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:43:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:43:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:43:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:43:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:43:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:43:25 INFO - 'installer_path': 'installer.exe', 04:43:25 INFO - 'log_level': 'info', 04:43:25 INFO - 'log_name': 'talos', 04:43:25 INFO - 'log_to_console': True, 04:43:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:43:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:43:25 INFO - 'opt_config_files': (), 04:43:25 INFO - 'pip_index': False, 04:43:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:25 INFO - 'cmd': ('bash', 04:43:25 INFO - '-c', 04:43:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:25 INFO - 'enabled': True, 04:43:25 INFO - 'halt_on_failure': False, 04:43:25 INFO - 'name': 'check_screen_resolution'},), 04:43:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:25 INFO - 'cmd': ('bash', 04:43:25 INFO - '-c', 04:43:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:25 INFO - 'enabled': True, 04:43:25 INFO - 'halt_on_failure': False, 04:43:25 INFO - 'name': 'check_screen_resolution'},), 04:43:25 INFO - 'run_cmd_checks_enabled': True, 04:43:25 INFO - 'sps_profile': False, 04:43:25 INFO - 'sps_profile_interval': 0, 04:43:25 INFO - 'suite': 'dromaeojs-e10s', 04:43:25 INFO - 'system_bits': '64', 04:43:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:43:25 INFO - 'title': 't-yosemite-r7-0018', 04:43:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:43:25 INFO - 'use_talos_json': True, 04:43:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:43:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:43:25 INFO - 'work_dir': 'build'} 04:43:25 INFO - ##### 04:43:25 INFO - ##### Running clobber step. 04:43:25 INFO - ##### 04:43:25 INFO - Running pre-action listener: _resource_record_pre_action 04:43:25 INFO - Running main action method: clobber 04:43:25 INFO - rmtree: /builds/slave/test/build 04:43:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:43:27 INFO - Running post-action listener: _resource_record_post_action 04:43:27 INFO - ##### 04:43:27 INFO - ##### Running read-buildbot-config step. 04:43:27 INFO - ##### 04:43:27 INFO - Running pre-action listener: _resource_record_pre_action 04:43:27 INFO - Running main action method: read_buildbot_config 04:43:27 INFO - Using buildbot properties: 04:43:27 INFO - { 04:43:27 INFO - "properties": { 04:43:27 INFO - "buildnumber": 10, 04:43:27 INFO - "product": "firefox", 04:43:27 INFO - "script_repo_revision": "production", 04:43:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:43:27 INFO - "repository": "", 04:43:27 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:43:27 INFO - "buildid": "20151123025227", 04:43:27 INFO - "slavename": "t-yosemite-r7-0018", 04:43:27 INFO - "pgo_build": "False", 04:43:27 INFO - "basedir": "/builds/slave/test", 04:43:27 INFO - "project": "", 04:43:27 INFO - "platform": "yosemite_r7", 04:43:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:43:27 INFO - "slavebuilddir": "test", 04:43:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:43:27 INFO - "branch": "mozilla-central", 04:43:27 INFO - "repo_path": "mozilla-central", 04:43:27 INFO - "stage_platform": "macosx64", 04:43:27 INFO - "builduid": "7aa31ee9839b4c6280f36d4a4979eddb", 04:43:27 INFO - "revision": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9" 04:43:27 INFO - }, 04:43:27 INFO - "sourcestamp": { 04:43:27 INFO - "repository": "", 04:43:27 INFO - "hasPatch": false, 04:43:27 INFO - "project": "", 04:43:27 INFO - "branch": "mozilla-central-macosx64-talos", 04:43:27 INFO - "changes": [ 04:43:27 INFO - { 04:43:27 INFO - "category": null, 04:43:27 INFO - "files": [ 04:43:27 INFO - { 04:43:27 INFO - "url": null, 04:43:27 INFO - "name": "https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:43:27 INFO - } 04:43:27 INFO - ], 04:43:27 INFO - "repository": "", 04:43:27 INFO - "rev": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9", 04:43:27 INFO - "who": "cbook@mozilla.com", 04:43:27 INFO - "when": 1448282231, 04:43:27 INFO - "number": 6694696, 04:43:27 INFO - "comments": "merge b2g-inbound to mozilla-central on a CLOSED TREE", 04:43:27 INFO - "project": "", 04:43:27 INFO - "at": "Mon 23 Nov 2015 04:37:11", 04:43:27 INFO - "branch": "mozilla-central-macosx64-talos", 04:43:27 INFO - "revlink": "", 04:43:27 INFO - "properties": [ 04:43:27 INFO - [ 04:43:27 INFO - "buildid", 04:43:27 INFO - "20151123025227", 04:43:27 INFO - "Change" 04:43:27 INFO - ], 04:43:27 INFO - [ 04:43:27 INFO - "builduid", 04:43:27 INFO - "7aa31ee9839b4c6280f36d4a4979eddb", 04:43:27 INFO - "Change" 04:43:27 INFO - ], 04:43:27 INFO - [ 04:43:27 INFO - "pgo_build", 04:43:27 INFO - "False", 04:43:27 INFO - "Change" 04:43:27 INFO - ] 04:43:27 INFO - ], 04:43:27 INFO - "revision": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9" 04:43:27 INFO - } 04:43:27 INFO - ], 04:43:27 INFO - "revision": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9" 04:43:27 INFO - } 04:43:27 INFO - } 04:43:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:43:27 INFO - Running post-action listener: _resource_record_post_action 04:43:27 INFO - ##### 04:43:27 INFO - ##### Running download-and-extract step. 04:43:27 INFO - ##### 04:43:27 INFO - Running pre-action listener: _resource_record_pre_action 04:43:27 INFO - Running main action method: download_and_extract 04:43:27 INFO - mkdir: /builds/slave/test/build/tests 04:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:27 INFO - https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/test_packages.json 04:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/test_packages.json 04:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:43:28 INFO - Downloaded 1149 bytes. 04:43:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:43:28 INFO - Using the following test package requirements: 04:43:28 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:43:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:43:28 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:43:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:43:28 INFO - u'jsshell-mac.zip'], 04:43:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:43:28 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:43:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:43:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:43:28 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:43:28 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:43:28 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:43:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:43:28 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:43:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:43:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:43:28 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:43:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:28 INFO - https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:43:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:43:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:43:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/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 04:43:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/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 04:43:29 INFO - Downloaded 17524575 bytes. 04:43:29 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 04:43:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:43:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:43:32 INFO - Return code: 0 04:43:32 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 04:43:32 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')]} 04:43:32 INFO - https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:43:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:43:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:43:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/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 04:43:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/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 04:43:33 INFO - Downloaded 17524575 bytes. 04:43:33 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 04:43:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:43:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:43:37 INFO - Return code: 0 04:43:37 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')]} 04:43:37 INFO - https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/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 04:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/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 04:43:37 INFO - Downloaded 11130997 bytes. 04:43:37 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 04:43:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:43:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:43:38 INFO - Return code: 0 04:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:38 INFO - https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwq3o17mSxCo82KrhYQnHw/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 04:43:40 INFO - Downloaded 109619349 bytes. 04:43:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:43:40 INFO - mkdir: /builds/slave/test/properties 04:43:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:43:40 INFO - Writing to file /builds/slave/test/properties/build_url 04:43:40 INFO - Contents: 04:43:40 INFO - build_url:https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:43:40 INFO - Running post-action listener: _resource_record_post_action 04:43:40 INFO - Running post-action listener: set_extra_try_arguments 04:43:40 INFO - ##### 04:43:40 INFO - ##### Running populate-webroot step. 04:43:40 INFO - ##### 04:43:40 INFO - Running pre-action listener: _resource_record_pre_action 04:43:40 INFO - Running main action method: populate_webroot 04:43:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:43:41 INFO - '../fennec_ids.txt'], 04:43:41 INFO - 'tests': ['tcheck2']}, 04:43:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:41 INFO - '--tppagecycles', 04:43:41 INFO - '7'], 04:43:41 INFO - 'tests': ['tsvgm']}}, 04:43:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:43:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:43:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:43:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:43:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'tests': ['damp', 'tps']}, 04:43:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['damp', 'tps']}, 04:43:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:43:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:41 INFO - 'other': {'tests': ['a11yr', 04:43:41 INFO - 'ts_paint', 04:43:41 INFO - 'tpaint', 04:43:41 INFO - 'sessionrestore', 04:43:41 INFO - 'sessionrestore_no_auto_restore']}, 04:43:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['a11yr', 04:43:41 INFO - 'ts_paint', 04:43:41 INFO - 'tpaint', 04:43:41 INFO - 'sessionrestore', 04:43:41 INFO - 'sessionrestore_no_auto_restore']}, 04:43:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['a11yr', 04:43:41 INFO - 'ts_paint', 04:43:41 INFO - 'tpaint', 04:43:41 INFO - 'sessionrestore', 04:43:41 INFO - 'sessionrestore_no_auto_restore']}, 04:43:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['a11yr', 04:43:41 INFO - 'ts_paint', 04:43:41 INFO - 'tpaint', 04:43:41 INFO - 'sessionrestore', 04:43:41 INFO - 'sessionrestore_no_auto_restore']}, 04:43:41 INFO - 'other_l64': {'tests': ['a11yr', 04:43:41 INFO - 'ts_paint', 04:43:41 INFO - 'tpaint', 04:43:41 INFO - 'sessionrestore', 04:43:41 INFO - 'sessionrestore_no_auto_restore']}, 04:43:41 INFO - 'other_nol64': {'tests': ['a11yr', 04:43:41 INFO - 'ts_paint', 04:43:41 INFO - 'tpaint', 04:43:41 INFO - 'sessionrestore', 04:43:41 INFO - 'sessionrestore_no_auto_restore']}, 04:43:41 INFO - 'svgr': {'tests': ['tsvgx', 04:43:41 INFO - 'tsvgr_opacity', 04:43:41 INFO - 'tart', 04:43:41 INFO - 'tscrollx', 04:43:41 INFO - 'cart']}, 04:43:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['tsvgx', 04:43:41 INFO - 'tsvgr_opacity', 04:43:41 INFO - 'tart', 04:43:41 INFO - 'tscrollx', 04:43:41 INFO - 'cart']}, 04:43:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'tests': ['tp5o']}, 04:43:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'talos_options': ['--e10s'], 04:43:41 INFO - 'tests': ['tp5o']}, 04:43:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'talos_options': ['--xperf_path', 04:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:41 INFO - 'tests': ['tp5n']}, 04:43:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:41 INFO - 'talos_options': ['--e10s', 04:43:41 INFO - '--xperf_path', 04:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:41 INFO - 'tests': ['tp5n']}}, 04:43:41 INFO - 'talos.zip': {'path': '', 04:43:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:41 INFO - Running post-action listener: _resource_record_post_action 04:43:41 INFO - ##### 04:43:41 INFO - ##### Running create-virtualenv step. 04:43:41 INFO - ##### 04:43:41 INFO - Running pre-action listener: _resource_record_pre_action 04:43:41 INFO - Running main action method: create_virtualenv 04:43:41 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:41 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 04:43:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:41 INFO - Using real prefix '/tools/python27' 04:43:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:44 INFO - Installing pip.................done. 04:43:44 INFO - Return code: 0 04:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43:44 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')]} 04:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:44 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')]} 04:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:44 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 0x1038b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a2db1980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, '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.TUMCy1uNp4/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.OkyVLZkt2E/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 04:43:44 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 04:43:44 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 04:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:44 INFO - 'HOME': '/Users/cltbld', 04:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:44 INFO - 'LOGNAME': 'cltbld', 04:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:44 INFO - 'MOZ_NO_REMOTE': '1', 04:43:44 INFO - 'NO_EM_RESTART': '1', 04:43:44 INFO - 'PAGER': '/bin/cat', 04:43:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:44 INFO - 'PWD': '/builds/slave/test', 04:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:44 INFO - 'SHELL': '/bin/bash', 04:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:43:44 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:44 INFO - 'USER': 'cltbld', 04:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:44 INFO - 'XPC_FLAGS': '0x0', 04:43:44 INFO - 'XPC_SERVICE_NAME': '0', 04:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:45 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 04:43:45 INFO - Cleaning up... 04:43:45 INFO - Return code: 0 04:43:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:45 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 0x1038b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a2db1980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, '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.TUMCy1uNp4/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.OkyVLZkt2E/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 04:43:45 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 04:43:45 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 04:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:45 INFO - 'HOME': '/Users/cltbld', 04:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:45 INFO - 'LOGNAME': 'cltbld', 04:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:45 INFO - 'MOZ_NO_REMOTE': '1', 04:43:45 INFO - 'NO_EM_RESTART': '1', 04:43:45 INFO - 'PAGER': '/bin/cat', 04:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:45 INFO - 'PWD': '/builds/slave/test', 04:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:45 INFO - 'SHELL': '/bin/bash', 04:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:43:45 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:45 INFO - 'USER': 'cltbld', 04:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:45 INFO - 'XPC_FLAGS': '0x0', 04:43:45 INFO - 'XPC_SERVICE_NAME': '0', 04:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:45 INFO - Downloading/unpacking psutil>=0.7.1 04:43:45 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 04:43:45 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 04:43:45 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 04:43:45 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 04:43:45 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 04:43:45 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 04:43:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:43:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:47 INFO - Installing collected packages: psutil 04:43:47 INFO - Running setup.py install for psutil 04:43:47 INFO - building 'psutil._psutil_osx' extension 04:43:47 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 04:43:48 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 04:43:48 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 04:43:48 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 04:43:48 INFO - building 'psutil._psutil_posix' extension 04:43:48 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 04:43:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:43:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:43:48 INFO - ^ 04:43:48 INFO - 1 warning generated. 04:43:48 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 04:43:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:48 INFO - Successfully installed psutil 04:43:48 INFO - Cleaning up... 04:43:48 INFO - Return code: 0 04:43:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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', '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 0x1038b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a2db1980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, '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.TUMCy1uNp4/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.OkyVLZkt2E/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 04:43: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:43: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 mozsystemmonitor==0.0.0 04:43:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:43:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:49 INFO - 'HOME': '/Users/cltbld', 04:43:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:49 INFO - 'LOGNAME': 'cltbld', 04:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:49 INFO - 'MOZ_NO_REMOTE': '1', 04:43:49 INFO - 'NO_EM_RESTART': '1', 04:43:49 INFO - 'PAGER': '/bin/cat', 04:43:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:49 INFO - 'PWD': '/builds/slave/test', 04:43:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:49 INFO - 'SHELL': '/bin/bash', 04:43:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:43:49 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:43:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:49 INFO - 'USER': 'cltbld', 04:43:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:49 INFO - 'XPC_FLAGS': '0x0', 04:43:49 INFO - 'XPC_SERVICE_NAME': '0', 04:43:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:43:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:43:51 INFO - Installing collected packages: mozsystemmonitor 04:43:51 INFO - Running setup.py install for mozsystemmonitor 04:43:51 INFO - Successfully installed mozsystemmonitor 04:43:51 INFO - Cleaning up... 04:43:51 INFO - Return code: 0 04:43:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:51 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 0x1038b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a2db1980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, '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.TUMCy1uNp4/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.OkyVLZkt2E/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 04:43:51 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 04:43:51 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 04:43:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:43:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:51 INFO - 'HOME': '/Users/cltbld', 04:43:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:51 INFO - 'LOGNAME': 'cltbld', 04:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:51 INFO - 'MOZ_NO_REMOTE': '1', 04:43:51 INFO - 'NO_EM_RESTART': '1', 04:43:51 INFO - 'PAGER': '/bin/cat', 04:43:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:51 INFO - 'PWD': '/builds/slave/test', 04:43:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:51 INFO - 'SHELL': '/bin/bash', 04:43:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:43:51 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:43:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:51 INFO - 'USER': 'cltbld', 04:43:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:51 INFO - 'XPC_FLAGS': '0x0', 04:43:51 INFO - 'XPC_SERVICE_NAME': '0', 04:43:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43:54 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 04:43:54 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 04:43:54 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 04:43:54 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 04:43:54 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 04:43:54 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 04:43:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:54 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 04:43:54 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 04:43:54 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 04:43:54 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 04:43:54 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 04:43:54 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 04:43:55 INFO - Downloading docopt-0.6.1.tar.gz 04:43:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:43:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:43:55 INFO - Running setup.py install for blobuploader 04:43:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:43:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:43:55 INFO - Running setup.py install for requests 04:43:55 INFO - Running setup.py install for docopt 04:43:56 INFO - Successfully installed blobuploader requests docopt 04:43:56 INFO - Cleaning up... 04:43:56 INFO - Return code: 0 04:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:56 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')]} 04:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:56 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')]} 04:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:56 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 0x1038b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a2db1980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, '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.TUMCy1uNp4/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.OkyVLZkt2E/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 04:43:56 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 04:43:56 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 04:43:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:43:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:56 INFO - 'HOME': '/Users/cltbld', 04:43:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:56 INFO - 'LOGNAME': 'cltbld', 04:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:56 INFO - 'MOZ_NO_REMOTE': '1', 04:43:56 INFO - 'NO_EM_RESTART': '1', 04:43:56 INFO - 'PAGER': '/bin/cat', 04:43:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:56 INFO - 'PWD': '/builds/slave/test', 04:43:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:56 INFO - 'SHELL': '/bin/bash', 04:43:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:43:56 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:43:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:56 INFO - 'USER': 'cltbld', 04:43:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:56 INFO - 'XPC_FLAGS': '0x0', 04:43:56 INFO - 'XPC_SERVICE_NAME': '0', 04:43:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LuwM1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-8aDkqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-MwBQC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-29DqWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-RkbuOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-biG7p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-SkwCuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-DwpT3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Y0_Hm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-uCXeop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-vFBnrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-xaokhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-rrwUj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-OnDoZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-k7rkKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-XRUaBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:58 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Rn77aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:58 INFO - Running setup.py install for manifestparser 04:43:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:58 INFO - Running setup.py install for mozcrash 04:43:58 INFO - Running setup.py install for mozdebug 04:43:58 INFO - Running setup.py install for mozdevice 04:43:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:43:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:58 INFO - Running setup.py install for mozfile 04:43:58 INFO - Running setup.py install for mozhttpd 04:43:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Running setup.py install for mozinfo 04:43:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Running setup.py install for mozInstall 04:43:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Running setup.py install for mozleak 04:43:59 INFO - Running setup.py install for mozlog 04:43:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Running setup.py install for moznetwork 04:43:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:59 INFO - Running setup.py install for mozprocess 04:43:59 INFO - Running setup.py install for mozprofile 04:44:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:00 INFO - Running setup.py install for mozrunner 04:44:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:00 INFO - Running setup.py install for mozscreenshot 04:44:00 INFO - Running setup.py install for moztest 04:44:00 INFO - Running setup.py install for mozversion 04:44:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:00 INFO - Cleaning up... 04:44:00 INFO - Return code: 0 04:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:00 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 0x1038b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a2db1980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, '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.TUMCy1uNp4/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.OkyVLZkt2E/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 04:44:00 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 04:44:00 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 04:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:00 INFO - 'HOME': '/Users/cltbld', 04:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:00 INFO - 'LOGNAME': 'cltbld', 04:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:00 INFO - 'MOZ_NO_REMOTE': '1', 04:44:00 INFO - 'NO_EM_RESTART': '1', 04:44:00 INFO - 'PAGER': '/bin/cat', 04:44:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:00 INFO - 'PWD': '/builds/slave/test', 04:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:00 INFO - 'SHELL': '/bin/bash', 04:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:44:00 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:00 INFO - 'USER': 'cltbld', 04:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:00 INFO - 'XPC_FLAGS': '0x0', 04:44:00 INFO - 'XPC_SERVICE_NAME': '0', 04:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:00 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-699VoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-xHUU7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-jfQvrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-TWJ8kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-8NJT1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-9Y_N6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-r1bCNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Cp7VN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-6iaYAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:01 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)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-AkeV5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-85qrwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:02 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)) 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-x6hkNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:02 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)) 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-yfhVAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:02 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)) 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-NaTxSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:02 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)) 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-wMTTkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:02 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)) 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-MTmkZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:02 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)) 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-kAPGEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:02 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)) 04:44:02 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)) 04:44:02 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)) 04:44:02 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)) 04:44:02 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)) 04:44:02 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)) 04:44:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:02 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 04:44:02 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 04:44:02 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 04:44:02 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 04:44:02 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 04:44:02 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 04:44:04 INFO - Downloading blessings-1.5.1.tar.gz 04:44:04 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 04:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:04 INFO - Installing collected packages: blessings 04:44:04 INFO - Running setup.py install for blessings 04:44:05 INFO - Successfully installed blessings 04:44:05 INFO - Cleaning up... 04:44:05 INFO - Return code: 0 04:44:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:05 INFO - Reading from file tmpfile_stdout 04:44:05 INFO - Current package versions: 04:44:05 INFO - blessings == 1.5.1 04:44:05 INFO - blobuploader == 1.2.4 04:44:05 INFO - docopt == 0.6.1 04:44:05 INFO - manifestparser == 1.1 04:44:05 INFO - mozInstall == 1.12 04:44:05 INFO - mozcrash == 0.16 04:44:05 INFO - mozdebug == 0.1 04:44:05 INFO - mozdevice == 0.47 04:44:05 INFO - mozfile == 1.2 04:44:05 INFO - mozhttpd == 0.7 04:44:05 INFO - mozinfo == 0.9 04:44:05 INFO - mozleak == 0.1 04:44:05 INFO - mozlog == 3.0 04:44:05 INFO - moznetwork == 0.27 04:44:05 INFO - mozprocess == 0.22 04:44:05 INFO - mozprofile == 0.27 04:44:05 INFO - mozrunner == 6.11 04:44:05 INFO - mozscreenshot == 0.1 04:44:05 INFO - mozsystemmonitor == 0.0 04:44:05 INFO - moztest == 0.7 04:44:05 INFO - mozversion == 1.4 04:44:05 INFO - psutil == 3.1.1 04:44:05 INFO - requests == 1.2.3 04:44:05 INFO - wsgiref == 0.1.2 04:44:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x1038b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a2db1980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, '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.TUMCy1uNp4/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.OkyVLZkt2E/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 04:44:05 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 04:44:05 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 04:44:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:44:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:05 INFO - 'HOME': '/Users/cltbld', 04:44:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:05 INFO - 'LOGNAME': 'cltbld', 04:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:05 INFO - 'MOZ_NO_REMOTE': '1', 04:44:05 INFO - 'NO_EM_RESTART': '1', 04:44:05 INFO - 'PAGER': '/bin/cat', 04:44:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:05 INFO - 'PWD': '/builds/slave/test', 04:44:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:05 INFO - 'SHELL': '/bin/bash', 04:44:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:44:05 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:44:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:05 INFO - 'USER': 'cltbld', 04:44:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:05 INFO - 'XPC_FLAGS': '0x0', 04:44:05 INFO - 'XPC_SERVICE_NAME': '0', 04:44:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 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)) 04:44:05 INFO - Cleaning up... 04:44:05 INFO - Return code: 0 04:44:05 INFO - Running post-action listener: _resource_record_post_action 04:44:05 INFO - Running post-action listener: _start_resource_monitoring 04:44:05 INFO - Starting resource monitoring. 04:44:05 INFO - ##### 04:44:05 INFO - ##### Running install step. 04:44:05 INFO - ##### 04:44:05 INFO - Running pre-action listener: _resource_record_pre_action 04:44:05 INFO - Running main action method: install 04:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:06 INFO - Reading from file tmpfile_stdout 04:44:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:06 INFO - Reading from file tmpfile_stdout 04:44:06 INFO - Output received: 04:44:06 INFO - Usage: mozinstall [options] installer 04:44:06 INFO - Options: 04:44:06 INFO - -h, --help show this help message and exit 04:44:06 INFO - -d DEST, --destination=DEST 04:44:06 INFO - Directory to install application into. [default: 04:44:06 INFO - "/builds/slave/test"] 04:44:06 INFO - --app=APP Application being installed. [default: firefox] 04:44:06 INFO - mkdir: /builds/slave/test/build/application 04:44:06 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'] 04:44:06 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 04:44:36 INFO - Reading from file tmpfile_stdout 04:44:36 INFO - Output received: 04:44:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:44:36 INFO - Running post-action listener: _resource_record_post_action 04:44:36 INFO - ##### 04:44:36 INFO - ##### Running run-tests step. 04:44:36 INFO - ##### 04:44:36 INFO - Running pre-action listener: _resource_record_pre_action 04:44:36 INFO - Running main action method: run_tests 04:44:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:36 INFO - 2015-11-23 04:44:36.701 screenresolution[1638:7527] starting screenresolution argv=screenresolution get 04:44:36 INFO - 2015-11-23 04:44:36.704 screenresolution[1638:7527] Display 0: 1600x1200x32@60 04:44:36 INFO - 2015-11-23 04:44:36.709 screenresolution[1639:7529] starting screenresolution argv=screenresolution list 04:44:36 INFO - Available Modes on Display 0 04:44:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:36 INFO - Intel Iris: 04:44:36 INFO - Chipset Model: Intel Iris 04:44:36 INFO - Type: GPU 04:44:36 INFO - Bus: Built-In 04:44:36 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:36 INFO - Vendor: Intel (0x8086) 04:44:36 INFO - Device ID: 0x0a2e 04:44:36 INFO - Revision ID: 0x0009 04:44:36 INFO - Displays: 04:44:36 INFO - Display: 04:44:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:36 INFO - Display Serial Number: 1600x1200 60 04:44:36 INFO - Main Display: Yes 04:44:36 INFO - Mirror: Off 04:44:36 INFO - Online: Yes 04:44:36 INFO - Rotation: Supported 04:44:36 INFO - Return code: 0 04:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:36 INFO - Python 2.7.3 04:44:36 INFO - Return code: 0 04:44:36 INFO - grabbing minidump binary from tooltool 04:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:36 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 0x1037dd9f0>, '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 0x10353cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d08c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:36 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 04:44:36 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 04:44:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:37 INFO - Return code: 0 04:44:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:44:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:44:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] in /builds/slave/test/build 04:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --webServer localhost 04:44:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUMCy1uNp4/Render', 04:44:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:37 INFO - 'HOME': '/Users/cltbld', 04:44:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:37 INFO - 'LOGNAME': 'cltbld', 04:44:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:37 INFO - 'MOZ_NO_REMOTE': '1', 04:44:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:37 INFO - 'NO_EM_RESTART': '1', 04:44:37 INFO - 'PAGER': '/bin/cat', 04:44:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:37 INFO - 'PWD': '/builds/slave/test', 04:44:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:37 INFO - 'SHELL': '/bin/bash', 04:44:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OkyVLZkt2E/Listeners', 04:44:37 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 04:44:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:37 INFO - 'USER': 'cltbld', 04:44:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:37 INFO - 'XPC_FLAGS': '0x0', 04:44:37 INFO - 'XPC_SERVICE_NAME': '0', 04:44:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] with output_timeout 3600 04:44:37 INFO - mozversion INFO | application_buildid: 20151123025227 04:44:37 INFO - mozversion INFO | application_changeset: db77a24c37698b4e71f8ba0fba170a0c157fc1f9 04:44:37 INFO - mozversion INFO | application_display_name: Nightly 04:44:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:37 INFO - mozversion INFO | application_name: Firefox 04:44:37 INFO - mozversion INFO | application_remotingname: firefox 04:44:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:44:37 INFO - mozversion INFO | application_vendor: Mozilla 04:44:37 INFO - mozversion INFO | application_version: 45.0a1 04:44:37 INFO - mozversion INFO | platform_buildid: 20151123025227 04:44:37 INFO - mozversion INFO | platform_changeset: db77a24c37698b4e71f8ba0fba170a0c157fc1f9 04:44:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:44:37 INFO - mozversion INFO | platform_version: 45.0a1 04:44:37 INFO - 2015-11-23 04:44:37,254 DEBUG : using testdate: 1448282677 04:44:37 INFO - 2015-11-23 04:44:37,254 DEBUG : actual date: 1448282677 04:44:37 INFO - 2015-11-23 04:44:37,263 INFO : starting webserver on 'localhost:49269' 04:44:37 INFO - 2015-11-23 04:44:37,264 INFO : Starting test suite t-yosemite-r7-0018.e 04:44:37 INFO - 2015-11-23 04:44:37,264 INFO : Starting test dromaeo_css 04:44:37 INFO - 2015-11-23 04:44:37,264 DEBUG : operating with platform_type : mac_ 04:44:37 INFO - 2015-11-23 04:44:37,265 INFO : Initialising browser for dromaeo_css test... 04:44:37 INFO - 2015-11-23 04:44:37,277 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpi9r6n3/profile http://localhost:49269/getInfo.html 04:44:39 INFO - 2015-11-23 04:44:39,963 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:44:39 INFO - 2015-11-23 04:44:39,964 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:44:39 INFO - 2015-11-23 04:44:39,964 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:44:39 INFO - 2015-11-23 04:44:39,964 DEBUG : BROWSER_OUTPUT: __metrics 04:44:40 INFO - 2015-11-23 04:44:40,609 INFO : Browser initialized. 04:44:40 INFO - 2015-11-23 04:44:40,610 INFO : Running cycle 1/1 for dromaeo_css test... 04:44:40 INFO - 2015-11-23 04:44:40,610 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpi9r6n3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:44:52 INFO - 2015-11-23 04:44:52,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 237006848 04:44:52 INFO - 2015-11-23 04:44:52,451 DEBUG : BROWSER_OUTPUT: 04:45:42 INFO - 2015-11-23 04:45:42,158 DEBUG : BROWSER_OUTPUT: 1448282742157 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] 04:47:53 INFO - 2015-11-23 04:47:53,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 04:47:54 INFO - 2015-11-23 04:47:54,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 253227008 04:47:54 INFO - 2015-11-23 04:47:54,556 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-23 04:50:56,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 04:50:57 INFO - 2015-11-23 04:50:57,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 261857280 04:50:57 INFO - 2015-11-23 04:50:57,113 DEBUG : BROWSER_OUTPUT: 04:53:58 INFO - 2015-11-23 04:53:58,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 04:53:59 INFO - 2015-11-23 04:53:59,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 263368704 04:53:59 INFO - 2015-11-23 04:53:59,336 DEBUG : BROWSER_OUTPUT: 04:57:00 INFO - 2015-11-23 04:57:00,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 04:57:01 INFO - 2015-11-23 04:57:01,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 266141696 04:57:01 INFO - 2015-11-23 04:57:01,555 DEBUG : BROWSER_OUTPUT: 05:00:03 INFO - 2015-11-23 05:00:03,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 05:00:04 INFO - 2015-11-23 05:00:04,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 268898304 05:00:04 INFO - 2015-11-23 05:00:04,524 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 05:03:06 INFO - 2015-11-23 05:03:06,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 272351232 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3479.6520347965197;3583.2833433313344;3593.245418462123;3623.5289412376387;3623.9094022649447;5962.940370596293;5987.670678112702;5994.370591087938;5998.0702991036405;6035.336113027563;4632.606228470576;5734.881698068878;5895.292564892219;5915.911261331073;6029.1257767623665;4948.950510494903;5317.388500322454;5362.865928351803;5383.219433182206;5407.783688652449;5356.812511562096;5428.511433970942;5441.83674489764;5464.55189374816;5468.781248750045;5116.744162791882;5165.457626949154;5257.605679574047;5312.495312945264;5336.67979921206;5398.568114550826;5403.540699040586;5420.186971954199;5420.186971954199;5437.8368648940595;5324.787008519694;5373.731313434313;5400.729963501809;5415.458454154593;5474.863128421782;5466.945330546723;5528.723563821833;5532.944670553283;5832.270966129234;5957.374475680078;6364.904526432108;6385.393387628168;6400.839979000562;6417.2299324081405;6431.678416079224;6119.837693858745;6532.020196970445;6547.738090476375;6557.377049180321;6566.737330506774;6053.364396738367;6111.480524155452;6125.938740612626;6151.5386346024225;6168.722407491674;6519.8044058678315;6655.101561289261;6668.966655166791;6676.365745254193;6691.130153080068;6116.457510225599;6268.561200715997;6282;6342.112104305401;6347.079673447324;6293.748250070037;6421.325760795143;6441.484681225491;6473.352664733489;6485.221773387224;6260.655663938527;6273.62358258506;6289.088082228142;6291.716872740738;6302.747890084437;6115.544587951936;6192.969035154795;6231.470325022424;6287.2140982377205;6307.463865571386;5063.215201643751;5126.333576635014;5128.25640282157;5140.485951404829;5154;4605.102005109038;4616.261398176276;4634.46703629087;4639.536046395334;4672.135654903854;5919.911201331984;5978.342382337939;6074.36219196978;6086.391360863879;6088.178095957078;6144.678894037804;6200.968995154995;6308.116863639094;6405.967970160119;6543.887539118361;4983.277424773388;5970.283565972024;5990.371011043865;6026.849328766728;6038.818835434944;5374.5700343972385;5519.034169020405;5574.749136288877;5581.49766521015;5585.69278689676;5502.834914952397;6232.3144454110015;6264.029075493306;6370.968145159244;6373.6175829450385;5290.973545132404;5408.405075441777;6422.389872962248;6492.870142597028;6501.772437964649;5587.944120558743;6147.692615369303;6163.722632481638;6243.282022567463;6287.717052732546;6341.460975817107;6397.4562162216735;6397.4562162216735;6409.519286053658;6411.230652321751;6518.902216466851;6540.672966351568;6544.705488252945;6545.836354091186;6558.081868538313;5861.1501332307425;6123.343628574205;6188.783392581238;6236.126942228001;6336.3030066693545;6235.657038862906;6285.560010799383;6289.119523266655;6293.937060629335;6311.053341998553;4475.865724028285;5166.715830629351;6063.5452341073715;6211.440970312513;6229.159063526366;5425.376081750492;6113.358097399709;6130.570860039755;6158.199434073542;6214.25428948529;5171.431142574239;6219.284782250099;6237.251529816451;6250.031245157008;6264.655443950626 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.656520306653;558.6229295225719;576.1070340971495;607.2045620237486;618.4557589321397;30465.543016854765;41203.381949270784;41246.793766031165;41613.95965100874;41623.54317598881;45498.8625284368;45586.7720661397;45901;46075;46320.768396157975;9947.154491868181;10111;10116.494175291244;10125.443100629462;10171.643992460266;9910.653127140551;10034.949825250864;10043.296969212159;10052.798944021115;10072.496375181248;9949.502524873764;10023.799524009515;10032.949835250814;10080.94959525205;10100.090991810735;9923.206143508502;10046.346987445866;10066.245031622657;10070.546825392876;10097.747556311078;9876.802463950753;9984.750381240454;9998.300118991674;10003.699889003341;10022.649207277711;42300.57699423028;42362.788186058875;42579.787101064605;42699.7865010676;42774.358384624255;3425.760196786226;3510;3677;3781.5273090863643;4103.158852435244;28924.42151156986;30312.63593138292;30332.393352132833;30524;30740.231494212825;2707.945841083187;2754.2701184186208;2784.554471284605;2889.4510043091955;2983.1796256029547;433900;496318;499770.5011474956;500167;501638;56982.7150864243;57725.42274577284;70114.64942675356;70469.64765176244;70833;70151.29848701549;70395;70703.93944090843;70757.64621176862;71191;16608.833911660728;16735;16796.748048779278;16854.915725421295;17203.741943870853;11309.151813614011;12268.509259629693;12619.62141135749;12663.873361266453;12803.975681945421;19335.54983376224;20840.895795520926;20923.895380523;21042;21138.577228455346;8075.717349892726;8545.871811922827;9509.857352139723;9552.617895284111;9564.321989842854;961.4519723757531;968.1963969904962;1023.3501726403639;1028.2082796246998;1198.269055875915;31283.374332513224;31458.213544661565;31835.681643183736;32186;32368.352632947208;1071.5499490214129;1105.5522513382093;1108.6175269531998;1185.1230089733708;1191.92252503587;15220.771688424682;15236.009659372105;15460.613484662748;15594.9220253898;15602.687946241012;552268;553007;557325;558969;560626;55611.88776224453;56709.14936275877;58920.705396472746;59416;59684.70157649184;1436.9497067602583;1444.5738507140418;1465.4065103633045;1471.9337629806685;1491.6121808329694;29567.26081847971;29927;30929.845350773103;31370;31536.684633153374;55022.72488637531;55126.724366379516;55251.171232430745;55799.721001396356;55916.44083559112;396725.0163749163;399671.00164498994;399998;402887;404058;29206;29641.9625313113;31194.688053120088;33793.83103084469;34547.48178777371;43283;44063.33904991364;44286.778566106965;44389.89025274394;45110;38343.808280958416;38373.424398633484;38954.02614934649;39267.80366098151;39340.40989385104;36099.81950090338;37583.24833503369;38585.80707096447;38623.613763862;38839.41740873946;36435;36594.8170259147;38328.04179895525;38488.2302353957;38586.421203681406;27296;28363;32275.35449291048;33844;33982.64069437195;24314.756852431958;25767.355816104748;25886.093986710373;25990.61014084828;26122.346941326618 05:03:06 INFO - 2015-11-23 05:03:06,971 DEBUG : BROWSER_OUTPUT: |2;jquery.html;362.54319557357735;365.69281803285236;365.84451608066564;368.35905524387573;370.38700949927863;15804.44684436045;19626.411207663776;20423.795762042377;20680.48298792531;20943.685844712323;11904.642860714172;14098.872090232782;15351;20632.69050964237;20757.377278681626;5212.76542555585;5336.9733151334185;5352.652077614943;5369.892602147955;5386.245925570423;4471.016376397188;4929.186684197121;5106.336176297076;5248.763805628756;5295.735213239342;3812.218495208476;3946.980265098685;5232.2674825524455;5256.132738098209;5284.075286824809;5574;5706.857328566777;5710.628809127435;5729.997250481149;5761.683107429089;4790.640701947368;5374.865628359284;5508;5517.5585953123655;5535.6955367454775;12785.762491563939;12815.551455699098;12817.935910320388;22100.88949555258;24283.271501854797;1987.6322880267053;2027.0574183004826;2072.4611600983703;2102.02255950982;2120.5652841167525;8566.785830354229;9973.551190196386;10191;10634.734131646694;13714.862851371558;1770.7609472721276;1777.8222177782118;1818.436284751718;1871.7566716326926;1895.109298629642;93643;100498.9950100497;101183.49408252911;102090.48954755253;102868;10793.946030269955;11029.867146139182;11045.28205666629;11158.218924675195;11200.215984881143;13298.667533311746;13309.134906231064;13329.133606315558;13370.732585348238;13387.263700496565;8599.183077607617;8633.093525179891;8636.136386361313;8655.6970506032;8685.305175585938;8681.913180868236;8718.86921696175;8758.56207189638;8827.293816494664;8833.160849719266;4368.912621747547;4404.317330813729;4417.182821178092;4430.468343798765;4452.666050046259;1856.3688345962437;1882.5952420229717;1901.363043380483;1905.7427247321434;1906.3613689413924;844.9619767110495;918.9540522973824;919.6873063158558;996.5963784667076;1015.7308313296983;19547.902260488605;19763.912984785686;20241.987900605207;20282;20408.693869591967;833.4957350802798;970.1608108985677;997.835357166074;1013.3767732844248;1049.4123290957089;9739;10745.51645175969;10770.94614526938;10775.730606734895;10790.73023174427;769414.1529292318;770223;775492;778623;788705;122812;123968.38015809863;124573;125846;126793.36603317109;1161.4250945781891;1163.9301641901513;1182.5624518928053;1185.1526158796503;1218.8476440444945;17823.84145030569;18674.022165896542;19084.904575477034;19172.61654766869;19178.712319315502;44851.32723009092;45027.32459013052;51309;52821;52943.47056529386;66519.33480665131;74583.62708186642;74889.87665184918;75990;76909.23090769244;9783.902160978583;9794.26543009263;9881.703548893545;10105.646302379382;10117.140043096124;19377.934213618388;19559;19721.309754158534;19759.308424205083;20165.899170504053;15492.457763978657;15756.527304180892;15785.605359866095;15794.76307855406;15911.920440397724;12733.490660373482;13199.340032998503;15487.148206848731;15556.455524056604;15825.287862046465;15734.291956862198;16018.919905400864;16125.193740312703;16563.337466501685;16671.749923751395;7903.84192316139;9691.176250018545;9790.167835734042;9857.457839818879;9896.505174741378;15749.291281892114;15869.761953570474;15892.841071589599;16171.919140404223;16212.10833404174 05:03:06 INFO - 2015-11-23 05:03:06,975 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1375.4360712108037;1561.055561385362;1847.475832438238;1874.915628796704;1928.3443629166084;6498.057781621662;7568.356689681384;8611.569421528922;8822.250108740765;8847.557622118893;8314.91685083149;8501.489910605367;8556.957215213915;8595.355348348867;8647.35144864136;2384.320468666435;2419.5402873454077;2420.8668523231217;2426.9271921842374;2427.5630386530415;2395.4849707312924;2432.4648577312964;2437.70747510299;2445.1319781477587;2456;2379.690640216778;2385.785279324869;2417.516496700658;2425.7143713831697;2429.6355546667965;2362.9881850590637;2390.8565486070806;2411.1078900806815;2414.5653782319177;2416.395901024744;2421.4430680943483;2430.1980346485616;2445.779879810808;2450.33840862966;2453.276283496373;8465.195806398382;8495.490270583785;8540.530270835101;8556.443831150955;8560.529170895597;5211.635185537014;5245.055889939809;5291.788328466857;5298.81454149103;5320.707361095138;3301.3892429900307;3346.397648423283;3552.3250582389264;3579.838907249154;3629.383004889175;1060.120100316743;1071.1912506057954;1078.094400703405;1088.2817340555196;1088.3198001249218;11351.886481135165;11408.657740267805;11461.770764584746;11495.770084598262;11505.827412588735;4736.692115012514;4755.191617425046;4775.188218002948;4784.928226076611;4802.447718512346;9762.707118786448;9764;9799.853002204973;9820.312578119463;9824.45965471906;5236.188390799432;5263.18420644793;5279.736013199325;5288.995090932711;5309.734513274321;4227.175700738327;4360.302351623725;4674.368960190331;4750.809967601257;4771.188897887368;3291.259466619991;3900.3759398496104;3941.9802900985887;3960.7029472789654;3974.344233201547;1166.935818529972;1271.3833790611545;1306.3337697774205;1314.6384744195423;1316.2892038299403;1324.9403776830065;1329.0364485747948;1341.1751772659939;1382.05329349396;1387.8334599848083;7851.9214807851195;7853.7251196209;7950;7999;8008.879866802003;432.7706315652709;504.25527674246786;513.509598333598;514.7580637100557;517.4644243208261;5237.3453318335205;5498.9826882026955;5676.318841738936;6010.609310394811;6084.361142080018;9936.900630993741;10177.54201060954;10331.070203681706;10366.740831479274;10379.740506487247;9849.852252216222;10168.237382196365;10176.440295783656;10248.692539223835;10262.589496420209;7827.1390147083775;7857.096433910059;7897.842043159105;7919.247671471201;7991.2807847294025;7893.407994400328;7898.407619428681;7913.841723165389;7938.880916786137;7965.761027169194;9041.05068967749;9240.214581760625;9288.58201380953;9352.579133938852;9420.152186303265;8085.919140808516;9158.450492970444;9303.860442093239;9496.477693726634;9497.525123743924;6667.399934005963;6911.997760324624;7375.409967202503;7560.432967527568;7599;8188.754337369888;8210.712625058333;8225.383096267684;8226.465279756796;8263.793405164919;7550.962245188959;7672;7704.691812327668;7784.260495252942;7814.765557033298;7481.214472480311;7486.176520582841;7518.173000969999;7624.885626715492;7635.389168866366;7587.962060189664;7687.846243074995;7698.422618303762;7723.111842138226;7733.265339792936;6939.965300173467;6948.374646281859;6971.930280697128;7000.299970002959;7024.297570242935;7019.789406317818;7038.753643622448;7038.929610703827;7083.645817709197;7108.644567771694 05:03:06 INFO - 2015-11-23 05:03:06,976 DEBUG : BROWSER_OUTPUT: |4;prototype.html;321.081706319925;325.372031978282;327.3061110445855;333.373258274444;334.7489382962778;6596.7691130810435;6753.493487988396;6836.11130553028;6858.965705171473;6878.105846239994;6615.702293396796;6770.3906648401635;6803;6803.353681400272;6851.931480685192;4435.223835828733;5076.492350764931;5085.110105731501;5107.438181799999;5113.795448182068;4295.677824163185;4944.4313903900975;5084.67798372424;5093.236014597822;5121.1038068338075;4983.227599722049;5006.924896126561;5012.849614511552;5035.144025515653;5037;4517.728936263802;4833.734144622044;4986.601071914256;5036.445990940993;5040.722760248185;4079.5716449772644;4159.625633692952;4169.687273454473;4300.849470268526;4303.935440968388;6368.840778980516;6410.910145275315;6427.421532062137;6439.7746078887485;6442.291347951722;5848.41515848416;5879.3826648202175;5911.527077833763;5931.377205393414;5944.7027648617395;7013.964930175367;7243.7102515899305;7266.927330726678;7267.672954717051;7305.963470182668;4809.254565542346;4819.6867203631655;4827.08285425768;4834.250691142844;4840.467548569654;7679.846403071907;7700.229977002311;7702.422318326148;7709.074911010659;7713.807154821118;4066.8169932353117;4760.45254795696;4882.438519570223;4884.8290309838985;4894.95105048945;4935.827246046443;4984.451710311862;4989.401271847401;5003.074431230234;5010.498950105033;4760.309755085494;4920.458749537548;5866.413358664099;5910.286017055092;5930.644161350333;7312.305330993547;7337.0828646419195;7353.742619008309;7354.191038985708;7367.557946523226;1667.1497536256354;1733.159417682423;1733.9219735111951;1735.2451683517459;1746.9912650436665;1106.6624679472677;1110.439228189759;1124.9043831274269;1125.0380924309761;1125.7410795517078;5480.80817171405;6736.090627765189;6757.763478278237;6778.423833974069;6814.352636499525;6447.580907241108;7039.92960070403;7532.284432978859;7534.284242996907;7569.091708994956;6538.574992625559;6720.193576770819;6733.3266673333255;6776.796696099125;6802.115724955823;3062.6784187659973;3931.958031121755;3984.183242435294;3999.320115580358;4015.638592526687;7462.067241594801;7567.129780075252;7569.394448444111;7576.393888488908;7628.771136865903;6330.8417289567205;7855.607219638995;7858;7867.370610351159;7917.564533950573;7353;7620.657070431844;7623.809404764926;7650.540967541854;7694.807629809299;7586.582737949245;7597.6201189941385;7601.163871974189;7617.047869016373;7618.885716714143;7323.084614423197;7496.8500629986;7503.812404689927;7517;7578.772636820904;7643.350315223046;7645.808854778675;7646.9617651911385;7672.156062833195;7689.730859420118;4890;4905.852824415273;4910.582600479;4915.65590408668;4921.302150757982;6275.560710750204;7236.167840698176;7515.436342274242;7527.172011078667;7534.171241163358;7242.818929526804;7290.927090729025;7299.197088320174;7320.816979575553;7320.890186647311;6220.284667263141;7256.383207427428;7297.890531642136;7301.269873012656;7347.375473084848;6932.792016239521;7032.683529241299;7116.181639111568;7131;7138.964305178441;7272.527285726623;7281.453890958093;7293.927060729325;7313.012743279589;7331.706731730885;6929.5842249465195;7097.183823860116;7130.393916517154;7132.536385134949;7154.320339567733 05:03:06 INFO - 2015-11-23 05:03:06,978 DEBUG : BROWSER_OUTPUT: |5;yui.html;696.9233384327727;698.7589281697819;721.3976329764646;774.1136398823347;815.7144999250263;14684.77972830407;15017.849821501783;15027.474038408658;15128.167950762718;15157.09057456552;13780.862191378083;14343.354549045293;14451;14453.277336133204;14464.783028254584;775.1318523253964;779.4349096904728;955.3790036476312;973.6640858903702;975.1077763846072;962.210986990668;977.0522593084696;978.4373984958642;980.9558569864338;985.4136788610765;1004.638330201127;1022.5960745505521;1025.702546261587;1031.2111234905303;1033.6485594897733;1005.2762011351851;1008.2488546033215;1024.3188279793928;1025.3489034463096;1039.9220058495605;748.5059860492049;756.2701992577189;756.4553521464537;757.2957149850637;759.4076620236225;14993.400263989428;14995.250237488082;15000.774988375184;15008.399664013426;15073.773893391608;12436.81344779829;12662.746745065047;12673.809892851614;12863.742725145537;13122.278274694889;10943.507542160542;11069.723256918562;11526.19316647835;11967.82048269268;12108.576199832964;3486.965130348715;3612.151144481045;3612.476190952297;3620.294042661682;3633.382325004729;46432;71445.6427717858;73862;74850;75054;9277.231960661346;9291.67479138227;9402.576884040234;9661.372010819416;9693.70918872435;21124.78875211259;21148.259810906544;21246.893765531382;21262.043208055675;21278;7513.699452021967;7514.624268786539;7704.460687751804;7849.293563579306;8020.318272946748;4089.1617218470737;4096.5903409658795;4099.549049604541;4106.774127422961;4138.772367519755;3555.466679998021;3559.733020023457;3570.0182449826507;3580.7314451415727;3582.802945837952;664.3655309179721;664.5613894829389;665.8102440804445;698.4028655499576;698.7728988078894;496.3720893070269;506.9822556210515;508.5346907579597;509.6101482365993;525.7765449683945;7086.92913070873;8519.403641745019;8599.527026013504;8700.825983480421;8812.16284452976;450.70028431092953;459.80228501743903;471.30247234093736;498.0686116961306;506.57194670503367;3861.3242682530445;3867.7099217558793;4062.532808726975;4132.8140233689555;4234.767087810138;99862;100361;102685.48657256666;103257;103933.48033259786;83772.58113709514;83854.58072709598;84020;84110.15889841145;85782;74663;74978.62510687411;75119.62440187763;75343;76708.61645691736;6835.965820170867;8231.711890083818;8811.691590794291;8986.19124278818;9103.681371151977;52241.7387913058;53101;53999.650008748526;54593;54805;69848.65075674589;69983.95024074745;70096;73914.63042684752;74697.6265118671;10741.946290268499;10746.570137194425;10749.571730209864;10856.294340867818;11107.278026928223;11891.167618266983;11925.76148477043;11992.820107698566;12000.63998080059;12017.63947081554;11231.101511879193;11475.13936454786;11482.138839586898;11658.76682466363;11784.175107742376;10934.56261749521;11081;11462.82805757931;11657.659369172654;11857.288562686266;10800.559984908383;11121.05471034971;11431.199816013132;11510.36692981894;11868.465919033837;7825.960870195612;9581.185599224144;9631.662891799033;9987.051230133126;10148.949255253676;8945.284377249674;9451.265196847258;10043.404810907503;10098.141657958862;10121.732189183678 05:03:06 INFO - 2015-11-23 05:03:06,978 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:03:06 INFO - 2015-11-23 05:03:06,978 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:03:06 INFO - 2015-11-23 05:03:06,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,325 05:03:06 INFO - 2015-11-23 05:03:06,978 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:03:06 INFO - 2015-11-23 05:03:06,979 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283786964__endTimestamp 05:03:06 INFO - 2015-11-23 05:03:06,979 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,979 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:03:06 INFO - 2015-11-23 05:03:06,979 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:03:06 INFO - 2015-11-23 05:03:06,979 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,979 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5854.80 Median:6113.36 stddev:659.96 (10.8%) stddev-sans-first:635.14 05:03:06 INFO - 2015-11-23 05:03:06,980 DEBUG : BROWSER_OUTPUT: Values: 3479.7 3583.3 3593.2 3623.5 3623.9 5962.9 5987.7 5994.4 5998.1 6035.3 4632.6 5734.9 5895.3 5915.9 6029.1 4949.0 5317.4 5362.9 5383.2 5407.8 5356.8 5428.5 5441.8 5464.6 5468.8 5116.7 5165.5 5257.6 5312.5 5336.7 5398.6 5403.5 5420.2 5420.2 5437.8 5324.8 5373.7 5400.7 5415.5 5474.9 5466.9 5528.7 5532.9 5832.3 5957.4 6364.9 6385.4 6400.8 6417.2 6431.7 6119.8 6532.0 6547.7 6557.4 6566.7 6053.4 6111.5 6125.9 6151.5 6168.7 6519.8 6655.1 6669.0 6676.4 6691.1 6116.5 6268.6 6282.0 6342.1 6347.1 6293.7 6421.3 6441.5 6473.4 6485.2 6260.7 6273.6 6289.1 6291.7 6302.7 6115.5 6193.0 6231.5 6287.2 6307.5 5063.2 5126.3 5128.3 5140.5 5154.0 4605.1 4616.3 4634.5 4639.5 4672.1 5919.9 5978.3 6074.4 6086.4 6088.2 6144.7 6201.0 6308.1 6406.0 6543.9 4983.3 5970.3 5990.4 6026.8 6038.8 5374.6 5519.0 5574.7 5581.5 5585.7 5502.8 6232.3 6264.0 6371.0 6373.6 5291.0 5408.4 6422.4 6492.9 6501.8 5587.9 6147.7 6163.7 6243.3 6287.7 6341.5 6397.5 6397.5 6409.5 6411.2 6518.9 6540.7 6544.7 6545.8 6558.1 5861.2 6123.3 6188.8 6236.1 6336.3 6235.7 6285.6 6289.1 6293.9 6311.1 4475.9 5166.7 6063.5 6211.4 6229.2 5425.4 6113.4 6130.6 6158.2 6214.3 5171.4 6219.3 6237.3 6250.0 6264.7 05:03:06 INFO - 2015-11-23 05:03:06,980 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,980 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63764.01 Median:36514.91 stddev:129005.26 (353.3%) stddev-sans-first:129279.87 05:03:06 INFO - 2015-11-23 05:03:06,982 DEBUG : BROWSER_OUTPUT: Values: 556.7 558.6 576.1 607.2 618.5 30465.5 41203.4 41246.8 41614.0 41623.5 45498.9 45586.8 45901.0 46075.0 46320.8 9947.2 10111.0 10116.5 10125.4 10171.6 9910.7 10034.9 10043.3 10052.8 10072.5 9949.5 10023.8 10032.9 10080.9 10100.1 9923.2 10046.3 10066.2 10070.5 10097.7 9876.8 9984.8 9998.3 10003.7 10022.6 42300.6 42362.8 42579.8 42699.8 42774.4 3425.8 3510.0 3677.0 3781.5 4103.2 28924.4 30312.6 30332.4 30524.0 30740.2 2707.9 2754.3 2784.6 2889.5 2983.2 433900.0 496318.0 499770.5 500167.0 501638.0 56982.7 57725.4 70114.6 70469.6 70833.0 70151.3 70395.0 70703.9 70757.6 71191.0 16608.8 16735.0 16796.7 16854.9 17203.7 11309.2 12268.5 12619.6 12663.9 12804.0 19335.5 20840.9 20923.9 21042.0 21138.6 8075.7 8545.9 9509.9 9552.6 9564.3 961.5 968.2 1023.4 1028.2 1198.3 31283.4 31458.2 31835.7 32186.0 32368.4 1071.5 1105.6 1108.6 1185.1 1191.9 15220.8 15236.0 15460.6 15594.9 15602.7 552268.0 553007.0 557325.0 558969.0 560626.0 55611.9 56709.1 58920.7 59416.0 59684.7 1436.9 1444.6 1465.4 1471.9 1491.6 29567.3 29927.0 30929.8 31370.0 31536.7 55022.7 55126.7 55251.2 55799.7 55916.4 396725.0 399671.0 399998.0 402887.0 404058.0 29206.0 29642.0 31194.7 33793.8 34547.5 43283.0 44063.3 44286.8 44389.9 45110.0 38343.8 38373.4 38954.0 39267.8 39340.4 36099.8 37583.2 38585.8 38623.6 38839.4 36435.0 36594.8 38328.0 38488.2 38586.4 27296.0 28363.0 32275.4 33844.0 33982.6 24314.8 25767.4 25886.1 25990.6 26122.3 05:03:06 INFO - 2015-11-23 05:03:06,982 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,982 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39462.90 Median:20416.24 stddev:127785.22 (625.9%) stddev-sans-first:128109.96 05:03:06 INFO - 2015-11-23 05:03:06,983 DEBUG : BROWSER_OUTPUT: Values: 362.5 365.7 365.8 368.4 370.4 15804.4 19626.4 20423.8 20680.5 20943.7 11904.6 14098.9 15351.0 20632.7 20757.4 5212.8 5337.0 5352.7 5369.9 5386.2 4471.0 4929.2 5106.3 5248.8 5295.7 3812.2 3947.0 5232.3 5256.1 5284.1 5574.0 5706.9 5710.6 5730.0 5761.7 4790.6 5374.9 5508.0 5517.6 5535.7 12785.8 12815.6 12817.9 22100.9 24283.3 1987.6 2027.1 2072.5 2102.0 2120.6 8566.8 9973.6 10191.0 10634.7 13714.9 1770.8 1777.8 1818.4 1871.8 1895.1 93643.0 100499.0 101183.5 102090.5 102868.0 10793.9 11029.9 11045.3 11158.2 11200.2 13298.7 13309.1 13329.1 13370.7 13387.3 8599.2 8633.1 8636.1 8655.7 8685.3 8681.9 8718.9 8758.6 8827.3 8833.2 4368.9 4404.3 4417.2 4430.5 4452.7 1856.4 1882.6 1901.4 1905.7 1906.4 845.0 919.0 919.7 996.6 1015.7 19547.9 19763.9 20242.0 20282.0 20408.7 833.5 970.2 997.8 1013.4 1049.4 9739.0 10745.5 10770.9 10775.7 10790.7 769414.2 770223.0 775492.0 778623.0 788705.0 122812.0 123968.4 124573.0 125846.0 126793.4 1161.4 1163.9 1182.6 1185.2 1218.8 17823.8 18674.0 19084.9 19172.6 19178.7 44851.3 45027.3 51309.0 52821.0 52943.5 66519.3 74583.6 74889.9 75990.0 76909.2 9783.9 9794.3 9881.7 10105.6 10117.1 19377.9 19559.0 19721.3 19759.3 20165.9 15492.5 15756.5 15785.6 15794.8 15911.9 12733.5 13199.3 15487.1 15556.5 15825.3 15734.3 16018.9 16125.2 16563.3 16671.7 7903.8 9691.2 9790.2 9857.5 9896.5 15749.3 15869.8 15892.8 16171.9 16212.1 05:03:06 INFO - 2015-11-23 05:03:06,983 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,983 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5893.78 Median:5295.30 stddev:3091.76 (58.4%) stddev-sans-first:3081.77 05:03:06 INFO - 2015-11-23 05:03:06,985 DEBUG : BROWSER_OUTPUT: Values: 1375.4 1561.1 1847.5 1874.9 1928.3 6498.1 7568.4 8611.6 8822.3 8847.6 8314.9 8501.5 8557.0 8595.4 8647.4 2384.3 2419.5 2420.9 2426.9 2427.6 2395.5 2432.5 2437.7 2445.1 2456.0 2379.7 2385.8 2417.5 2425.7 2429.6 2363.0 2390.9 2411.1 2414.6 2416.4 2421.4 2430.2 2445.8 2450.3 2453.3 8465.2 8495.5 8540.5 8556.4 8560.5 5211.6 5245.1 5291.8 5298.8 5320.7 3301.4 3346.4 3552.3 3579.8 3629.4 1060.1 1071.2 1078.1 1088.3 1088.3 11351.9 11408.7 11461.8 11495.8 11505.8 4736.7 4755.2 4775.2 4784.9 4802.4 9762.7 9764.0 9799.9 9820.3 9824.5 5236.2 5263.2 5279.7 5289.0 5309.7 4227.2 4360.3 4674.4 4750.8 4771.2 3291.3 3900.4 3942.0 3960.7 3974.3 1166.9 1271.4 1306.3 1314.6 1316.3 1324.9 1329.0 1341.2 1382.1 1387.8 7851.9 7853.7 7950.0 7999.0 8008.9 432.8 504.3 513.5 514.8 517.5 5237.3 5499.0 5676.3 6010.6 6084.4 9936.9 10177.5 10331.1 10366.7 10379.7 9849.9 10168.2 10176.4 10248.7 10262.6 7827.1 7857.1 7897.8 7919.2 7991.3 7893.4 7898.4 7913.8 7938.9 7965.8 9041.1 9240.2 9288.6 9352.6 9420.2 8085.9 9158.5 9303.9 9496.5 9497.5 6667.4 6912.0 7375.4 7560.4 7599.0 8188.8 8210.7 8225.4 8226.5 8263.8 7551.0 7672.0 7704.7 7784.3 7814.8 7481.2 7486.2 7518.2 7624.9 7635.4 7588.0 7687.8 7698.4 7723.1 7733.3 6940.0 6948.4 6971.9 7000.3 7024.3 7019.8 7038.8 7038.9 7083.6 7108.6 05:03:06 INFO - 2015-11-23 05:03:06,985 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,985 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5915.18 Median:6744.79 stddev:1886.24 (28.0%) stddev-sans-first:1844.20 05:03:06 INFO - 2015-11-23 05:03:06,987 DEBUG : BROWSER_OUTPUT: Values: 321.1 325.4 327.3 333.4 334.7 6596.8 6753.5 6836.1 6859.0 6878.1 6615.7 6770.4 6803.0 6803.4 6851.9 4435.2 5076.5 5085.1 5107.4 5113.8 4295.7 4944.4 5084.7 5093.2 5121.1 4983.2 5006.9 5012.8 5035.1 5037.0 4517.7 4833.7 4986.6 5036.4 5040.7 4079.6 4159.6 4169.7 4300.8 4303.9 6368.8 6410.9 6427.4 6439.8 6442.3 5848.4 5879.4 5911.5 5931.4 5944.7 7014.0 7243.7 7266.9 7267.7 7306.0 4809.3 4819.7 4827.1 4834.3 4840.5 7679.8 7700.2 7702.4 7709.1 7713.8 4066.8 4760.5 4882.4 4884.8 4895.0 4935.8 4984.5 4989.4 5003.1 5010.5 4760.3 4920.5 5866.4 5910.3 5930.6 7312.3 7337.1 7353.7 7354.2 7367.6 1667.1 1733.2 1733.9 1735.2 1747.0 1106.7 1110.4 1124.9 1125.0 1125.7 5480.8 6736.1 6757.8 6778.4 6814.4 6447.6 7039.9 7532.3 7534.3 7569.1 6538.6 6720.2 6733.3 6776.8 6802.1 3062.7 3932.0 3984.2 3999.3 4015.6 7462.1 7567.1 7569.4 7576.4 7628.8 6330.8 7855.6 7858.0 7867.4 7917.6 7353.0 7620.7 7623.8 7650.5 7694.8 7586.6 7597.6 7601.2 7617.0 7618.9 7323.1 7496.9 7503.8 7517.0 7578.8 7643.4 7645.8 7647.0 7672.2 7689.7 4890.0 4905.9 4910.6 4915.7 4921.3 6275.6 7236.2 7515.4 7527.2 7534.2 7242.8 7290.9 7299.2 7320.8 7320.9 6220.3 7256.4 7297.9 7301.3 7347.4 6932.8 7032.7 7116.2 7131.0 7139.0 7272.5 7281.5 7293.9 7313.0 7331.7 6929.6 7097.2 7130.4 7132.5 7154.3 05:03:06 INFO - 2015-11-23 05:03:06,987 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-23 05:03:06,987 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18828.37 Median:4135.79 stddev:26874.68 (649.8%) stddev-sans-first:26915.59 05:03:06 INFO - 2015-11-23 05:03:06,987 DEBUG : BROWSER_OUTPUT: Values: 696.9 698.8 721.4 774.1 815.7 14684.8 15017.8 15027.5 15128.2 15157.1 13780.9 14343.4 14451.0 14453.3 14464.8 775.1 779.4 955.4 973.7 975.1 962.2 977.1 978.4 981.0 985.4 1004.6 1022.6 1025.7 1031.2 1033.6 1005.3 1008.2 1024.3 1025.3 1039.9 748.5 756.3 756.5 757.3 759.4 14993.4 14995.3 15000.8 15008.4 15073.8 12436.8 12662.7 12673.8 12863.7 13122.3 10943.5 11069.7 11526.2 11967.8 12108.6 3487.0 3612.2 3612.5 3620.3 3633.4 46432.0 71445.6 73862.0 74850.0 75054.0 9277.2 9291.7 9402.6 9661.4 9693.7 21124.8 21148.3 21246.9 21262.0 21278.0 7513.7 7514.6 7704.5 7849.3 8020.3 4089.2 4096.6 4099.5 4106.8 4138.8 3555.5 3559.7 3570.0 3580.7 3582.8 664.4 664.6 665.8 698.4 698.8 496.4 507.0 508.5 509.6 525.8 7086.9 8519.4 8599.5 8700.8 8812.2 450.7 459.8 471.3 498.1 506.6 3861.3 3867.7 4062.5 4132.8 4234.8 99862.0 100361.0 102685.5 103257.0 103933.5 83772.6 83854.6 84020.0 84110.2 85782.0 74663.0 74978.6 75119.6 75343.0 76708.6 6836.0 8231.7 8811.7 8986.2 9103.7 52241.7 53101.0 53999.7 54593.0 54805.0 69848.7 69984.0 70096.0 73914.6 74697.6 10741.9 10746.6 10749.6 10856.3 11107.3 11891.2 11925.8 11992.8 12000.6 12017.6 11231.1 11475.1 11482.1 11658.8 11784.2 10934.6 11081.0 11462.8 11657.7 11857.3 10800.6 11121.1 11431.2 11510.4 11868.5 7826.0 9581.2 9631.7 9987.1 10148.9 8945.3 9451.3 10043.4 10098.1 10121.7 05:03:06 INFO - 2015-11-23 05:03:06,987 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:03:06 INFO - 2015-11-23 05:03:06,987 DEBUG : BROWSER_OUTPUT: 05:03:07 INFO - 2015-11-23 05:03:07,398 INFO : Browser exited with error code: 0 05:03:07 INFO - 2015-11-23 05:03:07,424 INFO : Completed test dromaeo_css (00:18:30) 05:03:07 INFO - 2015-11-23 05:03:07,424 INFO : Starting test kraken 05:03:07 INFO - 2015-11-23 05:03:07,424 DEBUG : operating with platform_type : mac_ 05:03:07 INFO - 2015-11-23 05:03:07,424 INFO : Initialising browser for kraken test... 05:03:07 INFO - 2015-11-23 05:03:07,436 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpdpO61S/profile http://localhost:49269/getInfo.html 05:03:10 INFO - 2015-11-23 05:03:10,095 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:03:10 INFO - 2015-11-23 05:03:10,095 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:03:10 INFO - 2015-11-23 05:03:10,095 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:03:10 INFO - 2015-11-23 05:03:10,095 DEBUG : BROWSER_OUTPUT: __metrics 05:03:10 INFO - 2015-11-23 05:03:10,667 INFO : Browser initialized. 05:03:10 INFO - 2015-11-23 05:03:10,667 INFO : Running cycle 1/1 for kraken test... 05:03:10 INFO - 2015-11-23 05:03:10,667 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpdpO61S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:03:22 INFO - 2015-11-23 05:03:22,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 236646400 05:03:22 INFO - 2015-11-23 05:03:22,616 DEBUG : BROWSER_OUTPUT: 05:03:25 INFO - 2015-11-23 05:03:25,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:25 INFO - 2015-11-23 05:03:25,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 248225792 05:03:25 INFO - 2015-11-23 05:03:25,974 DEBUG : BROWSER_OUTPUT: 05:03:28 INFO - 2015-11-23 05:03:28,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 05:03:29 INFO - 2015-11-23 05:03:29,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 258572288 05:03:29 INFO - 2015-11-23 05:03:29,373 DEBUG : BROWSER_OUTPUT: 05:03:32 INFO - 2015-11-23 05:03:32,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 05:03:33 INFO - 2015-11-23 05:03:33,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 262053888 05:03:33 INFO - 2015-11-23 05:03:33,255 DEBUG : BROWSER_OUTPUT: 05:03:35 INFO - 2015-11-23 05:03:35,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 05:03:35 INFO - 2015-11-23 05:03:35,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 262393856 05:03:35 INFO - 2015-11-23 05:03:35,806 DEBUG : BROWSER_OUTPUT: 05:03:37 INFO - 2015-11-23 05:03:37,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:38 INFO - 2015-11-23 05:03:38,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 264454144 05:03:38 INFO - 2015-11-23 05:03:38,369 DEBUG : BROWSER_OUTPUT: 05:03:41 INFO - 2015-11-23 05:03:41,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:41 INFO - 2015-11-23 05:03:41,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 263057408 05:03:41 INFO - 2015-11-23 05:03:41,673 DEBUG : BROWSER_OUTPUT: 05:03:44 INFO - 2015-11-23 05:03:44,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:45 INFO - 2015-11-23 05:03:45,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 262909952 05:03:45 INFO - 2015-11-23 05:03:45,166 DEBUG : BROWSER_OUTPUT: 05:03:48 INFO - 2015-11-23 05:03:48,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 05:03:48 INFO - 2015-11-23 05:03:48,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 263241728 05:03:48 INFO - 2015-11-23 05:03:48,714 DEBUG : BROWSER_OUTPUT: 05:03:50 INFO - 2015-11-23 05:03:50,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:50 INFO - 2015-11-23 05:03:50,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 264888320 05:03:50 INFO - 2015-11-23 05:03:50,837 DEBUG : BROWSER_OUTPUT: 05:03:52 INFO - 2015-11-23 05:03:52,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:53 INFO - 2015-11-23 05:03:53,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 264638464 05:03:53 INFO - 2015-11-23 05:03:53,240 DEBUG : BROWSER_OUTPUT: 05:03:55 INFO - 2015-11-23 05:03:55,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:55 INFO - 2015-11-23 05:03:55,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 264998912 05:03:55 INFO - 2015-11-23 05:03:55,914 DEBUG : BROWSER_OUTPUT: 05:03:58 INFO - 2015-11-23 05:03:58,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:59 INFO - 2015-11-23 05:03:59,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 264093696 05:03:59 INFO - 2015-11-23 05:03:59,110 DEBUG : BROWSER_OUTPUT: 05:04:01 INFO - 2015-11-23 05:04:01,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:02 INFO - 2015-11-23 05:04:02,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 264482816 05:04:02 INFO - 2015-11-23 05:04:02,282 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 05:04:04 INFO - 2015-11-23 05:04:04,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 264048640 05:04:04 INFO - 2015-11-23 05:04:04,299 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,299 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:04:04 INFO - 2015-11-23 05:04:04,299 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;114;123;118;126;137;161;162;114 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;128;177;147;145;176;164;165;184;145 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |2;audio-dft;195;207;222;187;217;214;194;190;236;201 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |3;audio-fft;52;71;103;140;48;47;60;61;140;83 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;77;109;88;85;76;107;76;78;107 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;90;87;87;88;89;88;88;87;105 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;95;98;98;95;94;150;96;120;106 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;92;92;121;79;150;147;120;91;88;91 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;59;59;60;67;62;51;69;57;62 05:04:04 INFO - 2015-11-23 05:04:04,301 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;66;57;94;72;68;68;69;71 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;99;84;83;87;84;84;84;86;85 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;130;127;127;133;137;129;138;138;138 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;171;128;178;174;175;134;141;139;139;139 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;61;90;97;92;88;82;68;66;68 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,814 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283844299__endTimestamp 05:04:04 INFO - 2015-11-23 05:04:04,302 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,304 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:04:04 INFO - 2015-11-23 05:04:04,304 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:04:04 INFO - 2015-11-23 05:04:04,304 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,304 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:127.70 Median:124.50 stddev:19.56 (15.7%) stddev-sans-first:20.10 05:04:04 INFO - 2015-11-23 05:04:04,304 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 114.0 123.0 118.0 126.0 137.0 161.0 162.0 114.0 05:04:04 INFO - 2015-11-23 05:04:04,304 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:157.70 Median:164.50 stddev:18.10 (11.0%) stddev-sans-first:18.69 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: Values: 146.0 128.0 177.0 147.0 145.0 176.0 164.0 165.0 184.0 145.0 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:206.30 Median:210.50 stddev:15.80 (7.5%) stddev-sans-first:16.23 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: Values: 195.0 207.0 222.0 187.0 217.0 214.0 194.0 190.0 236.0 201.0 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:56.00 stddev:35.71 (63.8%) stddev-sans-first:36.35 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: Values: 52.0 71.0 103.0 140.0 48.0 47.0 60.0 61.0 140.0 83.0 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.00 Median:77.00 stddev:14.15 (18.4%) stddev-sans-first:14.44 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 109.0 88.0 85.0 76.0 107.0 76.0 78.0 107.0 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,305 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:88.00 stddev:5.50 (6.3%) stddev-sans-first:5.75 05:04:04 INFO - 2015-11-23 05:04:04,306 DEBUG : BROWSER_OUTPUT: Values: 87.0 90.0 87.0 87.0 88.0 89.0 88.0 88.0 87.0 105.0 05:04:04 INFO - 2015-11-23 05:04:04,306 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,306 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:104.70 Median:95.00 stddev:17.80 (18.7%) stddev-sans-first:18.53 05:04:04 INFO - 2015-11-23 05:04:04,306 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 98.0 98.0 95.0 94.0 150.0 96.0 120.0 106.0 05:04:04 INFO - 2015-11-23 05:04:04,306 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,306 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:107.10 Median:89.50 stddev:25.65 (28.7%) stddev-sans-first:26.62 05:04:04 INFO - 2015-11-23 05:04:04,307 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 121.0 79.0 150.0 147.0 120.0 91.0 88.0 91.0 05:04:04 INFO - 2015-11-23 05:04:04,307 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,307 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.50 stddev:5.01 (8.1%) stddev-sans-first:5.32 05:04:04 INFO - 2015-11-23 05:04:04,307 DEBUG : BROWSER_OUTPUT: Values: 61.0 59.0 59.0 60.0 67.0 62.0 51.0 69.0 57.0 62.0 05:04:04 INFO - 2015-11-23 05:04:04,307 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:68.50 stddev:9.46 (13.8%) stddev-sans-first:9.94 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 57.0 94.0 72.0 68.0 68.0 69.0 71.0 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.50 stddev:5.43 (6.3%) stddev-sans-first:4.94 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: Values: 95.0 99.0 84.0 83.0 87.0 84.0 84.0 84.0 86.0 85.0 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:135.00 stddev:4.74 (3.5%) stddev-sans-first:4.85 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: Values: 129.0 130.0 127.0 127.0 133.0 137.0 129.0 138.0 138.0 138.0 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:156.00 stddev:19.94 (12.8%) stddev-sans-first:19.90 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: Values: 171.0 128.0 178.0 174.0 175.0 134.0 141.0 139.0 139.0 139.0 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:85.00 stddev:12.97 (15.3%) stddev-sans-first:13.41 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: Values: 70.0 61.0 90.0 97.0 92.0 88.0 82.0 68.0 66.0 68.0 05:04:04 INFO - 2015-11-23 05:04:04,308 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:04:04 INFO - 2015-11-23 05:04:04,309 DEBUG : BROWSER_OUTPUT: 05:04:05 INFO - 2015-11-23 05:04:05,065 INFO : Browser exited with error code: 0 05:04:05 INFO - 2015-11-23 05:04:05,110 INFO : Completed test kraken (00:00:57) 05:04:05 INFO - 2015-11-23 05:04:05,111 INFO : Starting test v8_7 05:04:05 INFO - 2015-11-23 05:04:05,111 DEBUG : operating with platform_type : mac_ 05:04:05 INFO - 2015-11-23 05:04:05,111 INFO : Initialising browser for v8_7 test... 05:04:05 INFO - 2015-11-23 05:04:05,123 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpcMIZpx/profile http://localhost:49269/getInfo.html 05:04:07 INFO - 2015-11-23 05:04:07,880 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:04:07 INFO - 2015-11-23 05:04:07,880 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:04:07 INFO - 2015-11-23 05:04:07,880 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:04:07 INFO - 2015-11-23 05:04:07,881 DEBUG : BROWSER_OUTPUT: __metrics 05:04:08 INFO - 2015-11-23 05:04:08,482 INFO : Browser initialized. 05:04:08 INFO - 2015-11-23 05:04:08,482 INFO : Running cycle 1/1 for v8_7 test... 05:04:08 INFO - 2015-11-23 05:04:08,482 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpcMIZpx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:04:20 INFO - 2015-11-23 05:04:20,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 235958272 05:04:20 INFO - 2015-11-23 05:04:20,320 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 05:04:41 INFO - 2015-11-23 05:04:41,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 247681024 05:04:41 INFO - 2015-11-23 05:04:41,937 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,938 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:04:41 INFO - 2015-11-23 05:04:41,938 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:04:41 INFO - 2015-11-23 05:04:41,939 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:04:41 INFO - 2015-11-23 05:04:41,939 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:04:41 INFO - 2015-11-23 05:04:41,939 DEBUG : BROWSER_OUTPUT: |0;Richards;643.0868167202573 05:04:41 INFO - 2015-11-23 05:04:41,939 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;154.63120457708365 05:04:41 INFO - 2015-11-23 05:04:41,939 DEBUG : BROWSER_OUTPUT: |2;Encrypt;291.8855808523059 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4901.9607843137255 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: |4;RayTrace;954.1984732824427 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: |5;Earley;716.3323782234957 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: |6;Boyer;13333.333333333334 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: |7;RegExp;28000 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: |8;Splay;588.5815185403178 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4524.886877828054 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283881937__endTimestamp 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,940 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:643.09 Median:643.09 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: Values: 643.1 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:154.63 Median:154.63 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: Values: 154.6 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:291.89 Median:291.89 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: Values: 291.9 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4901.96 Median:4901.96 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,941 DEBUG : BROWSER_OUTPUT: Values: 4902.0 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:954.20 Median:954.20 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: Values: 954.2 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: Values: 716.3 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13333.33 Median:13333.33 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: Values: 13333.3 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28000.00 Median:28000.00 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: Values: 28000.0 05:04:41 INFO - 2015-11-23 05:04:41,942 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,943 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:588.58 Median:588.58 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,943 DEBUG : BROWSER_OUTPUT: Values: 588.6 05:04:41 INFO - 2015-11-23 05:04:41,943 DEBUG : BROWSER_OUTPUT: 05:04:41 INFO - 2015-11-23 05:04:41,943 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4524.89 Median:4524.89 stddev:0.00 (0.0%) 05:04:41 INFO - 2015-11-23 05:04:41,943 DEBUG : BROWSER_OUTPUT: Values: 4524.9 05:04:41 INFO - 2015-11-23 05:04:41,943 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:04:41 INFO - 2015-11-23 05:04:41,943 DEBUG : BROWSER_OUTPUT: 05:04:42 INFO - 2015-11-23 05:04:42,666 INFO : Browser exited with error code: 0 05:04:42 INFO - 2015-11-23 05:04:42,683 INFO : Completed test v8_7 (00:00:37) 05:04:43 INFO - 2015-11-23 05:04:43,042 INFO : Completed test suite (00:20:05) 05:04:43 INFO - 2015-11-23 05:04:43,042 DEBUG : Working with test: dromaeo_css 05:04:43 INFO - 2015-11-23 05:04:43,043 DEBUG : Generating results file: dromaeo_css 05:04:43 INFO - 2015-11-23 05:04:43,043 DEBUG : Working with test: kraken 05:04:43 INFO - 2015-11-23 05:04:43,044 DEBUG : Generating results file: kraken 05:04:43 INFO - 2015-11-23 05:04:43,044 INFO : javascript benchmark 05:04:43 INFO - 2015-11-23 05:04:43,044 DEBUG : Working with test: v8_7 05:04:43 INFO - 2015-11-23 05:04:43,044 DEBUG : Generating results file: v8_7 05:04:43 INFO - 2015-11-23 05:04:43,044 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:04:43 INFO - 2015-11-23 05:04:43,565 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:04:43 INFO - 2015-11-23 05:04:43,565 DEBUG : process_Request line: dromaeo_css 7676.90 graph.html#tests=[[72,1,61]] 05:04:43 INFO - 2015-11-23 05:04:43,565 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:04:43 INFO - 2015-11-23 05:04:43,589 DEBUG : process_Request line: kraken 1541.70 graph.html#tests=[[232,1,61]] 05:04:43 INFO - 2015-11-23 05:04:43,589 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:04:43 INFO - 2015-11-23 05:04:43,614 DEBUG : process_Request line: v8_7 19114.86 graph.html#tests=[[230,1,61]] 05:04:43 INFO - 2015-11-23 05:04:43,615 INFO : javascript benchmark 05:04:43 INFO - 2015-11-23 05:04:43,617 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3479.6520347965197, 3583.2833433313344, 3593.245418462123, 3623.5289412376387, 3623.9094022649447, 5962.940370596293, 5987.670678112702, 5994.370591087938, 5998.0702991036405, 6035.336113027563, 4632.606228470576, 5734.881698068878, 5895.292564892219, 5915.911261331073, 6029.1257767623665, 4948.950510494903, 5317.388500322454, 5362.865928351803, 5383.219433182206, 5407.783688652449, 5356.812511562096, 5428.511433970942, 5441.83674489764, 5464.55189374816, 5468.781248750045, 5116.744162791882, 5165.457626949154, 5257.605679574047, 5312.495312945264, 5336.67979921206, 5398.568114550826, 5403.540699040586, 5420.186971954199, 5420.186971954199, 5437.8368648940595, 5324.787008519694, 5373.731313434313, 5400.729963501809, 5415.458454154593, 5474.863128421782, 5466.945330546723, 5528.723563821833, 5532.944670553283, 5832.270966129234, 5957.374475680078, 6364.904526432108, 6385.393387628168, 6400.839979000562, 6417.2299324081405, 6431.678416079224, 6119.837693858745, 6532.020196970445, 6547.738090476375, 6557.377049180321, 6566.737330506774, 6053.364396738367, 6111.480524155452, 6125.938740612626, 6151.5386346024225, 6168.722407491674, 6519.8044058678315, 6655.101561289261, 6668.966655166791, 6676.365745254193, 6691.130153080068, 6116.457510225599, 6268.561200715997, 6282.0, 6342.112104305401, 6347.079673447324, 6293.748250070037, 6421.325760795143, 6441.484681225491, 6473.352664733489, 6485.221773387224, 6260.655663938527, 6273.62358258506, 6289.088082228142, 6291.716872740738, 6302.747890084437, 6115.544587951936, 6192.969035154795, 6231.470325022424, 6287.2140982377205, 6307.463865571386, 5063.215201643751, 5126.333576635014, 5128.25640282157, 5140.485951404829, 5154.0, 4605.102005109038, 4616.261398176276, 4634.46703629087, 4639.536046395334, 4672.135654903854, 5919.911201331984, 5978.342382337939, 6074.36219196978, 6086.391360863879, 6088.178095957078, 6144.678894037804, 6200.968995154995, 6308.116863639094, 6405.967970160119, 6543.887539118361, 4983.277424773388, 5970.283565972024, 5990.371011043865, 6026.849328766728, 6038.818835434944, 5374.5700343972385, 5519.034169020405, 5574.749136288877, 5581.49766521015, 5585.69278689676, 5502.834914952397, 6232.3144454110015, 6264.029075493306, 6370.968145159244, 6373.6175829450385, 5290.973545132404, 5408.405075441777, 6422.389872962248, 6492.870142597028, 6501.772437964649, 5587.944120558743, 6147.692615369303, 6163.722632481638, 6243.282022567463, 6287.717052732546, 6341.460975817107, 6397.4562162216735, 6397.4562162216735, 6409.519286053658, 6411.230652321751, 6518.902216466851, 6540.672966351568, 6544.705488252945, 6545.836354091186, 6558.081868538313, 5861.1501332307425, 6123.343628574205, 6188.783392581238, 6236.126942228001, 6336.3030066693545, 6235.657038862906, 6285.560010799383, 6289.119523266655, 6293.937060629335, 6311.053341998553, 4475.865724028285, 5166.715830629351, 6063.5452341073715, 6211.440970312513, 6229.159063526366, 5425.376081750492, 6113.358097399709, 6130.570860039755, 6158.199434073542, 6214.25428948529, 5171.431142574239, 6219.284782250099, 6237.251529816451, 6250.031245157008, 6264.655443950626], "unit": "ms", "name": "dojo.html", "value": 5817.377849332123}, {"lowerIsBetter": false, "replicates": [556.656520306653, 558.6229295225719, 576.1070340971495, 607.2045620237486, 618.4557589321397, 30465.543016854765, 41203.381949270784, 41246.793766031165, 41613.95965100874, 41623.54317598881, 45498.8625284368, 45586.7720661397, 45901.0, 46075.0, 46320.768396157975, 9947.154491868181, 10111.0, 10116.494175291244, 10125.443100629462, 10171.643992460266, 9910.653127140551, 10034.949825250864, 10043.296969212159, 10052.798944021115, 10072.496375181248, 9949.502524873764, 10023.799524009515, 10032.949835250814, 10080.94959525205, 10100.090991810735, 9923.206143508502, 10046.346987445866, 10066.245031622657, 10070.546825392876, 10097.747556311078, 9876.802463950753, 9984.750381240454, 9998.300118991674, 10003.699889003341, 10022.649207277711, 42300.57699423028, 42362.788186058875, 42579.787101064605, 42699.7865010676, 42774.358384624255, 3425.760196786226, 3510.0, 3677.0, 3781.5273090863643, 4103.158852435244, 28924.42151156986, 30312.63593138292, 30332.393352132833, 30524.0, 30740.231494212825, 2707.945841083187, 2754.2701184186208, 2784.554471284605, 2889.4510043091955, 2983.1796256029547, 433900.0, 496318.0, 499770.5011474956, 500167.0, 501638.0, 56982.7150864243, 57725.42274577284, 70114.64942675356, 70469.64765176244, 70833.0, 70151.29848701549, 70395.0, 70703.93944090843, 70757.64621176862, 71191.0, 16608.833911660728, 16735.0, 16796.748048779278, 16854.915725421295, 17203.741943870853, 11309.151813614011, 12268.509259629693, 12619.62141135749, 12663.873361266453, 12803.975681945421, 19335.54983376224, 20840.895795520926, 20923.895380523, 21042.0, 21138.577228455346, 8075.717349892726, 8545.871811922827, 9509.857352139723, 9552.617895284111, 9564.321989842854, 961.4519723757531, 968.1963969904962, 1023.3501726403639, 1028.2082796246998, 1198.269055875915, 31283.374332513224, 31458.213544661565, 31835.681643183736, 32186.0, 32368.352632947208, 1071.5499490214129, 1105.5522513382093, 1108.6175269531998, 1185.1230089733708, 1191.92252503587, 15220.771688424682, 15236.009659372105, 15460.613484662748, 15594.9220253898, 15602.687946241012, 552268.0, 553007.0, 557325.0, 558969.0, 560626.0, 55611.88776224453, 56709.14936275877, 58920.705396472746, 59416.0, 59684.70157649184, 1436.9497067602583, 1444.5738507140418, 1465.4065103633045, 1471.9337629806685, 1491.6121808329694, 29567.26081847971, 29927.0, 30929.845350773103, 31370.0, 31536.684633153374, 55022.72488637531, 55126.724366379516, 55251.171232430745, 55799.721001396356, 55916.44083559112, 396725.0163749163, 399671.00164498994, 399998.0, 402887.0, 404058.0, 29206.0, 29641.9625313113, 31194.688053120088, 33793.83103084469, 34547.48178777371, 43283.0, 44063.33904991364, 44286.778566106965, 44389.89025274394, 45110.0, 38343.808280958416, 38373.424398633484, 38954.02614934649, 39267.80366098151, 39340.40989385104, 36099.81950090338, 37583.24833503369, 38585.80707096447, 38623.613763862, 38839.41740873946, 36435.0, 36594.8170259147, 38328.04179895525, 38488.2302353957, 38586.421203681406, 27296.0, 28363.0, 32275.35449291048, 33844.0, 33982.64069437195, 24314.756852431958, 25767.355816104748, 25886.093986710373, 25990.61014084828, 26122.346941326618], "unit": "ms", "name": "ext.html", "value": 20415.39376175822}, {"lowerIsBetter": false, "replicates": [362.54319557357735, 365.69281803285236, 365.84451608066564, 368.35905524387573, 370.38700949927863, 15804.44684436045, 19626.411207663776, 20423.795762042377, 20680.48298792531, 20943.685844712323, 11904.642860714172, 14098.872090232782, 15351.0, 20632.69050964237, 20757.377278681626, 5212.76542555585, 5336.9733151334185, 5352.652077614943, 5369.892602147955, 5386.245925570423, 4471.016376397188, 4929.186684197121, 5106.336176297076, 5248.763805628756, 5295.735213239342, 3812.218495208476, 3946.980265098685, 5232.2674825524455, 5256.132738098209, 5284.075286824809, 5574.0, 5706.857328566777, 5710.628809127435, 5729.997250481149, 5761.683107429089, 4790.640701947368, 5374.865628359284, 5508.0, 5517.5585953123655, 5535.6955367454775, 12785.762491563939, 12815.551455699098, 12817.935910320388, 22100.88949555258, 24283.271501854797, 1987.6322880267053, 2027.0574183004826, 2072.4611600983703, 2102.02255950982, 2120.5652841167525, 8566.785830354229, 9973.551190196386, 10191.0, 10634.734131646694, 13714.862851371558, 1770.7609472721276, 1777.8222177782118, 1818.436284751718, 1871.7566716326926, 1895.109298629642, 93643.0, 100498.9950100497, 101183.49408252911, 102090.48954755253, 102868.0, 10793.946030269955, 11029.867146139182, 11045.28205666629, 11158.218924675195, 11200.215984881143, 13298.667533311746, 13309.134906231064, 13329.133606315558, 13370.732585348238, 13387.263700496565, 8599.183077607617, 8633.093525179891, 8636.136386361313, 8655.6970506032, 8685.305175585938, 8681.913180868236, 8718.86921696175, 8758.56207189638, 8827.293816494664, 8833.160849719266, 4368.912621747547, 4404.317330813729, 4417.182821178092, 4430.468343798765, 4452.666050046259, 1856.3688345962437, 1882.5952420229717, 1901.363043380483, 1905.7427247321434, 1906.3613689413924, 844.9619767110495, 918.9540522973824, 919.6873063158558, 996.5963784667076, 1015.7308313296983, 19547.902260488605, 19763.912984785686, 20241.987900605207, 20282.0, 20408.693869591967, 833.4957350802798, 970.1608108985677, 997.835357166074, 1013.3767732844248, 1049.4123290957089, 9739.0, 10745.51645175969, 10770.94614526938, 10775.730606734895, 10790.73023174427, 769414.1529292318, 770223.0, 775492.0, 778623.0, 788705.0, 122812.0, 123968.38015809863, 124573.0, 125846.0, 126793.36603317109, 1161.4250945781891, 1163.9301641901513, 1182.5624518928053, 1185.1526158796503, 1218.8476440444945, 17823.84145030569, 18674.022165896542, 19084.904575477034, 19172.61654766869, 19178.712319315502, 44851.32723009092, 45027.32459013052, 51309.0, 52821.0, 52943.47056529386, 66519.33480665131, 74583.62708186642, 74889.87665184918, 75990.0, 76909.23090769244, 9783.902160978583, 9794.26543009263, 9881.703548893545, 10105.646302379382, 10117.140043096124, 19377.934213618388, 19559.0, 19721.309754158534, 19759.308424205083, 20165.899170504053, 15492.457763978657, 15756.527304180892, 15785.605359866095, 15794.76307855406, 15911.920440397724, 12733.490660373482, 13199.340032998503, 15487.148206848731, 15556.455524056604, 15825.287862046465, 15734.291956862198, 16018.919905400864, 16125.193740312703, 16563.337466501685, 16671.749923751395, 7903.84192316139, 9691.176250018545, 9790.167835734042, 9857.457839818879, 9896.505174741378, 15749.291281892114, 15869.761953570474, 15892.841071589599, 16171.919140404223, 16212.10833404174], "unit": "ms", "name": "jquery.html", "value": 9798.08191497622}, {"lowerIsBetter": false, "replicates": [1375.4360712108037, 1561.055561385362, 1847.475832438238, 1874.915628796704, 1928.3443629166084, 6498.057781621662, 7568.356689681384, 8611.569421528922, 8822.250108740765, 8847.557622118893, 8314.91685083149, 8501.489910605367, 8556.957215213915, 8595.355348348867, 8647.35144864136, 2384.320468666435, 2419.5402873454077, 2420.8668523231217, 2426.9271921842374, 2427.5630386530415, 2395.4849707312924, 2432.4648577312964, 2437.70747510299, 2445.1319781477587, 2456.0, 2379.690640216778, 2385.785279324869, 2417.516496700658, 2425.7143713831697, 2429.6355546667965, 2362.9881850590637, 2390.8565486070806, 2411.1078900806815, 2414.5653782319177, 2416.395901024744, 2421.4430680943483, 2430.1980346485616, 2445.779879810808, 2450.33840862966, 2453.276283496373, 8465.195806398382, 8495.490270583785, 8540.530270835101, 8556.443831150955, 8560.529170895597, 5211.635185537014, 5245.055889939809, 5291.788328466857, 5298.81454149103, 5320.707361095138, 3301.3892429900307, 3346.397648423283, 3552.3250582389264, 3579.838907249154, 3629.383004889175, 1060.120100316743, 1071.1912506057954, 1078.094400703405, 1088.2817340555196, 1088.3198001249218, 11351.886481135165, 11408.657740267805, 11461.770764584746, 11495.770084598262, 11505.827412588735, 4736.692115012514, 4755.191617425046, 4775.188218002948, 4784.928226076611, 4802.447718512346, 9762.707118786448, 9764.0, 9799.853002204973, 9820.312578119463, 9824.45965471906, 5236.188390799432, 5263.18420644793, 5279.736013199325, 5288.995090932711, 5309.734513274321, 4227.175700738327, 4360.302351623725, 4674.368960190331, 4750.809967601257, 4771.188897887368, 3291.259466619991, 3900.3759398496104, 3941.9802900985887, 3960.7029472789654, 3974.344233201547, 1166.935818529972, 1271.3833790611545, 1306.3337697774205, 1314.6384744195423, 1316.2892038299403, 1324.9403776830065, 1329.0364485747948, 1341.1751772659939, 1382.05329349396, 1387.8334599848083, 7851.9214807851195, 7853.7251196209, 7950.0, 7999.0, 8008.879866802003, 432.7706315652709, 504.25527674246786, 513.509598333598, 514.7580637100557, 517.4644243208261, 5237.3453318335205, 5498.9826882026955, 5676.318841738936, 6010.609310394811, 6084.361142080018, 9936.900630993741, 10177.54201060954, 10331.070203681706, 10366.740831479274, 10379.740506487247, 9849.852252216222, 10168.237382196365, 10176.440295783656, 10248.692539223835, 10262.589496420209, 7827.1390147083775, 7857.096433910059, 7897.842043159105, 7919.247671471201, 7991.2807847294025, 7893.407994400328, 7898.407619428681, 7913.841723165389, 7938.880916786137, 7965.761027169194, 9041.05068967749, 9240.214581760625, 9288.58201380953, 9352.579133938852, 9420.152186303265, 8085.919140808516, 9158.450492970444, 9303.860442093239, 9496.477693726634, 9497.525123743924, 6667.399934005963, 6911.997760324624, 7375.409967202503, 7560.432967527568, 7599.0, 8188.754337369888, 8210.712625058333, 8225.383096267684, 8226.465279756796, 8263.793405164919, 7550.962245188959, 7672.0, 7704.691812327668, 7784.260495252942, 7814.765557033298, 7481.214472480311, 7486.176520582841, 7518.173000969999, 7624.885626715492, 7635.389168866366, 7587.962060189664, 7687.846243074995, 7698.422618303762, 7723.111842138226, 7733.265339792936, 6939.965300173467, 6948.374646281859, 6971.930280697128, 7000.299970002959, 7024.297570242935, 7019.789406317818, 7038.753643622448, 7038.929610703827, 7083.645817709197, 7108.644567771694], "unit": "ms", "name": "mootools.html", "value": 4747.674384862021}, {"lowerIsBetter": false, "replicates": [321.081706319925, 325.372031978282, 327.3061110445855, 333.373258274444, 334.7489382962778, 6596.7691130810435, 6753.493487988396, 6836.11130553028, 6858.965705171473, 6878.105846239994, 6615.702293396796, 6770.3906648401635, 6803.0, 6803.353681400272, 6851.931480685192, 4435.223835828733, 5076.492350764931, 5085.110105731501, 5107.438181799999, 5113.795448182068, 4295.677824163185, 4944.4313903900975, 5084.67798372424, 5093.236014597822, 5121.1038068338075, 4983.227599722049, 5006.924896126561, 5012.849614511552, 5035.144025515653, 5037.0, 4517.728936263802, 4833.734144622044, 4986.601071914256, 5036.445990940993, 5040.722760248185, 4079.5716449772644, 4159.625633692952, 4169.687273454473, 4300.849470268526, 4303.935440968388, 6368.840778980516, 6410.910145275315, 6427.421532062137, 6439.7746078887485, 6442.291347951722, 5848.41515848416, 5879.3826648202175, 5911.527077833763, 5931.377205393414, 5944.7027648617395, 7013.964930175367, 7243.7102515899305, 7266.927330726678, 7267.672954717051, 7305.963470182668, 4809.254565542346, 4819.6867203631655, 4827.08285425768, 4834.250691142844, 4840.467548569654, 7679.846403071907, 7700.229977002311, 7702.422318326148, 7709.074911010659, 7713.807154821118, 4066.8169932353117, 4760.45254795696, 4882.438519570223, 4884.8290309838985, 4894.95105048945, 4935.827246046443, 4984.451710311862, 4989.401271847401, 5003.074431230234, 5010.498950105033, 4760.309755085494, 4920.458749537548, 5866.413358664099, 5910.286017055092, 5930.644161350333, 7312.305330993547, 7337.0828646419195, 7353.742619008309, 7354.191038985708, 7367.557946523226, 1667.1497536256354, 1733.159417682423, 1733.9219735111951, 1735.2451683517459, 1746.9912650436665, 1106.6624679472677, 1110.439228189759, 1124.9043831274269, 1125.0380924309761, 1125.7410795517078, 5480.80817171405, 6736.090627765189, 6757.763478278237, 6778.423833974069, 6814.352636499525, 6447.580907241108, 7039.92960070403, 7532.284432978859, 7534.284242996907, 7569.091708994956, 6538.574992625559, 6720.193576770819, 6733.3266673333255, 6776.796696099125, 6802.115724955823, 3062.6784187659973, 3931.958031121755, 3984.183242435294, 3999.320115580358, 4015.638592526687, 7462.067241594801, 7567.129780075252, 7569.394448444111, 7576.393888488908, 7628.771136865903, 6330.8417289567205, 7855.607219638995, 7858.0, 7867.370610351159, 7917.564533950573, 7353.0, 7620.657070431844, 7623.809404764926, 7650.540967541854, 7694.807629809299, 7586.582737949245, 7597.6201189941385, 7601.163871974189, 7617.047869016373, 7618.885716714143, 7323.084614423197, 7496.8500629986, 7503.812404689927, 7517.0, 7578.772636820904, 7643.350315223046, 7645.808854778675, 7646.9617651911385, 7672.156062833195, 7689.730859420118, 4890.0, 4905.852824415273, 4910.582600479, 4915.65590408668, 4921.302150757982, 6275.560710750204, 7236.167840698176, 7515.436342274242, 7527.172011078667, 7534.171241163358, 7242.818929526804, 7290.927090729025, 7299.197088320174, 7320.816979575553, 7320.890186647311, 6220.284667263141, 7256.383207427428, 7297.890531642136, 7301.269873012656, 7347.375473084848, 6932.792016239521, 7032.683529241299, 7116.181639111568, 7131.0, 7138.964305178441, 7272.527285726623, 7281.453890958093, 7293.927060729325, 7313.012743279589, 7331.706731730885, 6929.5842249465195, 7097.183823860116, 7130.393916517154, 7132.536385134949, 7154.320339567733], "unit": "ms", "name": "prototype.html", "value": 5284.255917133556}, {"lowerIsBetter": false, "replicates": [696.9233384327727, 698.7589281697819, 721.3976329764646, 774.1136398823347, 815.7144999250263, 14684.77972830407, 15017.849821501783, 15027.474038408658, 15128.167950762718, 15157.09057456552, 13780.862191378083, 14343.354549045293, 14451.0, 14453.277336133204, 14464.783028254584, 775.1318523253964, 779.4349096904728, 955.3790036476312, 973.6640858903702, 975.1077763846072, 962.210986990668, 977.0522593084696, 978.4373984958642, 980.9558569864338, 985.4136788610765, 1004.638330201127, 1022.5960745505521, 1025.702546261587, 1031.2111234905303, 1033.6485594897733, 1005.2762011351851, 1008.2488546033215, 1024.3188279793928, 1025.3489034463096, 1039.9220058495605, 748.5059860492049, 756.2701992577189, 756.4553521464537, 757.2957149850637, 759.4076620236225, 14993.400263989428, 14995.250237488082, 15000.774988375184, 15008.399664013426, 15073.773893391608, 12436.81344779829, 12662.746745065047, 12673.809892851614, 12863.742725145537, 13122.278274694889, 10943.507542160542, 11069.723256918562, 11526.19316647835, 11967.82048269268, 12108.576199832964, 3486.965130348715, 3612.151144481045, 3612.476190952297, 3620.294042661682, 3633.382325004729, 46432.0, 71445.6427717858, 73862.0, 74850.0, 75054.0, 9277.231960661346, 9291.67479138227, 9402.576884040234, 9661.372010819416, 9693.70918872435, 21124.78875211259, 21148.259810906544, 21246.893765531382, 21262.043208055675, 21278.0, 7513.699452021967, 7514.624268786539, 7704.460687751804, 7849.293563579306, 8020.318272946748, 4089.1617218470737, 4096.5903409658795, 4099.549049604541, 4106.774127422961, 4138.772367519755, 3555.466679998021, 3559.733020023457, 3570.0182449826507, 3580.7314451415727, 3582.802945837952, 664.3655309179721, 664.5613894829389, 665.8102440804445, 698.4028655499576, 698.7728988078894, 496.3720893070269, 506.9822556210515, 508.5346907579597, 509.6101482365993, 525.7765449683945, 7086.92913070873, 8519.403641745019, 8599.527026013504, 8700.825983480421, 8812.16284452976, 450.70028431092953, 459.80228501743903, 471.30247234093736, 498.0686116961306, 506.57194670503367, 3861.3242682530445, 3867.7099217558793, 4062.532808726975, 4132.8140233689555, 4234.767087810138, 99862.0, 100361.0, 102685.48657256666, 103257.0, 103933.48033259786, 83772.58113709514, 83854.58072709598, 84020.0, 84110.15889841145, 85782.0, 74663.0, 74978.62510687411, 75119.62440187763, 75343.0, 76708.61645691736, 6835.965820170867, 8231.711890083818, 8811.691590794291, 8986.19124278818, 9103.681371151977, 52241.7387913058, 53101.0, 53999.650008748526, 54593.0, 54805.0, 69848.65075674589, 69983.95024074745, 70096.0, 73914.63042684752, 74697.6265118671, 10741.946290268499, 10746.570137194425, 10749.571730209864, 10856.294340867818, 11107.278026928223, 11891.167618266983, 11925.76148477043, 11992.820107698566, 12000.63998080059, 12017.63947081554, 11231.101511879193, 11475.13936454786, 11482.138839586898, 11658.76682466363, 11784.175107742376, 10934.56261749521, 11081.0, 11462.82805757931, 11657.659369172654, 11857.288562686266, 10800.559984908383, 11121.05471034971, 11431.199816013132, 11510.36692981894, 11868.465919033837, 7825.960870195612, 9581.185599224144, 9631.662891799033, 9987.051230133126, 10148.949255253676, 8945.284377249674, 9451.265196847258, 10043.404810907503, 10098.141657958862, 10121.732189183678], "unit": "ms", "name": "yui.html", "value": 7011.143844236464}], "name": "dromaeo_css", "value": 7676.902542418638}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 114.0, 123.0, 118.0, 126.0, 137.0, 161.0, 162.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 127.7}, {"lowerIsBetter": true, "replicates": [146.0, 128.0, 177.0, 147.0, 145.0, 176.0, 164.0, 165.0, 184.0, 145.0], "unit": "ms", "name": "audio-beat-detection", "value": 157.7}, {"lowerIsBetter": true, "replicates": [195.0, 207.0, 222.0, 187.0, 217.0, 214.0, 194.0, 190.0, 236.0, 201.0], "unit": "ms", "name": "audio-dft", "value": 206.3}, {"lowerIsBetter": true, "replicates": [52.0, 71.0, 103.0, 140.0, 48.0, 47.0, 60.0, 61.0, 140.0, 83.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 109.0, 88.0, 85.0, 76.0, 107.0, 76.0, 78.0, 107.0], "unit": "ms", "name": "audio-oscillator", "value": 88.0}, {"lowerIsBetter": true, "replicates": [87.0, 90.0, 87.0, 87.0, 88.0, 89.0, 88.0, 88.0, 87.0, 105.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 89.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 98.0, 98.0, 95.0, 94.0, 150.0, 96.0, 120.0, 106.0], "unit": "ms", "name": "imaging-darkroom", "value": 104.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 121.0, 79.0, 150.0, 147.0, 120.0, 91.0, 88.0, 91.0], "unit": "ms", "name": "imaging-desaturate", "value": 107.1}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 59.0, 60.0, 67.0, 62.0, 51.0, 69.0, 57.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 57.0, 94.0, 72.0, 68.0, 68.0, 69.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [95.0, 99.0, 84.0, 83.0, 87.0, 84.0, 84.0, 84.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [129.0, 130.0, 127.0, 127.0, 133.0, 137.0, 129.0, 138.0, 138.0, 138.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 132.6}, {"lowerIsBetter": true, "replicates": [171.0, 128.0, 178.0, 174.0, 175.0, 134.0, 141.0, 139.0, 139.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [70.0, 61.0, 90.0, 97.0, 92.0, 88.0, 82.0, 68.0, 66.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 78.2}], "name": "kraken", "value": 1541.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [643.0868167202573], "unit": "score", "name": "Richards", "value": 54.894609999999986}, {"lowerIsBetter": false, "replicates": [154.63120457708365], "unit": "score", "name": "DeltaBlue", "value": 427.58510600000017}, {"lowerIsBetter": false, "replicates": [291.8855808523059], "unit": "score", "name": "Encrypt", "value": 911.9361060000001}, {"lowerIsBetter": false, "replicates": [4901.9607843137255], "unit": "score", "name": "Decrypt", "value": 54.30092399999998}, {"lowerIsBetter": false, "replicates": [954.1984732824427], "unit": "score", "name": "RayTrace", "value": 775.5084720000002}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [13333.333333333334], "unit": "score", "name": "Boyer", "value": 49.98472500000001}, {"lowerIsBetter": false, "replicates": [28000.0], "unit": "score", "name": "RegExp", "value": 32.53517857142855}, {"lowerIsBetter": false, "replicates": [588.5815185403178], "unit": "score", "name": "Splay", "value": 138.453209}, {"lowerIsBetter": false, "replicates": [4524.886877828054], "unit": "score", "name": "NavierStokes", "value": 327.9640000000003}], "name": "v8_7", "value": 19114.85700241643}]} 05:04:43 INFO - RETURN: dromaeo_css: 7676.90 05:04:43 INFO - RETURN: kraken: 1541.70 05:04:43 INFO - RETURN: v8_7: 19114.86 05:04:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "19114.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1541.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7676.90"}}} 05:04:43 INFO - Return code: 0 05:04:43 INFO - # TBPL SUCCESS # 05:04:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:43 INFO - 2015-11-23 05:04:43.711 screenresolution[1676:10869] starting screenresolution argv=screenresolution get 05:04:43 INFO - 2015-11-23 05:04:43.714 screenresolution[1676:10869] Display 0: 1600x1200x32@60 05:04:43 INFO - 2015-11-23 05:04:43.720 screenresolution[1677:10872] starting screenresolution argv=screenresolution list 05:04:43 INFO - Available Modes on Display 0 05:04:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:43 INFO - Intel Iris: 05:04:43 INFO - Chipset Model: Intel Iris 05:04:43 INFO - Type: GPU 05:04:43 INFO - Bus: Built-In 05:04:43 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:43 INFO - Vendor: Intel (0x8086) 05:04:43 INFO - Device ID: 0x0a2e 05:04:43 INFO - Revision ID: 0x0009 05:04:43 INFO - Displays: 05:04:43 INFO - Display: 05:04:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:43 INFO - Display Serial Number: 1600x1200 60 05:04:43 INFO - Main Display: Yes 05:04:43 INFO - Mirror: Off 05:04:43 INFO - Online: Yes 05:04:43 INFO - Rotation: Supported 05:04:43 INFO - Return code: 0 05:04:43 INFO - Running post-action listener: _resource_record_post_action 05:04:43 INFO - Running post-run listener: _resource_record_post_run 05:04:45 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 38999552; Write bytes: 694965760; Read time: 423; Write time: 2129 05:04:45 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 335315456; Write bytes: 338794496; Read time: 26072; Write time: 681 05:04:45 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 38073856; Write bytes: 345804288; Read time: 409; Write time: 1416 05:04:45 INFO - Running post-run listener: _upload_blobber_files 05:04:45 INFO - Blob upload gear active. 05:04:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:04:45 INFO - Copying logs to upload dir... 05:04:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.335763 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-23 05:04:45.085403) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 05:04:45.089211) ========= 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.TUMCy1uNp4/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.OkyVLZkt2E/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/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009333 build_url: 'https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/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-23 05:04:45.115705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:04:45.116153) ========= 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.TUMCy1uNp4/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.OkyVLZkt2E/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.005124 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:04:45.167562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 05:04:45.168121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 05:04:45.168656) ========= ========= Total master_lag: 0.31 =========