builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0016 starttime: 1448281895.27 results: success (0) buildid: 20151123030237 builduid: 933d95c3f7ec4a1382a9e13a65e28a4a revision: 8b1fc0961a076e35646d0472a81feefc0074558c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.271090) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.271518) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.271888) ========= 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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005630 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.345110) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.345564) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.380295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.380614) ========= 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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005820 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.433885) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.434179) ========= 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:31:35.434568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.434874) ========= 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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:31:35-- 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% 8.49M=0.001s 2015-11-23 04:31:35 (8.49 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.677308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.677644) ========= 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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.025987 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.726604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:31:35.727010) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --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 8b1fc0961a076e35646d0472a81feefc0074558c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:31:35,799 truncating revision to first 12 chars 2015-11-23 04:31:35,799 Setting DEBUG logging. 2015-11-23 04:31:35,799 attempt 1/10 2015-11-23 04:31:35,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b1fc0961a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 04:31:37,432 unpacking tar archive at: mozilla-central-8b1fc0961a07/testing/mozharness/ program finished with exit code 0 elapsedTime=1.875236 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:31:37.617365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:37.617694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:37.633697) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:37.633998) ========= 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:31:37.634377) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-11-23 04:31:37.634700) ========= /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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:31:37 INFO - MultiFileLogger online at 20151123 04:31:37 in /builds/slave/test 04:31:37 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:31:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:37 INFO - {'append_to_log': False, 04:31:37 INFO - 'base_work_dir': '/builds/slave/test', 04:31:37 INFO - 'blob_upload_branch': 'Firefox', 04:31:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:37 INFO - 'branch': 'Firefox', 04:31:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:37 INFO - 'config_files': ('talos/mac_config.py',), 04:31:37 INFO - 'default_actions': ('clobber', 04:31:37 INFO - 'read-buildbot-config', 04:31:37 INFO - 'download-and-extract', 04:31:37 INFO - 'populate-webroot', 04:31:37 INFO - 'create-virtualenv', 04:31:37 INFO - 'install', 04:31:37 INFO - 'run-tests'), 04:31:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:37 INFO - 'download_minidump_stackwalk': True, 04:31:37 INFO - 'download_symbols': 'ondemand', 04:31:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:37 INFO - 'installer_path': 'installer.exe', 04:31:37 INFO - 'log_level': 'info', 04:31:37 INFO - 'log_name': 'talos', 04:31:37 INFO - 'log_to_console': True, 04:31:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:37 INFO - 'opt_config_files': (), 04:31:37 INFO - 'pip_index': False, 04:31:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:37 INFO - 'cmd': ('bash', 04:31:37 INFO - '-c', 04:31:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:37 INFO - 'enabled': True, 04:31:37 INFO - 'halt_on_failure': False, 04:31:37 INFO - 'name': 'check_screen_resolution'},), 04:31:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:37 INFO - 'cmd': ('bash', 04:31:37 INFO - '-c', 04:31:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:37 INFO - 'enabled': True, 04:31:37 INFO - 'halt_on_failure': False, 04:31:37 INFO - 'name': 'check_screen_resolution'},), 04:31:37 INFO - 'run_cmd_checks_enabled': True, 04:31:37 INFO - 'sps_profile': False, 04:31:37 INFO - 'sps_profile_interval': 0, 04:31:37 INFO - 'suite': 'dromaeojs-e10s', 04:31:37 INFO - 'system_bits': '64', 04:31:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:37 INFO - 'title': 't-yosemite-r7-0016', 04:31:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:37 INFO - 'use_talos_json': True, 04:31:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:37 INFO - 'work_dir': 'build'} 04:31:37 INFO - ##### 04:31:37 INFO - ##### Running clobber step. 04:31:37 INFO - ##### 04:31:37 INFO - Running pre-action listener: _resource_record_pre_action 04:31:37 INFO - Running main action method: clobber 04:31:37 INFO - rmtree: /builds/slave/test/build 04:31:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:39 INFO - Running post-action listener: _resource_record_post_action 04:31:39 INFO - ##### 04:31:39 INFO - ##### Running read-buildbot-config step. 04:31:39 INFO - ##### 04:31:39 INFO - Running pre-action listener: _resource_record_pre_action 04:31:39 INFO - Running main action method: read_buildbot_config 04:31:39 INFO - Using buildbot properties: 04:31:39 INFO - { 04:31:39 INFO - "properties": { 04:31:39 INFO - "buildnumber": 5, 04:31:39 INFO - "product": "firefox", 04:31:39 INFO - "script_repo_revision": "production", 04:31:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:31:39 INFO - "repository": "", 04:31:39 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:31:39 INFO - "buildid": "20151123030237", 04:31:39 INFO - "slavename": "t-yosemite-r7-0016", 04:31:39 INFO - "stage_platform": "macosx64", 04:31:39 INFO - "basedir": "/builds/slave/test", 04:31:39 INFO - "nightly_build": "True", 04:31:39 INFO - "project": "", 04:31:39 INFO - "platform": "yosemite_r7", 04:31:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:31:39 INFO - "slavebuilddir": "test", 04:31:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:31:39 INFO - "branch": "mozilla-central", 04:31:39 INFO - "repo_path": "mozilla-central", 04:31:39 INFO - "pgo_build": "False", 04:31:39 INFO - "builduid": "933d95c3f7ec4a1382a9e13a65e28a4a", 04:31:39 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:31:39 INFO - }, 04:31:39 INFO - "sourcestamp": { 04:31:39 INFO - "repository": "", 04:31:39 INFO - "hasPatch": false, 04:31:39 INFO - "project": "", 04:31:39 INFO - "branch": "mozilla-central-macosx64-talos", 04:31:39 INFO - "changes": [ 04:31:39 INFO - { 04:31:39 INFO - "category": null, 04:31:39 INFO - "files": [ 04:31:39 INFO - { 04:31:39 INFO - "url": null, 04:31:39 INFO - "name": "https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:31:39 INFO - } 04:31:39 INFO - ], 04:31:39 INFO - "repository": "", 04:31:39 INFO - "rev": "8b1fc0961a076e35646d0472a81feefc0074558c", 04:31:39 INFO - "who": "sendchange", 04:31:39 INFO - "when": 1448281874, 04:31:39 INFO - "number": 6694663, 04:31:39 INFO - "comments": "", 04:31:39 INFO - "project": "", 04:31:39 INFO - "at": "Mon 23 Nov 2015 04:31:14", 04:31:39 INFO - "branch": "mozilla-central-macosx64-talos", 04:31:39 INFO - "revlink": "", 04:31:39 INFO - "properties": [ 04:31:39 INFO - [ 04:31:39 INFO - "buildid", 04:31:39 INFO - "20151123030237", 04:31:39 INFO - "Change" 04:31:39 INFO - ], 04:31:39 INFO - [ 04:31:39 INFO - "builduid", 04:31:39 INFO - "933d95c3f7ec4a1382a9e13a65e28a4a", 04:31:39 INFO - "Change" 04:31:39 INFO - ], 04:31:39 INFO - [ 04:31:39 INFO - "nightly_build", 04:31:39 INFO - "True", 04:31:39 INFO - "Change" 04:31:39 INFO - ], 04:31:39 INFO - [ 04:31:39 INFO - "pgo_build", 04:31:39 INFO - "False", 04:31:39 INFO - "Change" 04:31:39 INFO - ] 04:31:39 INFO - ], 04:31:39 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:31:39 INFO - } 04:31:39 INFO - ], 04:31:39 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:31:39 INFO - } 04:31:39 INFO - } 04:31:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:31:39 INFO - Running post-action listener: _resource_record_post_action 04:31:39 INFO - ##### 04:31:39 INFO - ##### Running download-and-extract step. 04:31:39 INFO - ##### 04:31:39 INFO - Running pre-action listener: _resource_record_pre_action 04:31:39 INFO - Running main action method: download_and_extract 04:31:39 INFO - mkdir: /builds/slave/test/build/tests 04:31:39 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:31:39 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:31:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json 04:31:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json 04:31:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:47 INFO - Downloaded 1149 bytes. 04:31:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:47 INFO - Using the following test package requirements: 04:31:47 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:47 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:47 INFO - u'jsshell-mac.zip'], 04:31:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:47 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:31:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:47 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:31:47 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:47 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:31:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:47 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:31:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:47 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:47 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:31:47 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:31:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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:31:53 INFO - Downloaded 17525302 bytes. 04:31:53 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:31:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:31:56 INFO - Return code: 0 04:31:56 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:31: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:31:56 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:31:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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:31:57 INFO - Downloaded 17525302 bytes. 04:31:57 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:31:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:32:00 INFO - Return code: 0 04:32: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:32:00 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:32:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:32:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:32:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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:32:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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:32:01 INFO - Downloaded 11130997 bytes. 04:32:01 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:32:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:32:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:32:01 INFO - Return code: 0 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:32:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:32:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:32:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:32:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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:32:04 INFO - Downloaded 109732865 bytes. 04:32:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:32:04 INFO - mkdir: /builds/slave/test/properties 04:32:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:04 INFO - Contents: 04:32:04 INFO - build_url:https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:32:04 INFO - Running post-action listener: _resource_record_post_action 04:32:04 INFO - Running post-action listener: set_extra_try_arguments 04:32:04 INFO - ##### 04:32:04 INFO - ##### Running populate-webroot step. 04:32:04 INFO - ##### 04:32:04 INFO - Running pre-action listener: _resource_record_pre_action 04:32:04 INFO - Running main action method: populate_webroot 04:32:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:32:04 INFO - '../fennec_ids.txt'], 04:32:04 INFO - 'tests': ['tcheck2']}, 04:32:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:04 INFO - '--tppagecycles', 04:32:04 INFO - '7'], 04:32:04 INFO - 'tests': ['tsvgm']}}, 04:32:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:32:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:32:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:32:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'tests': ['damp', 'tps']}, 04:32:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['damp', 'tps']}, 04:32:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:32:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:04 INFO - 'other': {'tests': ['a11yr', 04:32:04 INFO - 'ts_paint', 04:32:04 INFO - 'tpaint', 04:32:04 INFO - 'sessionrestore', 04:32:04 INFO - 'sessionrestore_no_auto_restore']}, 04:32:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['a11yr', 04:32:04 INFO - 'ts_paint', 04:32:04 INFO - 'tpaint', 04:32:04 INFO - 'sessionrestore', 04:32:04 INFO - 'sessionrestore_no_auto_restore']}, 04:32:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['a11yr', 04:32:04 INFO - 'ts_paint', 04:32:04 INFO - 'tpaint', 04:32:04 INFO - 'sessionrestore', 04:32:04 INFO - 'sessionrestore_no_auto_restore']}, 04:32:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['a11yr', 04:32:04 INFO - 'ts_paint', 04:32:04 INFO - 'tpaint', 04:32:04 INFO - 'sessionrestore', 04:32:04 INFO - 'sessionrestore_no_auto_restore']}, 04:32:04 INFO - 'other_l64': {'tests': ['a11yr', 04:32:04 INFO - 'ts_paint', 04:32:04 INFO - 'tpaint', 04:32:04 INFO - 'sessionrestore', 04:32:04 INFO - 'sessionrestore_no_auto_restore']}, 04:32:04 INFO - 'other_nol64': {'tests': ['a11yr', 04:32:04 INFO - 'ts_paint', 04:32:04 INFO - 'tpaint', 04:32:04 INFO - 'sessionrestore', 04:32:04 INFO - 'sessionrestore_no_auto_restore']}, 04:32:04 INFO - 'svgr': {'tests': ['tsvgx', 04:32:04 INFO - 'tsvgr_opacity', 04:32:04 INFO - 'tart', 04:32:04 INFO - 'tscrollx', 04:32:04 INFO - 'cart']}, 04:32:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['tsvgx', 04:32:04 INFO - 'tsvgr_opacity', 04:32:04 INFO - 'tart', 04:32:04 INFO - 'tscrollx', 04:32:04 INFO - 'cart']}, 04:32:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'tests': ['tp5o']}, 04:32:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'talos_options': ['--e10s'], 04:32:04 INFO - 'tests': ['tp5o']}, 04:32:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'talos_options': ['--xperf_path', 04:32:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:04 INFO - 'tests': ['tp5n']}, 04:32:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:04 INFO - 'talos_options': ['--e10s', 04:32:04 INFO - '--xperf_path', 04:32:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:04 INFO - 'tests': ['tp5n']}}, 04:32:04 INFO - 'talos.zip': {'path': '', 04:32:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:04 INFO - Running post-action listener: _resource_record_post_action 04:32:04 INFO - ##### 04:32:04 INFO - ##### Running create-virtualenv step. 04:32:04 INFO - ##### 04:32:04 INFO - Running pre-action listener: _resource_record_pre_action 04:32:04 INFO - Running main action method: create_virtualenv 04:32:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:04 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:32:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:04 INFO - Using real prefix '/tools/python27' 04:32:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:08 INFO - Installing pip.................done. 04:32:08 INFO - Return code: 0 04:32:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:08 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:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 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:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 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 0x10133e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10131b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a05c1470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, '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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:32:08 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:32:08 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:32:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:32:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:08 INFO - 'HOME': '/Users/cltbld', 04:32:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:08 INFO - 'LOGNAME': 'cltbld', 04:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:08 INFO - 'MOZ_NO_REMOTE': '1', 04:32:08 INFO - 'NO_EM_RESTART': '1', 04:32:08 INFO - 'PAGER': '/bin/cat', 04:32:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:08 INFO - 'PWD': '/builds/slave/test', 04:32:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:08 INFO - 'SHELL': '/bin/bash', 04:32:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:32:08 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:08 INFO - 'USER': 'cltbld', 04:32:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:08 INFO - 'XPC_FLAGS': '0x0', 04:32:08 INFO - 'XPC_SERVICE_NAME': '0', 04:32:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:08 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:32:08 INFO - Cleaning up... 04:32:08 INFO - Return code: 0 04:32:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:32:08 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:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 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:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 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 0x10133e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10131b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a05c1470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, '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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:32:08 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:32:08 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:32:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:32:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:08 INFO - 'HOME': '/Users/cltbld', 04:32:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:08 INFO - 'LOGNAME': 'cltbld', 04:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:08 INFO - 'MOZ_NO_REMOTE': '1', 04:32:08 INFO - 'NO_EM_RESTART': '1', 04:32:08 INFO - 'PAGER': '/bin/cat', 04:32:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:08 INFO - 'PWD': '/builds/slave/test', 04:32:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:08 INFO - 'SHELL': '/bin/bash', 04:32:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:32:08 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:08 INFO - 'USER': 'cltbld', 04:32:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:08 INFO - 'XPC_FLAGS': '0x0', 04:32:08 INFO - 'XPC_SERVICE_NAME': '0', 04:32:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:08 INFO - Downloading/unpacking psutil>=0.7.1 04:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:32:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:11 INFO - Installing collected packages: psutil 04:32:11 INFO - Running setup.py install for psutil 04:32:11 INFO - building 'psutil._psutil_osx' extension 04:32:11 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:32:12 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:32:12 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:32:12 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:32:12 INFO - building 'psutil._psutil_posix' extension 04:32:12 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:32:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:12 INFO - ^ 04:32:12 INFO - 1 warning generated. 04:32:12 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:32:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:12 INFO - Successfully installed psutil 04:32:12 INFO - Cleaning up... 04:32:12 INFO - Return code: 0 04:32:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:32:12 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:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:12 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:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:12 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 0x10133e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10131b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a05c1470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, '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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:32:12 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:32:12 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:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:12 INFO - 'HOME': '/Users/cltbld', 04:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:12 INFO - 'LOGNAME': 'cltbld', 04:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:12 INFO - 'MOZ_NO_REMOTE': '1', 04:32:12 INFO - 'NO_EM_RESTART': '1', 04:32:12 INFO - 'PAGER': '/bin/cat', 04:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:12 INFO - 'PWD': '/builds/slave/test', 04:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:12 INFO - 'SHELL': '/bin/bash', 04:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:32:12 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:12 INFO - 'USER': 'cltbld', 04:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:12 INFO - 'XPC_FLAGS': '0x0', 04:32:12 INFO - 'XPC_SERVICE_NAME': '0', 04:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:32:13 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:32:13 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:32:13 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:32:13 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:32:13 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:32:13 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:32:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:32:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:15 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:32:15 INFO - Installing collected packages: mozsystemmonitor 04:32:15 INFO - Running setup.py install for mozsystemmonitor 04:32:15 INFO - Successfully installed mozsystemmonitor 04:32:15 INFO - Cleaning up... 04:32:15 INFO - Return code: 0 04:32:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10133e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10131b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a05c1470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, '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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:15 INFO - 'HOME': '/Users/cltbld', 04:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:15 INFO - 'LOGNAME': 'cltbld', 04:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:15 INFO - 'MOZ_NO_REMOTE': '1', 04:32:15 INFO - 'NO_EM_RESTART': '1', 04:32:15 INFO - 'PAGER': '/bin/cat', 04:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:15 INFO - 'PWD': '/builds/slave/test', 04:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:15 INFO - 'SHELL': '/bin/bash', 04:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:32:15 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:15 INFO - 'USER': 'cltbld', 04:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:15 INFO - 'XPC_FLAGS': '0x0', 04:32:15 INFO - 'XPC_SERVICE_NAME': '0', 04:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:15 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:32:15 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:32:15 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:32:15 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:32:15 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:32:15 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:32:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:18 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:32:18 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:32:18 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:32:18 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:32:18 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:32:18 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:32:18 INFO - Downloading docopt-0.6.1.tar.gz 04:32:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:19 INFO - Running setup.py install for blobuploader 04:32:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:19 INFO - Running setup.py install for requests 04:32:19 INFO - Running setup.py install for docopt 04:32:19 INFO - Successfully installed blobuploader requests docopt 04:32:19 INFO - Cleaning up... 04:32:19 INFO - Return code: 0 04:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:19 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 0x10133e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10131b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a05c1470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, '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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:32:19 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:32:19 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:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:19 INFO - 'HOME': '/Users/cltbld', 04:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:19 INFO - 'LOGNAME': 'cltbld', 04:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:19 INFO - 'MOZ_NO_REMOTE': '1', 04:32:19 INFO - 'NO_EM_RESTART': '1', 04:32:19 INFO - 'PAGER': '/bin/cat', 04:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:19 INFO - 'PWD': '/builds/slave/test', 04:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:19 INFO - 'SHELL': '/bin/bash', 04:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:32:19 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:19 INFO - 'USER': 'cltbld', 04:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:19 INFO - 'XPC_FLAGS': '0x0', 04:32:19 INFO - 'XPC_SERVICE_NAME': '0', 04:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-F51IuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ajMLWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-DfFph4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ESNYEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-HmwPvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-QbCLHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-MGZMU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:20 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Mw5gPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-kBoboq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-kIY67H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-0XXJhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-885FBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-oVxi0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-jxwoDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-I4c29L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ml0tZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ZUXGiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:21 INFO - Running setup.py install for manifestparser 04:32:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozcrash 04:32:22 INFO - Running setup.py install for mozdebug 04:32:22 INFO - Running setup.py install for mozdevice 04:32:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozfile 04:32:22 INFO - Running setup.py install for mozhttpd 04:32:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozinfo 04:32:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozInstall 04:32:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Running setup.py install for mozleak 04:32:23 INFO - Running setup.py install for mozlog 04:32:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Running setup.py install for moznetwork 04:32:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Running setup.py install for mozprocess 04:32:23 INFO - Running setup.py install for mozprofile 04:32:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Running setup.py install for mozrunner 04:32:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:24 INFO - Running setup.py install for mozscreenshot 04:32:24 INFO - Running setup.py install for moztest 04:32:24 INFO - Running setup.py install for mozversion 04:32:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:24 INFO - Cleaning up... 04:32:24 INFO - Return code: 0 04:32:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:24 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 0x10133e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10131b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a05c1470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, '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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:32:24 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:32:24 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:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:24 INFO - 'HOME': '/Users/cltbld', 04:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:24 INFO - 'LOGNAME': 'cltbld', 04:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:24 INFO - 'MOZ_NO_REMOTE': '1', 04:32:24 INFO - 'NO_EM_RESTART': '1', 04:32:24 INFO - 'PAGER': '/bin/cat', 04:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:24 INFO - 'PWD': '/builds/slave/test', 04:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:24 INFO - 'SHELL': '/bin/bash', 04:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:32:24 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:24 INFO - 'USER': 'cltbld', 04:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:24 INFO - 'XPC_FLAGS': '0x0', 04:32:24 INFO - 'XPC_SERVICE_NAME': '0', 04:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-IokYfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-BlijMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-9cm9rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-gKs4NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ij3MXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-mu_D64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-FVPj7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-RRUnJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-oK9i1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-pEcfHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-yyTBsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-zD3C7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Rqabs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:26 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:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:26 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-nIrTUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:26 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:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:26 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Qq85k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:26 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:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:26 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-BYEvsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:26 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:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:26 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-nKEEEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:28 INFO - Downloading blessings-1.5.1.tar.gz 04:32:28 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:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:28 INFO - Installing collected packages: blessings 04:32:28 INFO - Running setup.py install for blessings 04:32:28 INFO - Successfully installed blessings 04:32:28 INFO - Cleaning up... 04:32:28 INFO - Return code: 0 04:32:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:29 INFO - Reading from file tmpfile_stdout 04:32:29 INFO - Current package versions: 04:32:29 INFO - blessings == 1.5.1 04:32:29 INFO - blobuploader == 1.2.4 04:32:29 INFO - docopt == 0.6.1 04:32:29 INFO - manifestparser == 1.1 04:32:29 INFO - mozInstall == 1.12 04:32:29 INFO - mozcrash == 0.16 04:32:29 INFO - mozdebug == 0.1 04:32:29 INFO - mozdevice == 0.47 04:32:29 INFO - mozfile == 1.2 04:32:29 INFO - mozhttpd == 0.7 04:32:29 INFO - mozinfo == 0.9 04:32:29 INFO - mozleak == 0.1 04:32:29 INFO - mozlog == 3.0 04:32:29 INFO - moznetwork == 0.27 04:32:29 INFO - mozprocess == 0.22 04:32:29 INFO - mozprofile == 0.27 04:32:29 INFO - mozrunner == 6.11 04:32:29 INFO - mozscreenshot == 0.1 04:32:29 INFO - mozsystemmonitor == 0.0 04:32:29 INFO - moztest == 0.7 04:32:29 INFO - mozversion == 1.4 04:32:29 INFO - psutil == 3.1.1 04:32:29 INFO - requests == 1.2.3 04:32:29 INFO - wsgiref == 0.1.2 04:32:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10133e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10131b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a05c1470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, '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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:29 INFO - 'HOME': '/Users/cltbld', 04:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:29 INFO - 'LOGNAME': 'cltbld', 04:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:29 INFO - 'MOZ_NO_REMOTE': '1', 04:32:29 INFO - 'NO_EM_RESTART': '1', 04:32:29 INFO - 'PAGER': '/bin/cat', 04:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:29 INFO - 'PWD': '/builds/slave/test', 04:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:29 INFO - 'SHELL': '/bin/bash', 04:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:32:29 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:29 INFO - 'USER': 'cltbld', 04:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:29 INFO - 'XPC_FLAGS': '0x0', 04:32:29 INFO - 'XPC_SERVICE_NAME': '0', 04:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:29 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:32:29 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:32:29 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:32:29 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:32:29 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:32:29 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:32:29 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:32:29 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:32:29 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:32:29 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:32:29 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:32:29 INFO - Cleaning up... 04:32:29 INFO - Return code: 0 04:32:29 INFO - Running post-action listener: _resource_record_post_action 04:32:29 INFO - Running post-action listener: _start_resource_monitoring 04:32:29 INFO - Starting resource monitoring. 04:32:29 INFO - ##### 04:32:29 INFO - ##### Running install step. 04:32:29 INFO - ##### 04:32:29 INFO - Running pre-action listener: _resource_record_pre_action 04:32:29 INFO - Running main action method: install 04:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:29 INFO - Reading from file tmpfile_stdout 04:32:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:29 INFO - Reading from file tmpfile_stdout 04:32:29 INFO - Output received: 04:32:29 INFO - Usage: mozinstall [options] installer 04:32:29 INFO - Options: 04:32:29 INFO - -h, --help show this help message and exit 04:32:29 INFO - -d DEST, --destination=DEST 04:32:29 INFO - Directory to install application into. [default: 04:32:29 INFO - "/builds/slave/test"] 04:32:29 INFO - --app=APP Application being installed. [default: firefox] 04:32:29 INFO - mkdir: /builds/slave/test/build/application 04:32:29 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:32:29 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:33:00 INFO - Reading from file tmpfile_stdout 04:33:00 INFO - Output received: 04:33:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:33:00 INFO - Running post-action listener: _resource_record_post_action 04:33:00 INFO - ##### 04:33:00 INFO - ##### Running run-tests step. 04:33:00 INFO - ##### 04:33:00 INFO - Running pre-action listener: _resource_record_pre_action 04:33:00 INFO - Running main action method: run_tests 04:33:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:00 INFO - 2015-11-23 04:33:00.102 screenresolution[1650:8080] starting screenresolution argv=screenresolution get 04:33:00 INFO - 2015-11-23 04:33:00.105 screenresolution[1650:8080] Display 0: 1600x1200x32@60 04:33:00 INFO - 2015-11-23 04:33:00.111 screenresolution[1651:8083] starting screenresolution argv=screenresolution list 04:33:00 INFO - Available Modes on Display 0 04:33:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:00 INFO - Intel Iris: 04:33:00 INFO - Chipset Model: Intel Iris 04:33:00 INFO - Type: GPU 04:33:00 INFO - Bus: Built-In 04:33:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:00 INFO - Vendor: Intel (0x8086) 04:33:00 INFO - Device ID: 0x0a2e 04:33:00 INFO - Revision ID: 0x0009 04:33:00 INFO - Displays: 04:33:00 INFO - Display: 04:33:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:00 INFO - Display Serial Number: 1600x1200 60 04:33:00 INFO - Main Display: Yes 04:33:00 INFO - Mirror: Off 04:33:00 INFO - Online: Yes 04:33:00 INFO - Rotation: Supported 04:33:00 INFO - Return code: 0 04:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:00 INFO - Python 2.7.3 04:33:00 INFO - Return code: 0 04:33:00 INFO - grabbing minidump binary from tooltool 04:33: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:33:00 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 0x1012629f0>, '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 0x100fc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012558c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:00 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:33:00 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:33:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:00 INFO - Return code: 0 04:33:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:00 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost'] in /builds/slave/test/build 04:33:00 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --webServer localhost 04:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5Qbi9RZk6/Render', 04:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:00 INFO - 'HOME': '/Users/cltbld', 04:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:00 INFO - 'LOGNAME': 'cltbld', 04:33:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:00 INFO - 'MOZ_NO_REMOTE': '1', 04:33:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:00 INFO - 'NO_EM_RESTART': '1', 04:33:00 INFO - 'PAGER': '/bin/cat', 04:33:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:00 INFO - 'PWD': '/builds/slave/test', 04:33:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:00 INFO - 'SHELL': '/bin/bash', 04:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1REqM1dV1/Listeners', 04:33:00 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:00 INFO - 'USER': 'cltbld', 04:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:00 INFO - 'XPC_FLAGS': '0x0', 04:33:00 INFO - 'XPC_SERVICE_NAME': '0', 04:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:00 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost'] with output_timeout 3600 04:33:00 INFO - mozversion INFO | application_buildid: 20151123030237 04:33:00 INFO - mozversion INFO | application_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 04:33:00 INFO - mozversion INFO | application_display_name: Nightly 04:33:00 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:00 INFO - mozversion INFO | application_name: Firefox 04:33:00 INFO - mozversion INFO | application_remotingname: firefox 04:33:00 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:33:00 INFO - mozversion INFO | application_vendor: Mozilla 04:33:00 INFO - mozversion INFO | application_version: 45.0a1 04:33:00 INFO - mozversion INFO | platform_buildid: 20151123030237 04:33:00 INFO - mozversion INFO | platform_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 04:33:00 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:33:00 INFO - mozversion INFO | platform_version: 45.0a1 04:33:00 INFO - 2015-11-23 04:33:00,657 DEBUG : using testdate: 1448281980 04:33:00 INFO - 2015-11-23 04:33:00,657 DEBUG : actual date: 1448281980 04:33:01 INFO - 2015-11-23 04:33:01,044 INFO : starting webserver on 'localhost:49272' 04:33:01 INFO - 2015-11-23 04:33:01,044 INFO : Starting test suite t-yosemite-r7-0016.e 04:33:01 INFO - 2015-11-23 04:33:01,045 INFO : Starting test dromaeo_css 04:33:01 INFO - 2015-11-23 04:33:01,045 DEBUG : operating with platform_type : mac_ 04:33:01 INFO - 2015-11-23 04:33:01,046 INFO : Initialising browser for dromaeo_css test... 04:33:01 INFO - 2015-11-23 04:33:01,059 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmp9EuJ38/profile http://localhost:49272/getInfo.html 04:33:04 INFO - 2015-11-23 04:33:04,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:04 INFO - 2015-11-23 04:33:04,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:04 INFO - 2015-11-23 04:33:04,138 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 04:33:04 INFO - 2015-11-23 04:33:04,138 DEBUG : BROWSER_OUTPUT: __metrics 04:33:04 INFO - 2015-11-23 04:33:04,724 INFO : Browser initialized. 04:33:04 INFO - 2015-11-23 04:33:04,724 INFO : Running cycle 1/1 for dromaeo_css test... 04:33:04 INFO - 2015-11-23 04:33:04,725 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmp9EuJ38/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:16 INFO - 2015-11-23 04:33:16,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 236032000 04:33:16 INFO - 2015-11-23 04:33:16,668 DEBUG : BROWSER_OUTPUT: 04:34:06 INFO - 2015-11-23 04:34:06,385 DEBUG : BROWSER_OUTPUT: 1448282046384 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:36:18 INFO - 2015-11-23 04:36:18,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 04:36:19 INFO - 2015-11-23 04:36:19,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 253452288 04:36:19 INFO - 2015-11-23 04:36:19,298 DEBUG : BROWSER_OUTPUT: 04:39:21 INFO - 2015-11-23 04:39:21,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 04:39:21 INFO - 2015-11-23 04:39:21,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 262668288 04:39:21 INFO - 2015-11-23 04:39:21,988 DEBUG : BROWSER_OUTPUT: 04:42:23 INFO - 2015-11-23 04:42:23,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 04:42:24 INFO - 2015-11-23 04:42:24,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 262774784 04:42:24 INFO - 2015-11-23 04:42:24,151 DEBUG : BROWSER_OUTPUT: 04:45:25 INFO - 2015-11-23 04:45:25,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 04:45:26 INFO - 2015-11-23 04:45:26,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 266018816 04:45:26 INFO - 2015-11-23 04:45:26,307 DEBUG : BROWSER_OUTPUT: 04:48:28 INFO - 2015-11-23 04:48:28,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 04:48:29 INFO - 2015-11-23 04:48:29,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 268599296 04:48:29 INFO - 2015-11-23 04:48:29,346 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 271499264 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3466.0468371197917;3559.2525569630393;3605.0266428064406;3630.564332280126;3631.092226943264;5678.517326027282;6021.307549631793;6027.005544085227;6034.939650603493;6053.273607167141;5869.295684517864;5891.88216235675;5923.792667256647;6060.393960603927;6100.206973093503;5279.762410691509;5300.893982120355;5387.218853266274;5489.4236105208975;5494.395616482204;4420.734755914639;5465.754041068141;5499.780008799643;5510.6969116698565;5582.7766889324375;5257.7108259045735;5266.578673706094;5316.202569614569;5420.295361602966;5420.91868621971;4460.7323560586465;5385.353757549119;5422.810201642963;5436.592255580847;5449.591280653927;5204.713740744258;5379.381371142291;5384.946150538483;5449.291592093042;5467.6719396836315;4984.800607975677;5245.4754524547625;5577.470140336662;5841.328247251536;6115.266168059861;6395.552311338208;6400.39196276353;6403.199600049994;6412.166418365629;6427.196600424947;6232.844178895519;6320.74717011319;6413.7434502619835;6445.774397896051;6478.222613286436;6054;6098.72555734993;6151.446369826737;6154.72303746337;6155.353687862755;6543.378379053982;6561.376669216417;6624.072629831828;6634.104395906587;6644.468442524587;6108.615274519966;6255.343188965184;6312.873742525216;6376.808695739135;6412.61524308543;5676.637606974296;6374.203224596926;6379.481748287791;6469.126667899774;6491.415772580491;6384.393482619236;6396.360363963567;6402.327755585689;6405.903911441332;6422.133012043408;6205.03821907596;6233.693533392583;6347.96826015867;6392.4246817786625;6400.743970241231;5118.309028281209;5135.486451354835;5136.486351364908;5139.871503212375;5161.380634323905;4643.512431194744;4649.116667833101;4660.231061874821;4666.719996800203;4705.223638099676;5841.532677385884;5870.882582348329;6014.669193194329;6115.088229002436;6136.846578835565;6441.1626488556185;6501.739930402731;6515.087887695727;6517.706703198272;6541;5869;6158.661273629993;6174.44430001302;6181;6184.536159788034;5449.536789372948;5535.059039963136;5609.214709940612;5624.803131890364;5673.234113394721;6410.61536307823;6428.228612566335;6430.678466076771;6437.774677886251;6449.0004049373365;6204.286507051746;6423.42189202974;6436.227652681709;6512.641804700787;6520.771772987922;6272.40412160844;6338.714757835816;6378;6391.712372943136;6402.807915762534;6366.172397588469;6402.263739669997;6429.38920802523;6429.58207716497;6431.549791514549;5629.240052593012;6210.472109870531;6361.840953976188;6485.416312531895;6506.284308726131;6370.90443643355;6379.87240255183;6382.744690212339;6384.744610215539;6394.104825324365;6355.3326900674765;6372.235331760218;6392.169018027626;6405.231372235362;6408.871822563616;5932.525397968066;6105.550726437353;6121.510279177566;6247.437730604086;6316.178896743394;6343.714532846126;6347.9843225085615;6360.77737279193;6363.5863668861375;6379.872402552016;6302.747890084529;6346.777862774781;6367.80896573085;6422.550421470452;6523.412892839668 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: |1;ext.html;522.4618642797919;563.6054761666834;571.2459553389526;577.3014652270754;588.417466707959;40689.79655101724;41304.79347603258;41525.584744152584;41547.58452415475;41641.791791041076;43930.780346098225;44213.557864421346;44453;44540.109197816026;44582.33126503097;9914.801703965899;10075.345102568346;10083;10110.191184705205;10118.696439106838;9860.506974651275;9943.353682010646;9959.103680668739;9974.152197063222;9990.850137247948;9872.70381888541;9951.402915825038;9955.10404063634;9956.452395118265;9956.701298961043;9943.95028024859;10012.94993525035;10014.198864090891;10020.64927727526;10033.849492257623;9760.17038551724;9886.80226395468;9906.455144967023;9931.453770042644;9933.453660048694;40788;40900.181996359905;41048.79475602633;41229.79385103085;41303.38044929328;2824.308044529083;3242.8864989725485;3304.6695330467;3404.557407537029;3495.8114241157873;28464.003759868512;29309;29396;29756.404871902658;30082.37264950482;2440.548498527778;2744.986275068632;2815.127310533741;2870.8277503349864;2979.478591246523;471766;472608;474026;474384;475715;56263.71868140633;58024.70987645119;59696;64221.03668444977;70346;66412;66850;66980.33019669839;67053.99419008719;67125.66437167783;16593.83406165947;16633.417830376122;16737.581560461087;16791.2443940023;16845.747313790303;12769.553065642844;12770.744585108247;12785.61643150707;12786.936065319614;12855.935720321339;19574.902125489567;19620.607587848164;19658.017099144985;19787.802121978882;20102.99485025743;9406.294527910297;9548.949615542424;9556.378835375679;9605.711828645151;9614.90385096154;944.3578366710566;960.7742180587557;968.6367612145445;985.7338518599938;1134.3647557367901;28511.28721781972;28704.003345664147;29164.85417572941;29600.259993500335;29919.85040074786;1010.7169992402139;1012.4886932099242;1084.4902895639036;1088.9509972051276;1129.0741591894569;14407;14492.710145797026;14619.707605847823;14706.55880323592;15925.203739813194;449398;457344;458981;459098;459656;48253.5174648249;57914.420855791745;57920;57956;57998;1257.8239046533492;1320;1440.107133577189;1441.351391873682;1455.9199244041467;27589.482578458377;28667;30007.249818754706;30377.392452151274;30891.845540772152;40996;51820;52140.478595213564;52200.47799521956;54234;460185.6990715025;514788;517790;518087;520829;31076.378472429973;33195.66804331926;33767;34105.65894341025;34126.31747365089;43242.783786080865;43293.3505997404;43414.56585434231;43543.34684979791;44113;36399.63600363962;36435.81782091073;36959.44560831536;36997.26005479929;38113.80943095267;28830.423391531633;36431.27137457289;37367;37604;38023.429648555844;35898.923032309074;36258.27483450369;37124;37966.81016594899;38011.42982855315;26151.869240653676;30107;31821.5226771594;32967.05494175893;43815;32203.677963221005;32276;32691.55323364828;33099.66900330966;34598.481022785185 04:51:31 INFO - 2015-11-23 04:51:31,745 DEBUG : BROWSER_OUTPUT: |2;jquery.html;366.91194113412774;369.6783798095656;372.1886287892394;373.8205661282584;375.16712897367853;16131.758023629654;19384.51538711533;20953.580928381423;21082.36752897412;21098.94505274736;20142.798572014275;21175.682364764503;21483.892580537115;21538.707677539358;21638.809865457395;5620.213170156181;5682.460166284196;5749.482546570808;5814.534837213034;5818.563607729416;5724;5734.598578099534;5742.54059675225;5775.249217601706;5777.277840269966;3755.3991361382186;3869.729118961674;5248.973755131219;5348.743045384332;5729.169270455782;5521.503064724174;5627.296587926509;5643.548516118701;5660.886782264352;5674.886502269973;4994.325766021577;5229.294045303874;5416.377116631598;5449.536789372908;5501.724913754337;12438;12712.491500339975;12712.745745085047;15345;19058.904705476383;1956.8043195680461;2046.996971483977;2182.4652960024737;2211.7898799614013;2302.7466978632337;9353.579088941015;9522.809543809086;9651.793525809273;9863.50682465881;9940.652077177336;1590.1731099828141;1664.858487028604;1748.3880641775404;1749.8775085744003;1779.3950056980689;101893.49053254686;107493;108019;109224;109852.45073774659;10997.560097596006;11073.446327683583;11134.27627204229;11185.888141118647;11231.887681123084;13061.804072938914;13076.150050246704;13093.279869607262;13101.296831412046;13204.339783010812;8309.916900830915;8534.914650853536;8592.011918629438;8636.006859211146;8661.783455413664;8795.604197811113;8824.779380515538;8869;8886.822263554823;8901.332400070021;4368.257396242647;4369.759663218553;4379.233634114017;4382.846600368972;4388.583084607021;1869.3924474545554;1883.3690713611093;1910.9331173408864;1937.2251099560008;1937.8159074887863;399.26535175277627;401.95176578810145;925.9398139120935;948.558920102142;995.5221493683073;11068.501917413574;11336.6032188873;11722.824157637642;11954.342511161796;11962.76074478523;435.9542248063971;443.5232125465138;450.09980039920157;453.3403897329378;461.7414248021119;5994.670293133832;6008.549358798107;6103.969480152659;6160.414760597736;6163.630182189083;771013;802924;803402;803944;816465;105291.94708052975;105961.47019265009;111332.44333778441;115775.42112289385;117264;479.41990191867535;479.63547703744706;483.842751105892;484.5808375754947;485.2430208874168;8589.484630922165;10882.857299983387;10937.781244375226;11035.95158459945;11088.445577721242;49181;50060.49939500559;50186.74906625444;50580.747096264284;50646.493535064175;71885.6405717968;72753;73448;73660.26339736534;76281;9823.901760982299;9892.802143957224;10041.698749037541;10068.496575171359;10108.54511546997;19259.711104333728;19337.613247735248;20165.59668806645;20189;20313.898430508343;16089.436869709503;16222.918885405497;16615;16631.417900373428;16998;13857.237851918242;15935.12356820386;16009;16135.596610084842;16267.26797294101;15674.608134796264;15830.49610287021;16336.346546138022;16352.918235408746;17141.914290428966;8664.696735614223;9816.116549510578;9875.506224688881;10003.34978226413;10207.438590877573;15297.770533441784;15808.288627012042;15881.602959926095;16073.276702548646;16402.015879047296 04:51:31 INFO - 2015-11-23 04:51:31,747 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1482.8146481689796;1528.1136940574468;1887.5752955584987;1900.8954507502085;1935.1388632058731;6356.904646430307;7726.961365193166;8434.945631796025;8688.956555217223;8814.162654547808;8283.378746593999;8385.790355241106;8434.831303373929;8490.150984901507;8512.106228845974;2038.4598081508411;2376.3583832365252;2385.3082606044227;2404.495056038234;2408.771166739157;2397.652340410639;2428.86641234732;2432.6107822748363;2451.019592163131;2500.062476571286;2369.2536850892;2389.0921449849034;2399.5440866235444;2407.205622144697;2419.4314336130997;2356.340224737059;2367.07684003238;2380.059876348841;2395.2574701842395;2412.4692567635093;2339.87130707811;2375.4536456615074;2375.964360534593;2383.416063064543;2404.987975060131;8541.572921353907;8608.268297194745;8624.56877156146;8635.790989261508;8648.65405383784;4557.680962332638;5184.896302073975;5252.3171987641745;5262.631615786897;5276.5251127398715;2905.4915389806697;3189.1708155879637;3505.8597656093725;3543.3799085160254;3583.33708263972;1052.9894701052967;1061.2889364126054;1073.9570417183304;1089.967300980972;1090.5419723716059;10755.03204711572;10782.299150555189;10791.02880740737;10855.891441085647;10866.130709543218;4092.263392589303;4731.313959475857;4817.325574419584;4825.396825396825;4864.951350486521;9693.660721874701;9735.561899714388;9768.706938791847;9796.461194634221;9816.65641702537;5212.921806172911;5257.658252213594;5263.131583288715;5295;5301.125314323093;4722.763861806896;4732.621390288768;4748.074125545554;4772.976135119302;4789.137955168103;3931.803409829497;3935.2916475034194;3937.586553411908;3940.645341919241;3981.6217459341315;1299.7920332746714;1311.2132720367704;1311.6196303072002;1312.2913626641507;1316.585275638171;1366.9658258543418;1372.945082196701;1389.673426744714;1394.9930250348887;1417.2630232279157;7999.440039197317;8050.476719013245;8082.83834323322;8113.269805717514;8118.959405202936;520.1703283263189;520.3417676639054;524.6589716684185;524.8477941397028;526.8814516733704;6027.389106853215;6081.483073938676;6169.722362493699;6318.8420289492215;6319.494440444753;9302.53487325631;9390.67132650354;9867.555959981675;10093.142082922886;10243.590256389662;9920.15678667307;10032.849507257397;10084.092431681183;10156.593736250616;10239.18086553074;8034.236747508978;8093.35253179756;8097.473664211808;8099.514029158269;8167.591620419074;7607.847843043219;7650.65572049248;7665.080190377191;7686.692532298645;7717.459777815499;8899.688510902088;9097.272218222659;9124.361294709306;9183.403078799856;9207.033261507713;9303.581338839633;9424.905750942402;9447.385919915183;9450.385724927857;9477.573509191965;6575.96712016456;6796.184457865088;7317;7383.07711536058;7386.741464048732;7874.763757087297;8112.553809540532;8119.634616442392;8130.593470326578;8139.4709343892455;7523.774286771406;7573.697052117854;7612.276833700789;7681.231876812498;7740.3420709240345;7465.552066876005;7488.775336739906;7563.9621801890635;7573.772786816405;7624.428167887319;6309.432151106423;7560.848783024198;7595.848083038198;7608.885866711893;7625.1231108421025;6924.065251191025;6955.443564514725;6956.617386043614;6968.965155174192;6986.6157361343585;6990.510664253454;7042.401395881408;7113.430925526049;7124.145102587722;7136.4290856730295 04:51:31 INFO - 2015-11-23 04:51:31,748 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.25553350024444;325.9755518336125;329.88454041085606;337.3354491651447;337.9831008449577;6806.11520502334;6928.237893831674;6967.233604303523;6972;7025.227225005252;5987.940120598792;6900.551464154839;6919.2734762849805;6943.270956549565;6977.1278590176225;4167.520735115455;4423.1153769246275;5150.4334523202415;5152.252923326116;5168.173092305213;4969.602431805447;5033.647644664875;5155.690658560498;5171.689698618076;5173.6119791015635;4137.27597670408;4188.2251783420015;4923.507649235065;5116.8742876567285;5143.09995750744;5064.632549211729;5095.719735414551;5104.081265372231;5113.667611605271;5135.460776618439;4160.105577300895;4231.132617813341;4253.340732186516;4367.170237654836;4382.715123516961;6586.110875031905;6636.701348439332;6651.93348066518;6674.599524028526;6692;6001.579889407743;6028.306744724369;6034.2155519782145;6042.516598672096;6070.848228794272;6579.539432239745;7059.964700176518;7228.674709638079;7485.737999170003;7532.17146113927;4486.618637415823;4894.070126675921;4899.436564795059;4907.509249075099;4908.214685650314;7903.407244456631;7912.920870791276;7920.80197995049;7934.682612695486;7968.880466793003;4631.189541830234;4757.215059515142;4968.8757781055765;4971.726555039508;4977.203647416396;4860.149473842063;4897.975510122426;4915.361003069578;4920.72935988524;4928;5867.178594996704;5897.43717914753;5901.852453688693;5906.26171728534;5908.291005079332;7245.275472452712;7511.737089201852;7522.699092036257;7528.322450979329;7536;1686.1822016322074;1702.7360759082362;1703.897766134036;1705.6588682263598;1709.2308461192513;906.4470672889532;1077.138289368502;1078.245228340165;1087.771567970735;1089.6022951622758;6932.792016239521;6966.5471744336455;6970.546914450544;7003.614801185881;7004.4046256068805;7787.377009839312;7806.297433231037;7830.33442157423;7835.2948234658015;7844.019497562805;6771.864562708718;6967.641309944512;6970.198427180838;6972.1981972072845;7018.9298107019295;4007.6593489553134;4088.1823635273063;4100.507939047334;4109.321961876317;4142.855000074983;6549.312322206099;7586.861970704438;7830.647620857075;7854.3716502679645;7873.724419645399;7032.296770322927;7929.5242285463055;8104.230098140667;8108.716194933149;8119.959400202961;6235.719392627343;6621.841177793867;7546.396288296923;7850.842983140419;7883.975083239142;7598.822182561712;7813.960930195312;7814.062312522534;7816.374690024671;7828;6472.805815825533;7367.2318643524095;7684.077910650758;7698.2686644768655;7738.7678369649;7152.284771522806;7442.957985882089;7854.803629909069;7863.882041769492;7883.251091146332;4755.643326750576;4809.9038019240115;4820.758962051954;4836.177849765478;4849.612031037579;7553.622318883924;7768.88346674789;7787.415943804351;7799.922000780147;7824.374050076094;6265.27949285838;7479.177290497932;7489.400847932261;7493.850122997618;7502.849943001219;6751.49363797727;7335.889961650473;7462.96268518654;7514.173440921603;7529.623518824146;7249.238829922782;7313.670884810303;7336.559806411632;7337.486375953632;7360;7452.105747310357;7478.850422991619;7484.43866709988;7488.251174882468;7492.7752167435065;7094.964525177341;7314.817129571803;7320.377767889789;7330.853382932418;7344 04:51:31 INFO - 2015-11-23 04:51:31,752 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.5073051785822;807.5760225881415;820.0528389709885;828.8881001064855;847.5889193741034;14945.327460264287;15051.92474037631;15203.923980380096;15260.618484537878;15265.694686106272;12523.874761252384;13656.726865462684;13882.236476993761;13979.650508737286;14257;936.9156775890168;951.0251991708485;964.6334392930677;969.8690676758653;971.116284181395;930.4138392812519;942.4769253064546;954.6610953111649;957.2198658093666;959.8608201810733;983.7540614846289;990.7077412163429;997.4563862694813;997.6109317366233;1007.9244056695741;979.6620166042704;985.5023213277249;987.1411871671655;998.8202123617746;1001.019001378653;737.3363972424806;741.8775901976168;748.135903031999;751.9360854327389;752.8870669399579;13300.800487992688;13336.19982801035;13452.529161479399;13470.797938030937;13504.932475337659;10971.23201375904;11078.556857725682;11204.943975280072;11471.713207169887;11729.003034742058;9558.139767420897;9653.71038868835;9811.067948544876;10173.643922462752;10267.127294180003;3410.437277849152;3549.2546565221332;3555.1112221944513;3555.875544355961;3566.3937130687586;66002.3399766001;73768.6311568444;78290.6085469569;78642;78687;9692.176165026052;9917.107460328605;9954.20366370703;10080.29437939352;10648.946755266174;19822.20711171566;21180.78819211819;22247.44381390478;22909;23582.70295133784;7546.2831031051965;7599.164091949881;7644.694212231449;7711.537307761552;7885.5662938538935;4088.468499095158;4095.017195872969;4122.670186385082;4159.625633692982;4164.1879833432795;3357.690500704727;3395.966040339614;3642.1623026704005;3667.706583473369;3669.889903302905;606.884691908536;631.6810010944444;640.3180612647516;661.5237029338869;662.8475450646282;425.3152424596397;444.5176982973445;478.2443738892541;534.318743601903;542.0622323380574;8538.615762290712;8599.355048371397;8722.651093956298;8834.469931804113;8925.464472131693;528.3211073770264;550.6778534557329;582.9361415416881;588.3057991569989;629.4649547884353;3841.250956063541;4095.4675892133832;4151.024509240327;4198.517170525429;4215.409842622035;88713;89804;89978.55010724904;90164;90961;79053;82099;82779;83110.58444707858;83494.58252708698;70895.6455217731;71517.49066348062;71789;73336.63331683307;74719.62640186764;8889.73330800077;8970.506622135845;8977.416467929565;8998.370114091951;9170.67902623405;46569;48161.5183848157;52625.47374526359;52783.680407990105;53312;68172.659136704;71359.64320178366;74026;74902;74946.5010699794;9442.15020648145;10547.89247129071;10890.891091088988;10922.235443518877;11169.832452513056;12166.939165304471;12172.878271217174;12473.5010599575;12701.301428421526;13325.800112998118;11376.886231137914;11507.367094809866;11826.053915686896;12193.878061219275;12312.507499699912;9793.804123917624;10971.670849874517;11682.94158529236;11994.460249288977;12290.139690221598;11360.602378916697;11654.650360489199;11770.76458470843;11912;11919.582814601446;9656.9034309656;9704.514774261399;9823.656172033945;10125.341852779546;10288.331258468175;7652.693892244248;8205.810157527007;8553.74338769838;9943.751406214902;10208.897911021091 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,343 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283091736__endTimestamp 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5939.76 Median:6205.04 stddev:664.74 (10.7%) stddev-sans-first:637.82 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: Values: 3466.0 3559.3 3605.0 3630.6 3631.1 5678.5 6021.3 6027.0 6034.9 6053.3 5869.3 5891.9 5923.8 6060.4 6100.2 5279.8 5300.9 5387.2 5489.4 5494.4 4420.7 5465.8 5499.8 5510.7 5582.8 5257.7 5266.6 5316.2 5420.3 5420.9 4460.7 5385.4 5422.8 5436.6 5449.6 5204.7 5379.4 5384.9 5449.3 5467.7 4984.8 5245.5 5577.5 5841.3 6115.3 6395.6 6400.4 6403.2 6412.2 6427.2 6232.8 6320.7 6413.7 6445.8 6478.2 6054.0 6098.7 6151.4 6154.7 6155.4 6543.4 6561.4 6624.1 6634.1 6644.5 6108.6 6255.3 6312.9 6376.8 6412.6 5676.6 6374.2 6379.5 6469.1 6491.4 6384.4 6396.4 6402.3 6405.9 6422.1 6205.0 6233.7 6348.0 6392.4 6400.7 5118.3 5135.5 5136.5 5139.9 5161.4 4643.5 4649.1 4660.2 4666.7 4705.2 5841.5 5870.9 6014.7 6115.1 6136.8 6441.2 6501.7 6515.1 6517.7 6541.0 5869.0 6158.7 6174.4 6181.0 6184.5 5449.5 5535.1 5609.2 5624.8 5673.2 6410.6 6428.2 6430.7 6437.8 6449.0 6204.3 6423.4 6436.2 6512.6 6520.8 6272.4 6338.7 6378.0 6391.7 6402.8 6366.2 6402.3 6429.4 6429.6 6431.5 5629.2 6210.5 6361.8 6485.4 6506.3 6370.9 6379.9 6382.7 6384.7 6394.1 6355.3 6372.2 6392.2 6405.2 6408.9 5932.5 6105.6 6121.5 6247.4 6316.2 6343.7 6348.0 6360.8 6363.6 6379.9 6302.7 6346.8 6367.8 6422.6 6523.4 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,753 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63126.55 Median:38017.43 stddev:127225.91 (334.7%) stddev-sans-first:127495.99 04:51:31 INFO - 2015-11-23 04:51:31,754 DEBUG : BROWSER_OUTPUT: Values: 522.5 563.6 571.2 577.3 588.4 40689.8 41304.8 41525.6 41547.6 41641.8 43930.8 44213.6 44453.0 44540.1 44582.3 9914.8 10075.3 10083.0 10110.2 10118.7 9860.5 9943.4 9959.1 9974.2 9990.9 9872.7 9951.4 9955.1 9956.5 9956.7 9944.0 10012.9 10014.2 10020.6 10033.8 9760.2 9886.8 9906.5 9931.5 9933.5 40788.0 40900.2 41048.8 41229.8 41303.4 2824.3 3242.9 3304.7 3404.6 3495.8 28464.0 29309.0 29396.0 29756.4 30082.4 2440.5 2745.0 2815.1 2870.8 2979.5 471766.0 472608.0 474026.0 474384.0 475715.0 56263.7 58024.7 59696.0 64221.0 70346.0 66412.0 66850.0 66980.3 67054.0 67125.7 16593.8 16633.4 16737.6 16791.2 16845.7 12769.6 12770.7 12785.6 12786.9 12855.9 19574.9 19620.6 19658.0 19787.8 20103.0 9406.3 9548.9 9556.4 9605.7 9614.9 944.4 960.8 968.6 985.7 1134.4 28511.3 28704.0 29164.9 29600.3 29919.9 1010.7 1012.5 1084.5 1089.0 1129.1 14407.0 14492.7 14619.7 14706.6 15925.2 449398.0 457344.0 458981.0 459098.0 459656.0 48253.5 57914.4 57920.0 57956.0 57998.0 1257.8 1320.0 1440.1 1441.4 1455.9 27589.5 28667.0 30007.2 30377.4 30891.8 40996.0 51820.0 52140.5 52200.5 54234.0 460185.7 514788.0 517790.0 518087.0 520829.0 31076.4 33195.7 33767.0 34105.7 34126.3 43242.8 43293.4 43414.6 43543.3 44113.0 36399.6 36435.8 36959.4 36997.3 38113.8 28830.4 36431.3 37367.0 37604.0 38023.4 35898.9 36258.3 37124.0 37966.8 38011.4 26151.9 30107.0 31821.5 32967.1 43815.0 32203.7 32276.0 32691.6 33099.7 34598.5 04:51:31 INFO - 2015-11-23 04:51:31,754 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,755 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39440.21 Median:370.93 stddev:131495.86 (35450.0%) stddev-sans-first:131832.00 04:51:31 INFO - 2015-11-23 04:51:31,755 DEBUG : BROWSER_OUTPUT: Values: 366.9 369.7 372.2 373.8 375.2 16131.8 19384.5 20953.6 21082.4 21098.9 20142.8 21175.7 21483.9 21538.7 21638.8 5620.2 5682.5 5749.5 5814.5 5818.6 5724.0 5734.6 5742.5 5775.2 5777.3 3755.4 3869.7 5249.0 5348.7 5729.2 5521.5 5627.3 5643.5 5660.9 5674.9 4994.3 5229.3 5416.4 5449.5 5501.7 12438.0 12712.5 12712.7 15345.0 19058.9 1956.8 2047.0 2182.5 2211.8 2302.7 9353.6 9522.8 9651.8 9863.5 9940.7 1590.2 1664.9 1748.4 1749.9 1779.4 101893.5 107493.0 108019.0 109224.0 109852.5 10997.6 11073.4 11134.3 11185.9 11231.9 13061.8 13076.2 13093.3 13101.3 13204.3 8309.9 8534.9 8592.0 8636.0 8661.8 8795.6 8824.8 8869.0 8886.8 8901.3 4368.3 4369.8 4379.2 4382.8 4388.6 1869.4 1883.4 1910.9 1937.2 1937.8 399.3 402.0 925.9 948.6 995.5 11068.5 11336.6 11722.8 11954.3 11962.8 436.0 443.5 450.1 453.3 461.7 5994.7 6008.5 6104.0 6160.4 6163.6 771013.0 802924.0 803402.0 803944.0 816465.0 105291.9 105961.5 111332.4 115775.4 117264.0 479.4 479.6 483.8 484.6 485.2 8589.5 10882.9 10937.8 11036.0 11088.4 49181.0 50060.5 50186.7 50580.7 50646.5 71885.6 72753.0 73448.0 73660.3 76281.0 9823.9 9892.8 10041.7 10068.5 10108.5 19259.7 19337.6 20165.6 20189.0 20313.9 16089.4 16222.9 16615.0 16631.4 16998.0 13857.2 15935.1 16009.0 16135.6 16267.3 15674.6 15830.5 16336.3 16352.9 17141.9 8664.7 9816.1 9875.5 10003.3 10207.4 15297.8 15808.3 15881.6 16073.3 16402.0 04:51:31 INFO - 2015-11-23 04:51:31,755 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,755 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5855.03 Median:5664.26 stddev:3036.63 (53.6%) stddev-sans-first:3027.36 04:51:31 INFO - 2015-11-23 04:51:31,757 DEBUG : BROWSER_OUTPUT: Values: 1482.8 1528.1 1887.6 1900.9 1935.1 6356.9 7727.0 8434.9 8689.0 8814.2 8283.4 8385.8 8434.8 8490.2 8512.1 2038.5 2376.4 2385.3 2404.5 2408.8 2397.7 2428.9 2432.6 2451.0 2500.1 2369.3 2389.1 2399.5 2407.2 2419.4 2356.3 2367.1 2380.1 2395.3 2412.5 2339.9 2375.5 2376.0 2383.4 2405.0 8541.6 8608.3 8624.6 8635.8 8648.7 4557.7 5184.9 5252.3 5262.6 5276.5 2905.5 3189.2 3505.9 3543.4 3583.3 1053.0 1061.3 1074.0 1090.0 1090.5 10755.0 10782.3 10791.0 10855.9 10866.1 4092.3 4731.3 4817.3 4825.4 4865.0 9693.7 9735.6 9768.7 9796.5 9816.7 5212.9 5257.7 5263.1 5295.0 5301.1 4722.8 4732.6 4748.1 4773.0 4789.1 3931.8 3935.3 3937.6 3940.6 3981.6 1299.8 1311.2 1311.6 1312.3 1316.6 1367.0 1372.9 1389.7 1395.0 1417.3 7999.4 8050.5 8082.8 8113.3 8119.0 520.2 520.3 524.7 524.8 526.9 6027.4 6081.5 6169.7 6318.8 6319.5 9302.5 9390.7 9867.6 10093.1 10243.6 9920.2 10032.8 10084.1 10156.6 10239.2 8034.2 8093.4 8097.5 8099.5 8167.6 7607.8 7650.7 7665.1 7686.7 7717.5 8899.7 9097.3 9124.4 9183.4 9207.0 9303.6 9424.9 9447.4 9450.4 9477.6 6576.0 6796.2 7317.0 7383.1 7386.7 7874.8 8112.6 8119.6 8130.6 8139.5 7523.8 7573.7 7612.3 7681.2 7740.3 7465.6 7488.8 7564.0 7573.8 7624.4 6309.4 7560.8 7595.8 7608.9 7625.1 6924.1 6955.4 6956.6 6969.0 6986.6 6990.5 7042.4 7113.4 7124.1 7136.4 04:51:31 INFO - 2015-11-23 04:51:31,757 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,757 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6026.64 Median:6923.76 stddev:1944.79 (28.1%) stddev-sans-first:1902.05 04:51:31 INFO - 2015-11-23 04:51:31,758 DEBUG : BROWSER_OUTPUT: Values: 294.3 326.0 329.9 337.3 338.0 6806.1 6928.2 6967.2 6972.0 7025.2 5987.9 6900.6 6919.3 6943.3 6977.1 4167.5 4423.1 5150.4 5152.3 5168.2 4969.6 5033.6 5155.7 5171.7 5173.6 4137.3 4188.2 4923.5 5116.9 5143.1 5064.6 5095.7 5104.1 5113.7 5135.5 4160.1 4231.1 4253.3 4367.2 4382.7 6586.1 6636.7 6651.9 6674.6 6692.0 6001.6 6028.3 6034.2 6042.5 6070.8 6579.5 7060.0 7228.7 7485.7 7532.2 4486.6 4894.1 4899.4 4907.5 4908.2 7903.4 7912.9 7920.8 7934.7 7968.9 4631.2 4757.2 4968.9 4971.7 4977.2 4860.1 4898.0 4915.4 4920.7 4928.0 5867.2 5897.4 5901.9 5906.3 5908.3 7245.3 7511.7 7522.7 7528.3 7536.0 1686.2 1702.7 1703.9 1705.7 1709.2 906.4 1077.1 1078.2 1087.8 1089.6 6932.8 6966.5 6970.5 7003.6 7004.4 7787.4 7806.3 7830.3 7835.3 7844.0 6771.9 6967.6 6970.2 6972.2 7018.9 4007.7 4088.2 4100.5 4109.3 4142.9 6549.3 7586.9 7830.6 7854.4 7873.7 7032.3 7929.5 8104.2 8108.7 8120.0 6235.7 6621.8 7546.4 7850.8 7884.0 7598.8 7814.0 7814.1 7816.4 7828.0 6472.8 7367.2 7684.1 7698.3 7738.8 7152.3 7443.0 7854.8 7863.9 7883.3 4755.6 4809.9 4820.8 4836.2 4849.6 7553.6 7768.9 7787.4 7799.9 7824.4 6265.3 7479.2 7489.4 7493.9 7502.8 6751.5 7335.9 7463.0 7514.2 7529.6 7249.2 7313.7 7336.6 7337.5 7360.0 7452.1 7478.9 7484.4 7488.3 7492.8 7095.0 7314.8 7320.4 7330.9 7344.0 04:51:31 INFO - 2015-11-23 04:51:31,758 DEBUG : BROWSER_OUTPUT: 04:51:31 INFO - 2015-11-23 04:51:31,758 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18419.61 Median:597.60 stddev:25859.51 (4327.3%) stddev-sans-first:25898.01 04:51:31 INFO - 2015-11-23 04:51:31,760 DEBUG : BROWSER_OUTPUT: Values: 746.5 807.6 820.1 828.9 847.6 14945.3 15051.9 15203.9 15260.6 15265.7 12523.9 13656.7 13882.2 13979.7 14257.0 936.9 951.0 964.6 969.9 971.1 930.4 942.5 954.7 957.2 959.9 983.8 990.7 997.5 997.6 1007.9 979.7 985.5 987.1 998.8 1001.0 737.3 741.9 748.1 751.9 752.9 13300.8 13336.2 13452.5 13470.8 13504.9 10971.2 11078.6 11204.9 11471.7 11729.0 9558.1 9653.7 9811.1 10173.6 10267.1 3410.4 3549.3 3555.1 3555.9 3566.4 66002.3 73768.6 78290.6 78642.0 78687.0 9692.2 9917.1 9954.2 10080.3 10648.9 19822.2 21180.8 22247.4 22909.0 23582.7 7546.3 7599.2 7644.7 7711.5 7885.6 4088.5 4095.0 4122.7 4159.6 4164.2 3357.7 3396.0 3642.2 3667.7 3669.9 606.9 631.7 640.3 661.5 662.8 425.3 444.5 478.2 534.3 542.1 8538.6 8599.4 8722.7 8834.5 8925.5 528.3 550.7 582.9 588.3 629.5 3841.3 4095.5 4151.0 4198.5 4215.4 88713.0 89804.0 89978.6 90164.0 90961.0 79053.0 82099.0 82779.0 83110.6 83494.6 70895.6 71517.5 71789.0 73336.6 74719.6 8889.7 8970.5 8977.4 8998.4 9170.7 46569.0 48161.5 52625.5 52783.7 53312.0 68172.7 71359.6 74026.0 74902.0 74946.5 9442.2 10547.9 10890.9 10922.2 11169.8 12166.9 12172.9 12473.5 12701.3 13325.8 11376.9 11507.4 11826.1 12193.9 12312.5 9793.8 10971.7 11682.9 11994.5 12290.1 11360.6 11654.7 11770.8 11912.0 11919.6 9656.9 9704.5 9823.7 10125.3 10288.3 7652.7 8205.8 8553.7 9943.8 10208.9 04:51:31 INFO - 2015-11-23 04:51:31,760 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:51:31 INFO - 2015-11-23 04:51:31,760 DEBUG : BROWSER_OUTPUT: 04:51:32 INFO - 2015-11-23 04:51:32,177 INFO : Browser exited with error code: 0 04:51:32 INFO - 2015-11-23 04:51:32,201 INFO : Completed test dromaeo_css (00:18:31) 04:51:32 INFO - 2015-11-23 04:51:32,201 INFO : Starting test kraken 04:51:32 INFO - 2015-11-23 04:51:32,201 DEBUG : operating with platform_type : mac_ 04:51:32 INFO - 2015-11-23 04:51:32,201 INFO : Initialising browser for kraken test... 04:51:32 INFO - 2015-11-23 04:51:32,213 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpoRxwDR/profile http://localhost:49272/getInfo.html 04:51:34 INFO - 2015-11-23 04:51:34,770 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:51:34 INFO - 2015-11-23 04:51:34,770 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:51:34 INFO - 2015-11-23 04:51:34,770 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 04:51:34 INFO - 2015-11-23 04:51:34,770 DEBUG : BROWSER_OUTPUT: __metrics 04:51:35 INFO - 2015-11-23 04:51:35,352 INFO : Browser initialized. 04:51:35 INFO - 2015-11-23 04:51:35,353 INFO : Running cycle 1/1 for kraken test... 04:51:35 INFO - 2015-11-23 04:51:35,353 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpoRxwDR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:51:47 INFO - 2015-11-23 04:51:47,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 237301760 04:51:47 INFO - 2015-11-23 04:51:47,220 DEBUG : BROWSER_OUTPUT: 04:51:50 INFO - 2015-11-23 04:51:50,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:50 INFO - 2015-11-23 04:51:50,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 248905728 04:51:50 INFO - 2015-11-23 04:51:50,724 DEBUG : BROWSER_OUTPUT: 04:51:53 INFO - 2015-11-23 04:51:53,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 04:51:53 INFO - 2015-11-23 04:51:53,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 259018752 04:51:53 INFO - 2015-11-23 04:51:53,960 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-11-23 04:51:57,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 04:51:58 INFO - 2015-11-23 04:51:58,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 260444160 04:51:58 INFO - 2015-11-23 04:51:58,061 DEBUG : BROWSER_OUTPUT: 04:51:59 INFO - 2015-11-23 04:51:59,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 04:52:00 INFO - 2015-11-23 04:52:00,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 263753728 04:52:00 INFO - 2015-11-23 04:52:00,469 DEBUG : BROWSER_OUTPUT: 04:52:02 INFO - 2015-11-23 04:52:02,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:03 INFO - 2015-11-23 04:52:03,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 264941568 04:52:03 INFO - 2015-11-23 04:52:03,091 DEBUG : BROWSER_OUTPUT: 04:52:05 INFO - 2015-11-23 04:52:05,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:06 INFO - 2015-11-23 04:52:06,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 264720384 04:52:06 INFO - 2015-11-23 04:52:06,536 DEBUG : BROWSER_OUTPUT: 04:52:09 INFO - 2015-11-23 04:52:09,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:09 INFO - 2015-11-23 04:52:09,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 264794112 04:52:09 INFO - 2015-11-23 04:52:09,856 DEBUG : BROWSER_OUTPUT: 04:52:12 INFO - 2015-11-23 04:52:12,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 04:52:13 INFO - 2015-11-23 04:52:13,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 264974336 04:52:13 INFO - 2015-11-23 04:52:13,375 DEBUG : BROWSER_OUTPUT: 04:52:14 INFO - 2015-11-23 04:52:14,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:15 INFO - 2015-11-23 04:52:15,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 263856128 04:52:15 INFO - 2015-11-23 04:52:15,581 DEBUG : BROWSER_OUTPUT: 04:52:17 INFO - 2015-11-23 04:52:17,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:18 INFO - 2015-11-23 04:52:18,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 264060928 04:52:18 INFO - 2015-11-23 04:52:18,071 DEBUG : BROWSER_OUTPUT: 04:52:20 INFO - 2015-11-23 04:52:20,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:20 INFO - 2015-11-23 04:52:20,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 264540160 04:52:20 INFO - 2015-11-23 04:52:20,890 DEBUG : BROWSER_OUTPUT: 04:52:23 INFO - 2015-11-23 04:52:23,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:24 INFO - 2015-11-23 04:52:24,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 264347648 04:52:24 INFO - 2015-11-23 04:52:24,046 DEBUG : BROWSER_OUTPUT: 04:52:26 INFO - 2015-11-23 04:52:26,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:27 INFO - 2015-11-23 04:52:27,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 263962624 04:52:27 INFO - 2015-11-23 04:52:27,099 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 04:52:28 INFO - 2015-11-23 04:52:28,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 265445376 04:52:28 INFO - 2015-11-23 04:52:28,975 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;108;114;125;160;176;117;113;113;113 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;143;134;174;182;150;141;121;158;144;122 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |2;audio-dft;267;276;192;221;228;273;240;203;194;199 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |3;audio-fft;59;65;70;103;58;55;58;59;108;56 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;79;104;76;76;79;92;101;100;138 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;126;88;87;93;134;86;87;86;77;132 04:52:28 INFO - 2015-11-23 04:52:28,976 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;95;94;93;94;95;95;95;98;100 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;93;92;125;149;145;98;94;92;99;93 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;59;58;58;59;77;91;85;83 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;66;68;66;67;67;97;100;94 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;89;120;111;107;85;83;105;74;102 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;133;151;122;126;138;127;118;127;122 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;140;162;136;161;139;141;139;139;138 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;67;66;69;65;67;66;67;65 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,813 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283148970__endTimestamp 04:52:28 INFO - 2015-11-23 04:52:28,977 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.40 Median:116.00 stddev:23.17 (20.0%) stddev-sans-first:24.26 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: Values: 115.0 108.0 114.0 125.0 160.0 176.0 117.0 113.0 113.0 113.0 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:147.00 stddev:20.04 (13.6%) stddev-sans-first:21.21 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: Values: 143.0 134.0 174.0 182.0 150.0 141.0 121.0 158.0 144.0 122.0 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:229.30 Median:234.00 stddev:33.24 (14.2%) stddev-sans-first:32.34 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: Values: 267.0 276.0 192.0 221.0 228.0 273.0 240.0 203.0 194.0 199.0 04:52:28 INFO - 2015-11-23 04:52:28,978 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:69.10 Median:58.50 stddev:19.72 (33.7%) stddev-sans-first:20.58 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: Values: 59.0 65.0 70.0 103.0 58.0 55.0 58.0 59.0 108.0 56.0 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:92.20 Median:76.50 stddev:19.66 (25.7%) stddev-sans-first:20.07 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 104.0 76.0 76.0 79.0 92.0 101.0 100.0 138.0 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:99.60 Median:86.50 stddev:21.87 (25.3%) stddev-sans-first:21.01 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: Values: 126.0 88.0 87.0 93.0 134.0 86.0 87.0 86.0 77.0 132.0 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:2.11 (2.2%) stddev-sans-first:2.19 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 94.0 93.0 94.0 95.0 95.0 95.0 98.0 100.0 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,979 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:108.00 Median:93.00 stddev:22.80 (24.5%) stddev-sans-first:23.53 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 125.0 149.0 145.0 98.0 94.0 92.0 99.0 93.0 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.70 Median:68.00 stddev:13.59 (20.0%) stddev-sans-first:13.95 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 59.0 58.0 58.0 59.0 77.0 91.0 85.0 83.0 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:75.80 Median:67.00 stddev:14.71 (22.0%) stddev-sans-first:15.17 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 68.0 66.0 67.0 67.0 97.0 100.0 94.0 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.00 Median:78.50 stddev:14.93 (19.0%) stddev-sans-first:15.19 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: Values: 84.0 89.0 120.0 111.0 107.0 85.0 83.0 105.0 74.0 102.0 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:129.00 stddev:9.54 (7.4%) stddev-sans-first:10.10 04:52:28 INFO - 2015-11-23 04:52:28,980 DEBUG : BROWSER_OUTPUT: Values: 131.0 133.0 151.0 122.0 126.0 138.0 127.0 118.0 127.0 122.0 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:140.00 stddev:9.58 (6.8%) stddev-sans-first:10.08 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: Values: 140.0 140.0 162.0 136.0 161.0 139.0 141.0 139.0 139.0 138.0 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 67.0 66.0 69.0 65.0 67.0 66.0 67.0 65.0 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:52:28 INFO - 2015-11-23 04:52:28,981 DEBUG : BROWSER_OUTPUT: 04:52:29 INFO - 2015-11-23 04:52:29,569 INFO : Browser exited with error code: 0 04:52:29 INFO - 2015-11-23 04:52:29,613 INFO : Completed test kraken (00:00:57) 04:52:29 INFO - 2015-11-23 04:52:29,613 INFO : Starting test v8_7 04:52:29 INFO - 2015-11-23 04:52:29,613 DEBUG : operating with platform_type : mac_ 04:52:29 INFO - 2015-11-23 04:52:29,614 INFO : Initialising browser for v8_7 test... 04:52:29 INFO - 2015-11-23 04:52:29,626 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpATmcqC/profile http://localhost:49272/getInfo.html 04:52:32 INFO - 2015-11-23 04:52:32,328 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:52:32 INFO - 2015-11-23 04:52:32,328 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:52:32 INFO - 2015-11-23 04:52:32,328 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 04:52:32 INFO - 2015-11-23 04:52:32,328 DEBUG : BROWSER_OUTPUT: __metrics 04:52:32 INFO - 2015-11-23 04:52:32,937 INFO : Browser initialized. 04:52:32 INFO - 2015-11-23 04:52:32,937 INFO : Running cycle 1/1 for v8_7 test... 04:52:32 INFO - 2015-11-23 04:52:32,937 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpATmcqC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:52:45 INFO - 2015-11-23 04:52:45,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 236969984 04:52:45 INFO - 2015-11-23 04:52:45,030 DEBUG : BROWSER_OUTPUT: 04:53:06 INFO - 2015-11-23 04:53:06,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/v8_7/run.html (next: http://localhost:49272/tests/v8_7/run.html) 04:53:07 INFO - 2015-11-23 04:53:07,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 248094720 04:53:07 INFO - 2015-11-23 04:53:07,119 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |0;Richards;144.59224985540774 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.38117721120554 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |2;Encrypt;274.8763056624519 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4758.293838862559 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |4;RayTrace;948.7666034155598 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |5;Earley;736.9196757553427 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |6;Boyer;12525 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |7;RegExp;27621.62162162162 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |8;Splay;661.8133686300463 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4524.886877828054 04:53:07 INFO - 2015-11-23 04:53:07,120 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283187115__endTimestamp 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:144.59 Median:144.59 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: Values: 144.6 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.38 Median:157.38 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: Values: 157.4 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:274.88 Median:274.88 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: Values: 274.9 04:53:07 INFO - 2015-11-23 04:53:07,121 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4758.29 Median:4758.29 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: Values: 4758.3 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:948.77 Median:948.77 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: Values: 948.8 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:736.92 Median:736.92 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: Values: 736.9 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: Values: 12525.0 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27621.62 Median:27621.62 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,122 DEBUG : BROWSER_OUTPUT: Values: 27621.6 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:661.81 Median:661.81 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: Values: 661.8 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4524.89 Median:4524.89 stddev:0.00 (0.0%) 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: Values: 4524.9 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:53:07 INFO - 2015-11-23 04:53:07,123 DEBUG : BROWSER_OUTPUT: 04:53:07 INFO - 2015-11-23 04:53:07,717 INFO : Browser exited with error code: 0 04:53:07 INFO - 2015-11-23 04:53:07,734 INFO : Completed test v8_7 (00:00:38) 04:53:08 INFO - 2015-11-23 04:53:08,133 INFO : Completed test suite (00:20:07) 04:53:08 INFO - 2015-11-23 04:53:08,133 DEBUG : Working with test: dromaeo_css 04:53:08 INFO - 2015-11-23 04:53:08,133 DEBUG : Generating results file: dromaeo_css 04:53:08 INFO - 2015-11-23 04:53:08,134 DEBUG : Working with test: kraken 04:53:08 INFO - 2015-11-23 04:53:08,134 DEBUG : Generating results file: kraken 04:53:08 INFO - 2015-11-23 04:53:08,134 INFO : javascript benchmark 04:53:08 INFO - 2015-11-23 04:53:08,134 DEBUG : Working with test: v8_7 04:53:08 INFO - 2015-11-23 04:53:08,135 DEBUG : Generating results file: v8_7 04:53:08 INFO - 2015-11-23 04:53:08,135 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:53:08 INFO - 2015-11-23 04:53:08,662 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 04:53:08 INFO - 2015-11-23 04:53:08,662 DEBUG : process_Request line: dromaeo_css 7569.90 graph.html#tests=[[72,1,61]] 04:53:08 INFO - 2015-11-23 04:53:08,662 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:53:08 INFO - 2015-11-23 04:53:08,688 DEBUG : process_Request line: kraken 1545.60 graph.html#tests=[[232,1,61]] 04:53:08 INFO - 2015-11-23 04:53:08,688 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:53:08 INFO - 2015-11-23 04:53:08,715 DEBUG : process_Request line: v8_7 22192.31 graph.html#tests=[[230,1,61]] 04:53:08 INFO - 2015-11-23 04:53:08,716 INFO : javascript benchmark 04:53:08 INFO - 2015-11-23 04:53:08,718 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3466.0468371197917, 3559.2525569630393, 3605.0266428064406, 3630.564332280126, 3631.092226943264, 5678.517326027282, 6021.307549631793, 6027.005544085227, 6034.939650603493, 6053.273607167141, 5869.295684517864, 5891.88216235675, 5923.792667256647, 6060.393960603927, 6100.206973093503, 5279.762410691509, 5300.893982120355, 5387.218853266274, 5489.4236105208975, 5494.395616482204, 4420.734755914639, 5465.754041068141, 5499.780008799643, 5510.6969116698565, 5582.7766889324375, 5257.7108259045735, 5266.578673706094, 5316.202569614569, 5420.295361602966, 5420.91868621971, 4460.7323560586465, 5385.353757549119, 5422.810201642963, 5436.592255580847, 5449.591280653927, 5204.713740744258, 5379.381371142291, 5384.946150538483, 5449.291592093042, 5467.6719396836315, 4984.800607975677, 5245.4754524547625, 5577.470140336662, 5841.328247251536, 6115.266168059861, 6395.552311338208, 6400.39196276353, 6403.199600049994, 6412.166418365629, 6427.196600424947, 6232.844178895519, 6320.74717011319, 6413.7434502619835, 6445.774397896051, 6478.222613286436, 6054.0, 6098.72555734993, 6151.446369826737, 6154.72303746337, 6155.353687862755, 6543.378379053982, 6561.376669216417, 6624.072629831828, 6634.104395906587, 6644.468442524587, 6108.615274519966, 6255.343188965184, 6312.873742525216, 6376.808695739135, 6412.61524308543, 5676.637606974296, 6374.203224596926, 6379.481748287791, 6469.126667899774, 6491.415772580491, 6384.393482619236, 6396.360363963567, 6402.327755585689, 6405.903911441332, 6422.133012043408, 6205.03821907596, 6233.693533392583, 6347.96826015867, 6392.4246817786625, 6400.743970241231, 5118.309028281209, 5135.486451354835, 5136.486351364908, 5139.871503212375, 5161.380634323905, 4643.512431194744, 4649.116667833101, 4660.231061874821, 4666.719996800203, 4705.223638099676, 5841.532677385884, 5870.882582348329, 6014.669193194329, 6115.088229002436, 6136.846578835565, 6441.1626488556185, 6501.739930402731, 6515.087887695727, 6517.706703198272, 6541.0, 5869.0, 6158.661273629993, 6174.44430001302, 6181.0, 6184.536159788034, 5449.536789372948, 5535.059039963136, 5609.214709940612, 5624.803131890364, 5673.234113394721, 6410.61536307823, 6428.228612566335, 6430.678466076771, 6437.774677886251, 6449.0004049373365, 6204.286507051746, 6423.42189202974, 6436.227652681709, 6512.641804700787, 6520.771772987922, 6272.40412160844, 6338.714757835816, 6378.0, 6391.712372943136, 6402.807915762534, 6366.172397588469, 6402.263739669997, 6429.38920802523, 6429.58207716497, 6431.549791514549, 5629.240052593012, 6210.472109870531, 6361.840953976188, 6485.416312531895, 6506.284308726131, 6370.90443643355, 6379.87240255183, 6382.744690212339, 6384.744610215539, 6394.104825324365, 6355.3326900674765, 6372.235331760218, 6392.169018027626, 6405.231372235362, 6408.871822563616, 5932.525397968066, 6105.550726437353, 6121.510279177566, 6247.437730604086, 6316.178896743394, 6343.714532846126, 6347.9843225085615, 6360.77737279193, 6363.5863668861375, 6379.872402552016, 6302.747890084529, 6346.777862774781, 6367.80896573085, 6422.550421470452, 6523.412892839668], "unit": "ms", "name": "dojo.html", "value": 5898.892665323442}, {"lowerIsBetter": false, "replicates": [522.4618642797919, 563.6054761666834, 571.2459553389526, 577.3014652270754, 588.417466707959, 40689.79655101724, 41304.79347603258, 41525.584744152584, 41547.58452415475, 41641.791791041076, 43930.780346098225, 44213.557864421346, 44453.0, 44540.109197816026, 44582.33126503097, 9914.801703965899, 10075.345102568346, 10083.0, 10110.191184705205, 10118.696439106838, 9860.506974651275, 9943.353682010646, 9959.103680668739, 9974.152197063222, 9990.850137247948, 9872.70381888541, 9951.402915825038, 9955.10404063634, 9956.452395118265, 9956.701298961043, 9943.95028024859, 10012.94993525035, 10014.198864090891, 10020.64927727526, 10033.849492257623, 9760.17038551724, 9886.80226395468, 9906.455144967023, 9931.453770042644, 9933.453660048694, 40788.0, 40900.181996359905, 41048.79475602633, 41229.79385103085, 41303.38044929328, 2824.308044529083, 3242.8864989725485, 3304.6695330467, 3404.557407537029, 3495.8114241157873, 28464.003759868512, 29309.0, 29396.0, 29756.404871902658, 30082.37264950482, 2440.548498527778, 2744.986275068632, 2815.127310533741, 2870.8277503349864, 2979.478591246523, 471766.0, 472608.0, 474026.0, 474384.0, 475715.0, 56263.71868140633, 58024.70987645119, 59696.0, 64221.03668444977, 70346.0, 66412.0, 66850.0, 66980.33019669839, 67053.99419008719, 67125.66437167783, 16593.83406165947, 16633.417830376122, 16737.581560461087, 16791.2443940023, 16845.747313790303, 12769.553065642844, 12770.744585108247, 12785.61643150707, 12786.936065319614, 12855.935720321339, 19574.902125489567, 19620.607587848164, 19658.017099144985, 19787.802121978882, 20102.99485025743, 9406.294527910297, 9548.949615542424, 9556.378835375679, 9605.711828645151, 9614.90385096154, 944.3578366710566, 960.7742180587557, 968.6367612145445, 985.7338518599938, 1134.3647557367901, 28511.28721781972, 28704.003345664147, 29164.85417572941, 29600.259993500335, 29919.85040074786, 1010.7169992402139, 1012.4886932099242, 1084.4902895639036, 1088.9509972051276, 1129.0741591894569, 14407.0, 14492.710145797026, 14619.707605847823, 14706.55880323592, 15925.203739813194, 449398.0, 457344.0, 458981.0, 459098.0, 459656.0, 48253.5174648249, 57914.420855791745, 57920.0, 57956.0, 57998.0, 1257.8239046533492, 1320.0, 1440.107133577189, 1441.351391873682, 1455.9199244041467, 27589.482578458377, 28667.0, 30007.249818754706, 30377.392452151274, 30891.845540772152, 40996.0, 51820.0, 52140.478595213564, 52200.47799521956, 54234.0, 460185.6990715025, 514788.0, 517790.0, 518087.0, 520829.0, 31076.378472429973, 33195.66804331926, 33767.0, 34105.65894341025, 34126.31747365089, 43242.783786080865, 43293.3505997404, 43414.56585434231, 43543.34684979791, 44113.0, 36399.63600363962, 36435.81782091073, 36959.44560831536, 36997.26005479929, 38113.80943095267, 28830.423391531633, 36431.27137457289, 37367.0, 37604.0, 38023.429648555844, 35898.923032309074, 36258.27483450369, 37124.0, 37966.81016594899, 38011.42982855315, 26151.869240653676, 30107.0, 31821.5226771594, 32967.05494175893, 43815.0, 32203.677963221005, 32276.0, 32691.55323364828, 33099.66900330966, 34598.481022785185], "unit": "ms", "name": "ext.html", "value": 20102.107309447387}, {"lowerIsBetter": false, "replicates": [366.91194113412774, 369.6783798095656, 372.1886287892394, 373.8205661282584, 375.16712897367853, 16131.758023629654, 19384.51538711533, 20953.580928381423, 21082.36752897412, 21098.94505274736, 20142.798572014275, 21175.682364764503, 21483.892580537115, 21538.707677539358, 21638.809865457395, 5620.213170156181, 5682.460166284196, 5749.482546570808, 5814.534837213034, 5818.563607729416, 5724.0, 5734.598578099534, 5742.54059675225, 5775.249217601706, 5777.277840269966, 3755.3991361382186, 3869.729118961674, 5248.973755131219, 5348.743045384332, 5729.169270455782, 5521.503064724174, 5627.296587926509, 5643.548516118701, 5660.886782264352, 5674.886502269973, 4994.325766021577, 5229.294045303874, 5416.377116631598, 5449.536789372908, 5501.724913754337, 12438.0, 12712.491500339975, 12712.745745085047, 15345.0, 19058.904705476383, 1956.8043195680461, 2046.996971483977, 2182.4652960024737, 2211.7898799614013, 2302.7466978632337, 9353.579088941015, 9522.809543809086, 9651.793525809273, 9863.50682465881, 9940.652077177336, 1590.1731099828141, 1664.858487028604, 1748.3880641775404, 1749.8775085744003, 1779.3950056980689, 101893.49053254686, 107493.0, 108019.0, 109224.0, 109852.45073774659, 10997.560097596006, 11073.446327683583, 11134.27627204229, 11185.888141118647, 11231.887681123084, 13061.804072938914, 13076.150050246704, 13093.279869607262, 13101.296831412046, 13204.339783010812, 8309.916900830915, 8534.914650853536, 8592.011918629438, 8636.006859211146, 8661.783455413664, 8795.604197811113, 8824.779380515538, 8869.0, 8886.822263554823, 8901.332400070021, 4368.257396242647, 4369.759663218553, 4379.233634114017, 4382.846600368972, 4388.583084607021, 1869.3924474545554, 1883.3690713611093, 1910.9331173408864, 1937.2251099560008, 1937.8159074887863, 399.26535175277627, 401.95176578810145, 925.9398139120935, 948.558920102142, 995.5221493683073, 11068.501917413574, 11336.6032188873, 11722.824157637642, 11954.342511161796, 11962.76074478523, 435.9542248063971, 443.5232125465138, 450.09980039920157, 453.3403897329378, 461.7414248021119, 5994.670293133832, 6008.549358798107, 6103.969480152659, 6160.414760597736, 6163.630182189083, 771013.0, 802924.0, 803402.0, 803944.0, 816465.0, 105291.94708052975, 105961.47019265009, 111332.44333778441, 115775.42112289385, 117264.0, 479.41990191867535, 479.63547703744706, 483.842751105892, 484.5808375754947, 485.2430208874168, 8589.484630922165, 10882.857299983387, 10937.781244375226, 11035.95158459945, 11088.445577721242, 49181.0, 50060.49939500559, 50186.74906625444, 50580.747096264284, 50646.493535064175, 71885.6405717968, 72753.0, 73448.0, 73660.26339736534, 76281.0, 9823.901760982299, 9892.802143957224, 10041.698749037541, 10068.496575171359, 10108.54511546997, 19259.711104333728, 19337.613247735248, 20165.59668806645, 20189.0, 20313.898430508343, 16089.436869709503, 16222.918885405497, 16615.0, 16631.417900373428, 16998.0, 13857.237851918242, 15935.12356820386, 16009.0, 16135.596610084842, 16267.26797294101, 15674.608134796264, 15830.49610287021, 16336.346546138022, 16352.918235408746, 17141.914290428966, 8664.696735614223, 9816.116549510578, 9875.506224688881, 10003.34978226413, 10207.438590877573, 15297.770533441784, 15808.288627012042, 15881.602959926095, 16073.276702548646, 16402.015879047296], "unit": "ms", "name": "jquery.html", "value": 8952.446173626919}, {"lowerIsBetter": false, "replicates": [1482.8146481689796, 1528.1136940574468, 1887.5752955584987, 1900.8954507502085, 1935.1388632058731, 6356.904646430307, 7726.961365193166, 8434.945631796025, 8688.956555217223, 8814.162654547808, 8283.378746593999, 8385.790355241106, 8434.831303373929, 8490.150984901507, 8512.106228845974, 2038.4598081508411, 2376.3583832365252, 2385.3082606044227, 2404.495056038234, 2408.771166739157, 2397.652340410639, 2428.86641234732, 2432.6107822748363, 2451.019592163131, 2500.062476571286, 2369.2536850892, 2389.0921449849034, 2399.5440866235444, 2407.205622144697, 2419.4314336130997, 2356.340224737059, 2367.07684003238, 2380.059876348841, 2395.2574701842395, 2412.4692567635093, 2339.87130707811, 2375.4536456615074, 2375.964360534593, 2383.416063064543, 2404.987975060131, 8541.572921353907, 8608.268297194745, 8624.56877156146, 8635.790989261508, 8648.65405383784, 4557.680962332638, 5184.896302073975, 5252.3171987641745, 5262.631615786897, 5276.5251127398715, 2905.4915389806697, 3189.1708155879637, 3505.8597656093725, 3543.3799085160254, 3583.33708263972, 1052.9894701052967, 1061.2889364126054, 1073.9570417183304, 1089.967300980972, 1090.5419723716059, 10755.03204711572, 10782.299150555189, 10791.02880740737, 10855.891441085647, 10866.130709543218, 4092.263392589303, 4731.313959475857, 4817.325574419584, 4825.396825396825, 4864.951350486521, 9693.660721874701, 9735.561899714388, 9768.706938791847, 9796.461194634221, 9816.65641702537, 5212.921806172911, 5257.658252213594, 5263.131583288715, 5295.0, 5301.125314323093, 4722.763861806896, 4732.621390288768, 4748.074125545554, 4772.976135119302, 4789.137955168103, 3931.803409829497, 3935.2916475034194, 3937.586553411908, 3940.645341919241, 3981.6217459341315, 1299.7920332746714, 1311.2132720367704, 1311.6196303072002, 1312.2913626641507, 1316.585275638171, 1366.9658258543418, 1372.945082196701, 1389.673426744714, 1394.9930250348887, 1417.2630232279157, 7999.440039197317, 8050.476719013245, 8082.83834323322, 8113.269805717514, 8118.959405202936, 520.1703283263189, 520.3417676639054, 524.6589716684185, 524.8477941397028, 526.8814516733704, 6027.389106853215, 6081.483073938676, 6169.722362493699, 6318.8420289492215, 6319.494440444753, 9302.53487325631, 9390.67132650354, 9867.555959981675, 10093.142082922886, 10243.590256389662, 9920.15678667307, 10032.849507257397, 10084.092431681183, 10156.593736250616, 10239.18086553074, 8034.236747508978, 8093.35253179756, 8097.473664211808, 8099.514029158269, 8167.591620419074, 7607.847843043219, 7650.65572049248, 7665.080190377191, 7686.692532298645, 7717.459777815499, 8899.688510902088, 9097.272218222659, 9124.361294709306, 9183.403078799856, 9207.033261507713, 9303.581338839633, 9424.905750942402, 9447.385919915183, 9450.385724927857, 9477.573509191965, 6575.96712016456, 6796.184457865088, 7317.0, 7383.07711536058, 7386.741464048732, 7874.763757087297, 8112.553809540532, 8119.634616442392, 8130.593470326578, 8139.4709343892455, 7523.774286771406, 7573.697052117854, 7612.276833700789, 7681.231876812498, 7740.3420709240345, 7465.552066876005, 7488.775336739906, 7563.9621801890635, 7573.772786816405, 7624.428167887319, 6309.432151106423, 7560.848783024198, 7595.848083038198, 7608.885866711893, 7625.1231108421025, 6924.065251191025, 6955.443564514725, 6956.617386043614, 6968.965155174192, 6986.6157361343585, 6990.510664253454, 7042.401395881408, 7113.430925526049, 7124.145102587722, 7136.4290856730295], "unit": "ms", "name": "mootools.html", "value": 4736.778079354379}, {"lowerIsBetter": false, "replicates": [294.25553350024444, 325.9755518336125, 329.88454041085606, 337.3354491651447, 337.9831008449577, 6806.11520502334, 6928.237893831674, 6967.233604303523, 6972.0, 7025.227225005252, 5987.940120598792, 6900.551464154839, 6919.2734762849805, 6943.270956549565, 6977.1278590176225, 4167.520735115455, 4423.1153769246275, 5150.4334523202415, 5152.252923326116, 5168.173092305213, 4969.602431805447, 5033.647644664875, 5155.690658560498, 5171.689698618076, 5173.6119791015635, 4137.27597670408, 4188.2251783420015, 4923.507649235065, 5116.8742876567285, 5143.09995750744, 5064.632549211729, 5095.719735414551, 5104.081265372231, 5113.667611605271, 5135.460776618439, 4160.105577300895, 4231.132617813341, 4253.340732186516, 4367.170237654836, 4382.715123516961, 6586.110875031905, 6636.701348439332, 6651.93348066518, 6674.599524028526, 6692.0, 6001.579889407743, 6028.306744724369, 6034.2155519782145, 6042.516598672096, 6070.848228794272, 6579.539432239745, 7059.964700176518, 7228.674709638079, 7485.737999170003, 7532.17146113927, 4486.618637415823, 4894.070126675921, 4899.436564795059, 4907.509249075099, 4908.214685650314, 7903.407244456631, 7912.920870791276, 7920.80197995049, 7934.682612695486, 7968.880466793003, 4631.189541830234, 4757.215059515142, 4968.8757781055765, 4971.726555039508, 4977.203647416396, 4860.149473842063, 4897.975510122426, 4915.361003069578, 4920.72935988524, 4928.0, 5867.178594996704, 5897.43717914753, 5901.852453688693, 5906.26171728534, 5908.291005079332, 7245.275472452712, 7511.737089201852, 7522.699092036257, 7528.322450979329, 7536.0, 1686.1822016322074, 1702.7360759082362, 1703.897766134036, 1705.6588682263598, 1709.2308461192513, 906.4470672889532, 1077.138289368502, 1078.245228340165, 1087.771567970735, 1089.6022951622758, 6932.792016239521, 6966.5471744336455, 6970.546914450544, 7003.614801185881, 7004.4046256068805, 7787.377009839312, 7806.297433231037, 7830.33442157423, 7835.2948234658015, 7844.019497562805, 6771.864562708718, 6967.641309944512, 6970.198427180838, 6972.1981972072845, 7018.9298107019295, 4007.6593489553134, 4088.1823635273063, 4100.507939047334, 4109.321961876317, 4142.855000074983, 6549.312322206099, 7586.861970704438, 7830.647620857075, 7854.3716502679645, 7873.724419645399, 7032.296770322927, 7929.5242285463055, 8104.230098140667, 8108.716194933149, 8119.959400202961, 6235.719392627343, 6621.841177793867, 7546.396288296923, 7850.842983140419, 7883.975083239142, 7598.822182561712, 7813.960930195312, 7814.062312522534, 7816.374690024671, 7828.0, 6472.805815825533, 7367.2318643524095, 7684.077910650758, 7698.2686644768655, 7738.7678369649, 7152.284771522806, 7442.957985882089, 7854.803629909069, 7863.882041769492, 7883.251091146332, 4755.643326750576, 4809.9038019240115, 4820.758962051954, 4836.177849765478, 4849.612031037579, 7553.622318883924, 7768.88346674789, 7787.415943804351, 7799.922000780147, 7824.374050076094, 6265.27949285838, 7479.177290497932, 7489.400847932261, 7493.850122997618, 7502.849943001219, 6751.49363797727, 7335.889961650473, 7462.96268518654, 7514.173440921603, 7529.623518824146, 7249.238829922782, 7313.670884810303, 7336.559806411632, 7337.486375953632, 7360.0, 7452.105747310357, 7478.850422991619, 7484.43866709988, 7488.251174882468, 7492.7752167435065, 7094.964525177341, 7314.817129571803, 7320.377767889789, 7330.853382932418, 7344.0], "unit": "ms", "name": "prototype.html", "value": 5363.375723112288}, {"lowerIsBetter": false, "replicates": [746.5073051785822, 807.5760225881415, 820.0528389709885, 828.8881001064855, 847.5889193741034, 14945.327460264287, 15051.92474037631, 15203.923980380096, 15260.618484537878, 15265.694686106272, 12523.874761252384, 13656.726865462684, 13882.236476993761, 13979.650508737286, 14257.0, 936.9156775890168, 951.0251991708485, 964.6334392930677, 969.8690676758653, 971.116284181395, 930.4138392812519, 942.4769253064546, 954.6610953111649, 957.2198658093666, 959.8608201810733, 983.7540614846289, 990.7077412163429, 997.4563862694813, 997.6109317366233, 1007.9244056695741, 979.6620166042704, 985.5023213277249, 987.1411871671655, 998.8202123617746, 1001.019001378653, 737.3363972424806, 741.8775901976168, 748.135903031999, 751.9360854327389, 752.8870669399579, 13300.800487992688, 13336.19982801035, 13452.529161479399, 13470.797938030937, 13504.932475337659, 10971.23201375904, 11078.556857725682, 11204.943975280072, 11471.713207169887, 11729.003034742058, 9558.139767420897, 9653.71038868835, 9811.067948544876, 10173.643922462752, 10267.127294180003, 3410.437277849152, 3549.2546565221332, 3555.1112221944513, 3555.875544355961, 3566.3937130687586, 66002.3399766001, 73768.6311568444, 78290.6085469569, 78642.0, 78687.0, 9692.176165026052, 9917.107460328605, 9954.20366370703, 10080.29437939352, 10648.946755266174, 19822.20711171566, 21180.78819211819, 22247.44381390478, 22909.0, 23582.70295133784, 7546.2831031051965, 7599.164091949881, 7644.694212231449, 7711.537307761552, 7885.5662938538935, 4088.468499095158, 4095.017195872969, 4122.670186385082, 4159.625633692982, 4164.1879833432795, 3357.690500704727, 3395.966040339614, 3642.1623026704005, 3667.706583473369, 3669.889903302905, 606.884691908536, 631.6810010944444, 640.3180612647516, 661.5237029338869, 662.8475450646282, 425.3152424596397, 444.5176982973445, 478.2443738892541, 534.318743601903, 542.0622323380574, 8538.615762290712, 8599.355048371397, 8722.651093956298, 8834.469931804113, 8925.464472131693, 528.3211073770264, 550.6778534557329, 582.9361415416881, 588.3057991569989, 629.4649547884353, 3841.250956063541, 4095.4675892133832, 4151.024509240327, 4198.517170525429, 4215.409842622035, 88713.0, 89804.0, 89978.55010724904, 90164.0, 90961.0, 79053.0, 82099.0, 82779.0, 83110.58444707858, 83494.58252708698, 70895.6455217731, 71517.49066348062, 71789.0, 73336.63331683307, 74719.62640186764, 8889.73330800077, 8970.506622135845, 8977.416467929565, 8998.370114091951, 9170.67902623405, 46569.0, 48161.5183848157, 52625.47374526359, 52783.680407990105, 53312.0, 68172.659136704, 71359.64320178366, 74026.0, 74902.0, 74946.5010699794, 9442.15020648145, 10547.89247129071, 10890.891091088988, 10922.235443518877, 11169.832452513056, 12166.939165304471, 12172.878271217174, 12473.5010599575, 12701.301428421526, 13325.800112998118, 11376.886231137914, 11507.367094809866, 11826.053915686896, 12193.878061219275, 12312.507499699912, 9793.804123917624, 10971.670849874517, 11682.94158529236, 11994.460249288977, 12290.139690221598, 11360.602378916697, 11654.650360489199, 11770.76458470843, 11912.0, 11919.582814601446, 9656.9034309656, 9704.514774261399, 9823.656172033945, 10125.341852779546, 10288.331258468175, 7652.693892244248, 8205.810157527007, 8553.74338769838, 9943.751406214902, 10208.897911021091], "unit": "ms", "name": "yui.html", "value": 6976.380106119888}], "name": "dromaeo_css", "value": 7569.896382302697}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 114.0, 125.0, 160.0, 176.0, 117.0, 113.0, 113.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 125.4}, {"lowerIsBetter": true, "replicates": [143.0, 134.0, 174.0, 182.0, 150.0, 141.0, 121.0, 158.0, 144.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [267.0, 276.0, 192.0, 221.0, 228.0, 273.0, 240.0, 203.0, 194.0, 199.0], "unit": "ms", "name": "audio-dft", "value": 229.3}, {"lowerIsBetter": true, "replicates": [59.0, 65.0, 70.0, 103.0, 58.0, 55.0, 58.0, 59.0, 108.0, 56.0], "unit": "ms", "name": "audio-fft", "value": 69.1}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 104.0, 76.0, 76.0, 79.0, 92.0, 101.0, 100.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 92.2}, {"lowerIsBetter": true, "replicates": [126.0, 88.0, 87.0, 93.0, 134.0, 86.0, 87.0, 86.0, 77.0, 132.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 99.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 94.0, 93.0, 94.0, 95.0, 95.0, 95.0, 98.0, 100.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.3}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 125.0, 149.0, 145.0, 98.0, 94.0, 92.0, 99.0, 93.0], "unit": "ms", "name": "imaging-desaturate", "value": 108.0}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 59.0, 58.0, 58.0, 59.0, 77.0, 91.0, 85.0, 83.0], "unit": "ms", "name": "json-parse-financial", "value": 68.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 68.0, 66.0, 67.0, 67.0, 97.0, 100.0, 94.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 75.8}, {"lowerIsBetter": true, "replicates": [84.0, 89.0, 120.0, 111.0, 107.0, 85.0, 83.0, 105.0, 74.0, 102.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 96.0}, {"lowerIsBetter": true, "replicates": [131.0, 133.0, 151.0, 122.0, 126.0, 138.0, 127.0, 118.0, 127.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.5}, {"lowerIsBetter": true, "replicates": [140.0, 140.0, 162.0, 136.0, 161.0, 139.0, 141.0, 139.0, 139.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 66.0, 69.0, 65.0, 67.0, 66.0, 67.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1545.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [144.59224985540774], "unit": "score", "name": "Richards", "value": 244.14863200000002}, {"lowerIsBetter": false, "replicates": [157.38117721120554], "unit": "score", "name": "DeltaBlue", "value": 420.1137720000001}, {"lowerIsBetter": false, "replicates": [274.8763056624519], "unit": "score", "name": "Encrypt", "value": 968.3664779999996}, {"lowerIsBetter": false, "replicates": [4758.293838862559], "unit": "score", "name": "Decrypt", "value": 55.94042928286857}, {"lowerIsBetter": false, "replicates": [948.7666034155598], "unit": "score", "name": "RayTrace", "value": 779.9484060000001}, {"lowerIsBetter": false, "replicates": [736.9196757553427], "unit": "score", "name": "Earley", "value": 904.3902909999999}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [27621.62162162162], "unit": "score", "name": "RegExp", "value": 32.980865949119355}, {"lowerIsBetter": false, "replicates": [661.8133686300463], "unit": "score", "name": "Splay", "value": 123.13290100000003}, {"lowerIsBetter": false, "replicates": [4524.886877828054], "unit": "score", "name": "NavierStokes", "value": 327.9640000000003}], "name": "v8_7", "value": 22192.305770876126}]} 04:53:08 INFO - RETURN: dromaeo_css: 7569.90 04:53:08 INFO - RETURN: kraken: 1545.60 04:53:08 INFO - RETURN: v8_7: 22192.31 04:53:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "22192.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1545.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7569.90"}}} 04:53:08 INFO - Return code: 0 04:53:08 INFO - # TBPL SUCCESS # 04:53:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:08 INFO - 2015-11-23 04:53:08.821 screenresolution[1688:11460] starting screenresolution argv=screenresolution get 04:53:08 INFO - 2015-11-23 04:53:08.824 screenresolution[1688:11460] Display 0: 1600x1200x32@60 04:53:08 INFO - 2015-11-23 04:53:08.830 screenresolution[1689:11463] starting screenresolution argv=screenresolution list 04:53:08 INFO - Available Modes on Display 0 04:53:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:09 INFO - Intel Iris: 04:53:09 INFO - Chipset Model: Intel Iris 04:53:09 INFO - Type: GPU 04:53:09 INFO - Bus: Built-In 04:53:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:09 INFO - Vendor: Intel (0x8086) 04:53:09 INFO - Device ID: 0x0a2e 04:53:09 INFO - Revision ID: 0x0009 04:53:09 INFO - Displays: 04:53:09 INFO - Display: 04:53:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:09 INFO - Display Serial Number: 1600x1200 60 04:53:09 INFO - Main Display: Yes 04:53:09 INFO - Mirror: Off 04:53:09 INFO - Online: Yes 04:53:09 INFO - Rotation: Supported 04:53:09 INFO - Return code: 0 04:53:09 INFO - Running post-action listener: _resource_record_post_action 04:53:09 INFO - Running post-run listener: _resource_record_post_run 04:53:10 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 34528768; Write bytes: 697052672; Read time: 359; Write time: 2320 04:53:10 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 338313728; Write bytes: 336644096; Read time: 26151; Write time: 664 04:53:10 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 32591360; Write bytes: 349189632; Read time: 338; Write time: 1619 04:53:10 INFO - Running post-run listener: _upload_blobber_files 04:53:10 INFO - Blob upload gear active. 04:53:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:53:10 INFO - Copying logs to upload dir... 04:53:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1292.519885 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-11-23 04:53:10.208457) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:53:10.215998) ========= 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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009521 build_url: 'https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:53:10.246621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:53:10.247075) ========= 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.z5Qbi9RZk6/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.W1REqM1dV1/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005001 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:53:10.302717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:53:10.303087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:53:10.303553) ========= ========= Total master_lag: 0.29 =========