builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0080 starttime: 1447641955.71 results: success (0) buildid: 20151115175333 builduid: a1f2dc32f05442bfab6da609df79d9f8 revision: 4b04af1dc5f5a99e44905777c2117424d819c3a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:55.713014) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:55.713502) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:55.713846) ========= 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.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006032 basedir: '/builds/slave/test' ========= master_lag: 0.32 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.042417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.042808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.082518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.082999) ========= 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.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.033354 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.133765) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.134071) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.134467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.134791) ========= 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.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-15 18:45:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25, :: Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-15 18:45:56 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.374765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.524845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.525131) ========= 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.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.054291 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.604130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:56.604533) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4b04af1dc5f5a99e44905777c2117424d819c3a0 --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 4b04af1dc5f5a99e44905777c2117424d819c3a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-15 18:45:56,758 truncating revision to first 12 chars 2015-11-15 18:45:56,758 Setting DEBUG logging. 2015-11-15 18:45:56,758 attempt 1/10 2015-11-15 18:45:56,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4b04af1dc5f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 18:45:57,017 unpacking tar archive at: mozilla-central-4b04af1dc5f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:57.204359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:57.207706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:57.221019) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:57.221359) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 18:45:57.221821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-11-15 18:45:57.222134) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 18:45:57 INFO - MultiFileLogger online at 20151115 18:45:57 in /builds/slave/test 18:45:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 18:45:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:45:57 INFO - {'append_to_log': False, 18:45:57 INFO - 'base_work_dir': '/builds/slave/test', 18:45:57 INFO - 'blob_upload_branch': 'Firefox', 18:45:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:45:57 INFO - 'branch': 'Firefox', 18:45:57 INFO - 'buildbot_json_path': 'buildprops.json', 18:45:57 INFO - 'config_files': ('talos/mac_config.py',), 18:45:57 INFO - 'default_actions': ('clobber', 18:45:57 INFO - 'read-buildbot-config', 18:45:57 INFO - 'download-and-extract', 18:45:57 INFO - 'populate-webroot', 18:45:57 INFO - 'create-virtualenv', 18:45:57 INFO - 'install', 18:45:57 INFO - 'run-tests'), 18:45:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:45:57 INFO - 'download_minidump_stackwalk': True, 18:45:57 INFO - 'download_symbols': 'ondemand', 18:45:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:45:57 INFO - 'tooltool.py': '/tools/tooltool.py', 18:45:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:45:57 INFO - '/tools/misc-python/virtualenv.py')}, 18:45:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:45:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:45:57 INFO - 'installer_path': 'installer.exe', 18:45:57 INFO - 'log_level': 'info', 18:45:57 INFO - 'log_name': 'talos', 18:45:57 INFO - 'log_to_console': True, 18:45:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:45:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:45:57 INFO - 'opt_config_files': (), 18:45:57 INFO - 'pip_index': False, 18:45:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:45:57 INFO - 'cmd': ('bash', 18:45:57 INFO - '-c', 18:45:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:45:57 INFO - 'enabled': True, 18:45:57 INFO - 'halt_on_failure': False, 18:45:57 INFO - 'name': 'check_screen_resolution'},), 18:45:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:45:57 INFO - 'cmd': ('bash', 18:45:57 INFO - '-c', 18:45:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:45:57 INFO - 'enabled': True, 18:45:57 INFO - 'halt_on_failure': False, 18:45:57 INFO - 'name': 'check_screen_resolution'},), 18:45:57 INFO - 'run_cmd_checks_enabled': True, 18:45:57 INFO - 'sps_profile': False, 18:45:57 INFO - 'sps_profile_interval': 0, 18:45:57 INFO - 'suite': 'dromaeojs', 18:45:57 INFO - 'system_bits': '64', 18:45:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:45:57 INFO - 'title': 't-yosemite-r5-0080', 18:45:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:45:57 INFO - 'use_talos_json': True, 18:45:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:45:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:45:57 INFO - 'work_dir': 'build'} 18:45:57 INFO - ##### 18:45:57 INFO - ##### Running clobber step. 18:45:57 INFO - ##### 18:45:57 INFO - Running pre-action listener: _resource_record_pre_action 18:45:57 INFO - Running main action method: clobber 18:45:57 INFO - rmtree: /builds/slave/test/build 18:45:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:46:01 INFO - Running post-action listener: _resource_record_post_action 18:46:01 INFO - ##### 18:46:01 INFO - ##### Running read-buildbot-config step. 18:46:01 INFO - ##### 18:46:01 INFO - Running pre-action listener: _resource_record_pre_action 18:46:01 INFO - Running main action method: read_buildbot_config 18:46:01 INFO - Using buildbot properties: 18:46:01 INFO - { 18:46:01 INFO - "properties": { 18:46:01 INFO - "buildnumber": 559, 18:46:01 INFO - "product": "firefox", 18:46:01 INFO - "script_repo_revision": "production", 18:46:01 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 18:46:01 INFO - "repository": "", 18:46:01 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 18:46:01 INFO - "buildid": "20151115175333", 18:46:01 INFO - "slavename": "t-yosemite-r5-0080", 18:46:01 INFO - "pgo_build": "False", 18:46:01 INFO - "basedir": "/builds/slave/test", 18:46:01 INFO - "project": "", 18:46:01 INFO - "platform": "yosemite", 18:46:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:46:01 INFO - "slavebuilddir": "test", 18:46:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:46:01 INFO - "branch": "mozilla-central", 18:46:01 INFO - "repo_path": "mozilla-central", 18:46:01 INFO - "stage_platform": "macosx64", 18:46:01 INFO - "builduid": "a1f2dc32f05442bfab6da609df79d9f8", 18:46:01 INFO - "revision": "4b04af1dc5f5a99e44905777c2117424d819c3a0" 18:46:01 INFO - }, 18:46:01 INFO - "sourcestamp": { 18:46:01 INFO - "repository": "", 18:46:01 INFO - "hasPatch": false, 18:46:01 INFO - "project": "", 18:46:01 INFO - "branch": "mozilla-central-macosx64-talos", 18:46:01 INFO - "changes": [ 18:46:01 INFO - { 18:46:01 INFO - "category": null, 18:46:01 INFO - "files": [ 18:46:01 INFO - { 18:46:01 INFO - "url": null, 18:46:01 INFO - "name": "https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:46:01 INFO - } 18:46:01 INFO - ], 18:46:01 INFO - "repository": "", 18:46:01 INFO - "rev": "4b04af1dc5f5a99e44905777c2117424d819c3a0", 18:46:01 INFO - "who": "philringnalda@gmail.com", 18:46:01 INFO - "when": 1447641869, 18:46:01 INFO - "number": 6664408, 18:46:01 INFO - "comments": "Bug 1223394 - skip failing webspeech tests on Mulet, a=relief", 18:46:01 INFO - "project": "", 18:46:01 INFO - "at": "Sun 15 Nov 2015 18:44:29", 18:46:01 INFO - "branch": "mozilla-central-macosx64-talos", 18:46:01 INFO - "revlink": "", 18:46:01 INFO - "properties": [ 18:46:01 INFO - [ 18:46:01 INFO - "buildid", 18:46:01 INFO - "20151115175333", 18:46:01 INFO - "Change" 18:46:01 INFO - ], 18:46:01 INFO - [ 18:46:01 INFO - "builduid", 18:46:01 INFO - "a1f2dc32f05442bfab6da609df79d9f8", 18:46:01 INFO - "Change" 18:46:01 INFO - ], 18:46:01 INFO - [ 18:46:01 INFO - "pgo_build", 18:46:01 INFO - "False", 18:46:01 INFO - "Change" 18:46:01 INFO - ] 18:46:01 INFO - ], 18:46:01 INFO - "revision": "4b04af1dc5f5a99e44905777c2117424d819c3a0" 18:46:01 INFO - } 18:46:01 INFO - ], 18:46:01 INFO - "revision": "4b04af1dc5f5a99e44905777c2117424d819c3a0" 18:46:01 INFO - } 18:46:01 INFO - } 18:46:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:46:01 INFO - Running post-action listener: _resource_record_post_action 18:46:01 INFO - ##### 18:46:01 INFO - ##### Running download-and-extract step. 18:46:01 INFO - ##### 18:46:01 INFO - Running pre-action listener: _resource_record_pre_action 18:46:01 INFO - Running main action method: download_and_extract 18:46:01 INFO - mkdir: /builds/slave/test/build/tests 18:46: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')]} 18:46:01 INFO - https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:46:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/test_packages.json 18:46:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/test_packages.json 18:46:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:46:03 INFO - Downloaded 1149 bytes. 18:46:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:46:03 INFO - Using the following test package requirements: 18:46:03 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:46:03 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:46:03 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:46:03 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:46:03 INFO - u'jsshell-mac.zip'], 18:46:03 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:46:03 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:46:03 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:46:03 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:46:03 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:46:03 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:46:03 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:46:03 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:46:03 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:46:03 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:46:03 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:46:03 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:46:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:46:03 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')]} 18:46:03 INFO - https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:46:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:46:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:46:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/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 18:46:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/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 18:46:06 INFO - Downloaded 17464049 bytes. 18:46:06 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 18:46:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:46:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:46:11 INFO - Return code: 0 18:46:11 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 18:46:11 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')]} 18:46:11 INFO - https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:46:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:46:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:46:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/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 18:46:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/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 18:46:13 INFO - Downloaded 17464049 bytes. 18:46:13 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 18:46:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:46:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:46:18 INFO - Return code: 0 18:46:18 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')]} 18:46:18 INFO - https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/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 18:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/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 18:46:20 INFO - Downloaded 11131693 bytes. 18:46:20 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 18:46:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:46:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:46:20 INFO - Return code: 0 18:46:20 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')]} 18:46:20 INFO - https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ps47_epGSXCNA2i6vu18hQ/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 18:46:24 INFO - Downloaded 108671564 bytes. 18:46:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:46:24 INFO - mkdir: /builds/slave/test/properties 18:46:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:46:24 INFO - Writing to file /builds/slave/test/properties/build_url 18:46:24 INFO - Contents: 18:46:24 INFO - build_url:https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:46:24 INFO - Running post-action listener: _resource_record_post_action 18:46:24 INFO - Running post-action listener: set_extra_try_arguments 18:46:24 INFO - ##### 18:46:24 INFO - ##### Running populate-webroot step. 18:46:24 INFO - ##### 18:46:24 INFO - Running pre-action listener: _resource_record_pre_action 18:46:24 INFO - Running main action method: populate_webroot 18:46:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:24 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:46:24 INFO - '../fennec_ids.txt'], 18:46:24 INFO - 'tests': ['tcheck2']}, 18:46:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:24 INFO - '--tppagecycles', 18:46:24 INFO - '7'], 18:46:24 INFO - 'tests': ['tsvgm']}}, 18:46:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:46:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'tests': ['damp', 'tps']}, 18:46:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['damp', 'tps']}, 18:46:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:46:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:24 INFO - 'other': {'tests': ['a11yr', 18:46:24 INFO - 'ts_paint', 18:46:24 INFO - 'tpaint', 18:46:24 INFO - 'sessionrestore', 18:46:24 INFO - 'sessionrestore_no_auto_restore']}, 18:46:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['a11yr', 18:46:24 INFO - 'ts_paint', 18:46:24 INFO - 'tpaint', 18:46:24 INFO - 'sessionrestore', 18:46:24 INFO - 'sessionrestore_no_auto_restore']}, 18:46:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['a11yr', 18:46:24 INFO - 'ts_paint', 18:46:24 INFO - 'tpaint', 18:46:24 INFO - 'sessionrestore', 18:46:24 INFO - 'sessionrestore_no_auto_restore']}, 18:46:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['a11yr', 18:46:24 INFO - 'ts_paint', 18:46:24 INFO - 'tpaint', 18:46:24 INFO - 'sessionrestore', 18:46:24 INFO - 'sessionrestore_no_auto_restore']}, 18:46:24 INFO - 'other_l64': {'tests': ['a11yr', 18:46:24 INFO - 'ts_paint', 18:46:24 INFO - 'tpaint', 18:46:24 INFO - 'sessionrestore', 18:46:24 INFO - 'sessionrestore_no_auto_restore']}, 18:46:24 INFO - 'other_nol64': {'tests': ['a11yr', 18:46:24 INFO - 'ts_paint', 18:46:24 INFO - 'tpaint', 18:46:24 INFO - 'sessionrestore', 18:46:24 INFO - 'sessionrestore_no_auto_restore']}, 18:46:24 INFO - 'svgr': {'tests': ['tsvgx', 18:46:24 INFO - 'tsvgr_opacity', 18:46:24 INFO - 'tart', 18:46:24 INFO - 'tscrollx', 18:46:24 INFO - 'cart']}, 18:46:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['tsvgx', 18:46:24 INFO - 'tsvgr_opacity', 18:46:24 INFO - 'tart', 18:46:24 INFO - 'tscrollx', 18:46:24 INFO - 'cart']}, 18:46:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'tests': ['tp5o']}, 18:46:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'talos_options': ['--e10s'], 18:46:24 INFO - 'tests': ['tp5o']}, 18:46:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'talos_options': ['--xperf_path', 18:46:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:24 INFO - 'tests': ['tp5n']}, 18:46:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:24 INFO - 'talos_options': ['--e10s', 18:46:24 INFO - '--xperf_path', 18:46:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:24 INFO - 'tests': ['tp5n']}}, 18:46:24 INFO - 'talos.zip': {'path': '', 18:46:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:24 INFO - Running post-action listener: _resource_record_post_action 18:46:24 INFO - ##### 18:46:24 INFO - ##### Running create-virtualenv step. 18:46:24 INFO - ##### 18:46:24 INFO - Running pre-action listener: _resource_record_pre_action 18:46:24 INFO - Running main action method: create_virtualenv 18:46:24 INFO - Creating virtualenv /builds/slave/test/build/venv 18:46:24 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 18:46:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:46:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:24 INFO - Using real prefix '/tools/python27' 18:46:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:46:25 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:29 INFO - Installing pip.................done. 18:46:29 INFO - Return code: 0 18:46:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:46: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')]} 18:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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', '--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 0x10c547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c524228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8ac8b0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:46:29 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 18:46:29 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 18:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:29 INFO - 'HOME': '/Users/cltbld', 18:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:29 INFO - 'LOGNAME': 'cltbld', 18:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:29 INFO - 'MOZ_NO_REMOTE': '1', 18:46:29 INFO - 'NO_EM_RESTART': '1', 18:46:29 INFO - 'PAGER': '/bin/cat', 18:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:29 INFO - 'PWD': '/builds/slave/test', 18:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:29 INFO - 'SHELL': '/bin/bash', 18:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:46:29 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:29 INFO - 'USER': 'cltbld', 18:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:29 INFO - 'XPC_FLAGS': '0x0', 18:46:29 INFO - 'XPC_SERVICE_NAME': '0', 18:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:29 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 18:46:29 INFO - Cleaning up... 18:46:29 INFO - Return code: 0 18:46:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:46: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')]} 18:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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', '--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 0x10c547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c524228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8ac8b0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:46:29 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 18:46:29 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 18:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:29 INFO - 'HOME': '/Users/cltbld', 18:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:29 INFO - 'LOGNAME': 'cltbld', 18:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:29 INFO - 'MOZ_NO_REMOTE': '1', 18:46:29 INFO - 'NO_EM_RESTART': '1', 18:46:29 INFO - 'PAGER': '/bin/cat', 18:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:29 INFO - 'PWD': '/builds/slave/test', 18:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:29 INFO - 'SHELL': '/bin/bash', 18:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:46:29 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:29 INFO - 'USER': 'cltbld', 18:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:29 INFO - 'XPC_FLAGS': '0x0', 18:46:29 INFO - 'XPC_SERVICE_NAME': '0', 18:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:30 INFO - Downloading/unpacking psutil>=0.7.1 18:46:30 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 18:46:30 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 18:46:30 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 18:46:30 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 18:46:30 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 18:46:30 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 18:46:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:46:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:32 INFO - Installing collected packages: psutil 18:46:32 INFO - Running setup.py install for psutil 18:46:32 INFO - building 'psutil._psutil_osx' extension 18:46:32 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 18:46:34 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 18:46:34 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 18:46:35 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 18:46:35 INFO - building 'psutil._psutil_posix' extension 18:46:35 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 18:46:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:46:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:46:35 INFO - ^ 18:46:35 INFO - 1 warning generated. 18:46:35 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 18:46:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:35 INFO - Successfully installed psutil 18:46:35 INFO - Cleaning up... 18:46:35 INFO - Return code: 0 18:46:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10c547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c524228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8ac8b0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:46:35 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 18:46:35 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 18:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:35 INFO - 'HOME': '/Users/cltbld', 18:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:35 INFO - 'LOGNAME': 'cltbld', 18:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:35 INFO - 'MOZ_NO_REMOTE': '1', 18:46:35 INFO - 'NO_EM_RESTART': '1', 18:46:35 INFO - 'PAGER': '/bin/cat', 18:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:35 INFO - 'PWD': '/builds/slave/test', 18:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:35 INFO - 'SHELL': '/bin/bash', 18:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:46:35 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:35 INFO - 'USER': 'cltbld', 18:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:35 INFO - 'XPC_FLAGS': '0x0', 18:46:35 INFO - 'XPC_SERVICE_NAME': '0', 18:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:46:35 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 18:46:35 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 18:46:35 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 18:46:35 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 18:46:35 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 18:46:35 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 18:46:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:46:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:46:38 INFO - Installing collected packages: mozsystemmonitor 18:46:38 INFO - Running setup.py install for mozsystemmonitor 18:46:38 INFO - Successfully installed mozsystemmonitor 18:46:38 INFO - Cleaning up... 18:46:38 INFO - Return code: 0 18:46:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:38 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 0x10c547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c524228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8ac8b0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:46:38 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 18:46:38 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 18:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:38 INFO - 'HOME': '/Users/cltbld', 18:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:38 INFO - 'LOGNAME': 'cltbld', 18:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:38 INFO - 'MOZ_NO_REMOTE': '1', 18:46:38 INFO - 'NO_EM_RESTART': '1', 18:46:38 INFO - 'PAGER': '/bin/cat', 18:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:38 INFO - 'PWD': '/builds/slave/test', 18:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:38 INFO - 'SHELL': '/bin/bash', 18:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:46:38 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:38 INFO - 'USER': 'cltbld', 18:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:38 INFO - 'XPC_FLAGS': '0x0', 18:46:38 INFO - 'XPC_SERVICE_NAME': '0', 18:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:38 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:38 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 18:46:38 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 18:46:38 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 18:46:38 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 18:46:38 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 18:46:38 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 18:46:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:46:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:46:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:46:41 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 18:46:41 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 18:46:41 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 18:46:41 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 18:46:41 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 18:46:41 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 18:46:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:46:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:42 INFO - Downloading docopt-0.6.1.tar.gz 18:46:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:46:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:46:42 INFO - Running setup.py install for blobuploader 18:46:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:46:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:46:42 INFO - Running setup.py install for requests 18:46:43 INFO - Running setup.py install for docopt 18:46:43 INFO - Successfully installed blobuploader requests docopt 18:46:43 INFO - Cleaning up... 18:46:43 INFO - Return code: 0 18:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:43 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')]} 18:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:43 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')]} 18:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:43 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 0x10c547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c524228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8ac8b0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:46:43 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 18:46:43 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 18:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:43 INFO - 'HOME': '/Users/cltbld', 18:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:43 INFO - 'LOGNAME': 'cltbld', 18:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:43 INFO - 'MOZ_NO_REMOTE': '1', 18:46:43 INFO - 'NO_EM_RESTART': '1', 18:46:43 INFO - 'PAGER': '/bin/cat', 18:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:43 INFO - 'PWD': '/builds/slave/test', 18:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:43 INFO - 'SHELL': '/bin/bash', 18:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:46:43 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:43 INFO - 'USER': 'cltbld', 18:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:43 INFO - 'XPC_FLAGS': '0x0', 18:46:43 INFO - 'XPC_SERVICE_NAME': '0', 18:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:43 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-MCYhJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-kvYduL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-9oKbz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-X0gKUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-Vgtlx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-L97mot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-RZcj9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-6OU7Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-RCKEid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:44 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-FN2IvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:45 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-OptqBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:45 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-huQPmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:45 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-Jgh9kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:45 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-5B4NNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:45 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-E9FnD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:45 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-KfBzPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:45 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-JGU9vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:46:45 INFO - Running setup.py install for manifestparser 18:46:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:46:46 INFO - Running setup.py install for mozcrash 18:46:46 INFO - Running setup.py install for mozdebug 18:46:46 INFO - Running setup.py install for mozdevice 18:46:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:46:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:46:46 INFO - Running setup.py install for mozfile 18:46:46 INFO - Running setup.py install for mozhttpd 18:46:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:46:46 INFO - Running setup.py install for mozinfo 18:46:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:46:47 INFO - Running setup.py install for mozInstall 18:46:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:46:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:46:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:46:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:46:47 INFO - Running setup.py install for mozleak 18:46:47 INFO - Running setup.py install for mozlog 18:46:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:46:47 INFO - Running setup.py install for moznetwork 18:46:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:46:47 INFO - Running setup.py install for mozprocess 18:46:47 INFO - Running setup.py install for mozprofile 18:46:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:46:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:46:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:46:48 INFO - Running setup.py install for mozrunner 18:46:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:46:48 INFO - Running setup.py install for mozscreenshot 18:46:48 INFO - Running setup.py install for moztest 18:46:48 INFO - Running setup.py install for mozversion 18:46:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:46:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:46:48 INFO - Cleaning up... 18:46:48 INFO - Return code: 0 18:46:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10c547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c524228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8ac8b0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:46:48 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 18:46:48 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 18:46:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:46:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:48 INFO - 'HOME': '/Users/cltbld', 18:46:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:48 INFO - 'LOGNAME': 'cltbld', 18:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:48 INFO - 'MOZ_NO_REMOTE': '1', 18:46:48 INFO - 'NO_EM_RESTART': '1', 18:46:48 INFO - 'PAGER': '/bin/cat', 18:46:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:48 INFO - 'PWD': '/builds/slave/test', 18:46:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:48 INFO - 'SHELL': '/bin/bash', 18:46:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:46:48 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:46:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:48 INFO - 'USER': 'cltbld', 18:46:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:48 INFO - 'XPC_FLAGS': '0x0', 18:46:48 INFO - 'XPC_SERVICE_NAME': '0', 18:46:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-rvmv44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:49 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)) 18:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-94ryRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:49 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)) 18:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-3CJhfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:49 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)) 18:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-WZWAEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:49 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)) 18:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-dUiHgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:49 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)) 18:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-yQQi8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-3l9QnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-2Ejciu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-l23qKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-cfQmWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-5LBuLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-NkW6UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-nRgdn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:50 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)) 18:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-iHwbOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:51 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)) 18:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:51 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-ICaOy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:51 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)) 18:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:51 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-jpQ9GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:51 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)) 18:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:51 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-iRLJVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:51 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)) 18:46:51 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)) 18:46:51 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)) 18:46:51 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)) 18:46:51 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)) 18:46:51 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)) 18:46:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:53 INFO - Downloading blessings-1.5.1.tar.gz 18:46:53 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 18:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:46:53 INFO - Installing collected packages: blessings 18:46:53 INFO - Running setup.py install for blessings 18:46:54 INFO - Successfully installed blessings 18:46:54 INFO - Cleaning up... 18:46:54 INFO - Return code: 0 18:46:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:54 INFO - Reading from file tmpfile_stdout 18:46:54 INFO - Current package versions: 18:46:54 INFO - blessings == 1.5.1 18:46:54 INFO - blobuploader == 1.2.4 18:46:54 INFO - docopt == 0.6.1 18:46:54 INFO - manifestparser == 1.1 18:46:54 INFO - mozInstall == 1.12 18:46:54 INFO - mozcrash == 0.16 18:46:54 INFO - mozdebug == 0.1 18:46:54 INFO - mozdevice == 0.47 18:46:54 INFO - mozfile == 1.2 18:46:54 INFO - mozhttpd == 0.7 18:46:54 INFO - mozinfo == 0.9 18:46:54 INFO - mozleak == 0.1 18:46:54 INFO - mozlog == 3.0 18:46:54 INFO - moznetwork == 0.27 18:46:54 INFO - mozprocess == 0.22 18:46:54 INFO - mozprofile == 0.27 18:46:54 INFO - mozrunner == 6.11 18:46:54 INFO - mozscreenshot == 0.1 18:46:54 INFO - mozsystemmonitor == 0.0 18:46:54 INFO - moztest == 0.7 18:46:54 INFO - mozversion == 1.4 18:46:54 INFO - psutil == 3.1.1 18:46:54 INFO - requests == 1.2.3 18:46:54 INFO - wsgiref == 0.1.2 18:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 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 0x10c547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c524228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8ac8b0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/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.rniHp7VxmD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:46:54 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 18:46:54 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 18:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:54 INFO - 'HOME': '/Users/cltbld', 18:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:54 INFO - 'LOGNAME': 'cltbld', 18:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:54 INFO - 'MOZ_NO_REMOTE': '1', 18:46:54 INFO - 'NO_EM_RESTART': '1', 18:46:54 INFO - 'PAGER': '/bin/cat', 18:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:54 INFO - 'PWD': '/builds/slave/test', 18:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:54 INFO - 'SHELL': '/bin/bash', 18:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:46:54 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:54 INFO - 'USER': 'cltbld', 18:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:54 INFO - 'XPC_FLAGS': '0x0', 18:46:54 INFO - 'XPC_SERVICE_NAME': '0', 18:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 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)) 18:46:54 INFO - Cleaning up... 18:46:54 INFO - Return code: 0 18:46:54 INFO - Running post-action listener: _resource_record_post_action 18:46:54 INFO - Running post-action listener: _start_resource_monitoring 18:46:54 INFO - Starting resource monitoring. 18:46:54 INFO - ##### 18:46:54 INFO - ##### Running install step. 18:46:54 INFO - ##### 18:46:54 INFO - Running pre-action listener: _resource_record_pre_action 18:46:54 INFO - Running main action method: install 18:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:55 INFO - Reading from file tmpfile_stdout 18:46:55 INFO - Detecting whether we're running mozinstall >=1.0... 18:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:46:55 INFO - Reading from file tmpfile_stdout 18:46:55 INFO - Output received: 18:46:55 INFO - Usage: mozinstall [options] installer 18:46:55 INFO - Options: 18:46:55 INFO - -h, --help show this help message and exit 18:46:55 INFO - -d DEST, --destination=DEST 18:46:55 INFO - Directory to install application into. [default: 18:46:55 INFO - "/builds/slave/test"] 18:46:55 INFO - --app=APP Application being installed. [default: firefox] 18:46:55 INFO - mkdir: /builds/slave/test/build/application 18:46:55 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'] 18:46:55 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 18:47:34 INFO - Reading from file tmpfile_stdout 18:47:34 INFO - Output received: 18:47:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:47:34 INFO - Running post-action listener: _resource_record_post_action 18:47:34 INFO - ##### 18:47:34 INFO - ##### Running run-tests step. 18:47:34 INFO - ##### 18:47:34 INFO - Running pre-action listener: _resource_record_pre_action 18:47:34 INFO - Running main action method: run_tests 18:47:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:47:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:47:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:47:34 INFO - 2015-11-15 18:47:34.445 screenresolution[1635:8526] starting screenresolution argv=screenresolution get 18:47:34 INFO - 2015-11-15 18:47:34.449 screenresolution[1635:8526] Display 0: 1600x1200x32@60 18:47:34 INFO - 2015-11-15 18:47:34.455 screenresolution[1636:8528] starting screenresolution argv=screenresolution list 18:47:34 INFO - Available Modes on Display 0 18:47:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:47:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:47:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:47:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:47:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:47:34 INFO - Intel HD Graphics 3000: 18:47:34 INFO - Chipset Model: Intel HD Graphics 3000 18:47:34 INFO - Type: GPU 18:47:34 INFO - Bus: Built-In 18:47:34 INFO - VRAM (Total): 512 MB 18:47:34 INFO - VRAM (Dynamic, Max): 10 18:47:34 INFO - Vendor: Intel (0x8086) 18:47:34 INFO - Device ID: 0x0116 18:47:34 INFO - Revision ID: 0x0009 18:47:34 INFO - Displays: 18:47:34 INFO - Display: 18:47:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:47:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:47:34 INFO - Display Serial Number: 1600x1200 60 18:47:34 INFO - Main Display: Yes 18:47:34 INFO - Mirror: Off 18:47:34 INFO - Online: Yes 18:47:34 INFO - Rotation: Supported 18:47:34 INFO - Return code: 0 18:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:47:34 INFO - Python 2.7.3 18:47:34 INFO - Return code: 0 18:47:34 INFO - grabbing minidump binary from tooltool 18:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c46a9f0>, '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 0x10c1cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c45e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:47:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:47:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:47:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:34 INFO - Return code: 0 18:47:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:47:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:47:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:47:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:47:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:47:34 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0080', '--webServer', 'localhost'] in /builds/slave/test/build 18:47:34 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0080 --webServer localhost 18:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5YEixAZtEU/Render', 18:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:47:34 INFO - 'HOME': '/Users/cltbld', 18:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:47:34 INFO - 'LOGNAME': 'cltbld', 18:47:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:47:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:34 INFO - 'MOZ_NO_REMOTE': '1', 18:47:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:47:34 INFO - 'NO_EM_RESTART': '1', 18:47:34 INFO - 'PAGER': '/bin/cat', 18:47:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:34 INFO - 'PWD': '/builds/slave/test', 18:47:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:47:34 INFO - 'SHELL': '/bin/bash', 18:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rniHp7VxmD/Listeners', 18:47:34 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 18:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:47:34 INFO - 'USER': 'cltbld', 18:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:34 INFO - 'XPC_FLAGS': '0x0', 18:47:34 INFO - 'XPC_SERVICE_NAME': '0', 18:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:47:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0080', '--webServer', 'localhost'] with output_timeout 3600 18:47:35 INFO - mozversion INFO | application_buildid: 20151115175333 18:47:35 INFO - mozversion INFO | application_changeset: 4b04af1dc5f5a99e44905777c2117424d819c3a0 18:47:35 INFO - mozversion INFO | application_display_name: Nightly 18:47:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:35 INFO - mozversion INFO | application_name: Firefox 18:47:35 INFO - mozversion INFO | application_remotingname: firefox 18:47:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:47:35 INFO - mozversion INFO | application_vendor: Mozilla 18:47:35 INFO - mozversion INFO | application_version: 45.0a1 18:47:35 INFO - mozversion INFO | platform_buildid: 20151115175333 18:47:35 INFO - mozversion INFO | platform_changeset: 4b04af1dc5f5a99e44905777c2117424d819c3a0 18:47:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:47:35 INFO - mozversion INFO | platform_version: 45.0a1 18:47:35 INFO - 2015-11-15 18:47:35,156 DEBUG : using testdate: 1447642055 18:47:35 INFO - 2015-11-15 18:47:35,156 DEBUG : actual date: 1447642055 18:47:35 INFO - 2015-11-15 18:47:35,272 INFO : starting webserver on 'localhost:49274' 18:47:35 INFO - 2015-11-15 18:47:35,273 INFO : Starting test suite t-yosemite-r5-0080 18:47:35 INFO - 2015-11-15 18:47:35,273 INFO : Starting test dromaeo_css 18:47:35 INFO - 2015-11-15 18:47:35,273 DEBUG : operating with platform_type : mac_ 18:47:35 INFO - 2015-11-15 18:47:35,274 INFO : Initialising browser for dromaeo_css test... 18:47:35 INFO - 2015-11-15 18:47:35,288 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpTH9gm7/profile http://localhost:49274/getInfo.html 18:47:38 INFO - 2015-11-15 18:47:38,849 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:47:38 INFO - 2015-11-15 18:47:38,850 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:47:38 INFO - 2015-11-15 18:47:38,850 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:47:38 INFO - 2015-11-15 18:47:38,850 DEBUG : BROWSER_OUTPUT: __metrics 18:47:38 INFO - 2015-11-15 18:47:38,869 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:47:39 INFO - 2015-11-15 18:47:39,589 INFO : Browser initialized. 18:47:39 INFO - 2015-11-15 18:47:39,589 INFO : Running cycle 1/1 for dromaeo_css test... 18:47:39 INFO - 2015-11-15 18:47:39,590 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpTH9gm7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:47:51 INFO - 2015-11-15 18:47:51,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 228720640 18:47:51 INFO - 2015-11-15 18:47:51,650 DEBUG : BROWSER_OUTPUT: 18:48:42 INFO - 2015-11-15 18:48:42,751 DEBUG : BROWSER_OUTPUT: 1447642122746 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] 18:50:54 INFO - 2015-11-15 18:50:54,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 18:50:55 INFO - 2015-11-15 18:50:55,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 340410368 18:50:55 INFO - 2015-11-15 18:50:55,283 DEBUG : BROWSER_OUTPUT: 18:53:58 INFO - 2015-11-15 18:53:58,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 18:53:58 INFO - 2015-11-15 18:53:58,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 365719552 18:53:58 INFO - 2015-11-15 18:53:58,602 DEBUG : BROWSER_OUTPUT: 18:57:00 INFO - 2015-11-15 18:57:00,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 18:57:01 INFO - 2015-11-15 18:57:01,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 336105472 18:57:01 INFO - 2015-11-15 18:57:01,457 DEBUG : BROWSER_OUTPUT: 19:00:03 INFO - 2015-11-15 19:00:03,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 19:00:04 INFO - 2015-11-15 19:00:04,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 317059072 19:00:04 INFO - 2015-11-15 19:00:04,244 DEBUG : BROWSER_OUTPUT: 19:03:07 INFO - 2015-11-15 19:03:07,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 19:03:08 INFO - 2015-11-15 19:03:08,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 323526656 19:03:08 INFO - 2015-11-15 19:03:08,036 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 19:06:11 INFO - 2015-11-15 19:06:11,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 365613056 19:06:11 INFO - 2015-11-15 19:06:11,305 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,305 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:06:11 INFO - 2015-11-15 19:06:11,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:06:11 INFO - 2015-11-15 19:06:11,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:06:11 INFO - 2015-11-15 19:06:11,305 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:06:11 INFO - 2015-11-15 19:06:11,307 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2923.693012233716;2947.631546056743;2971.598834157388;3003.6846131156226;3147.181732749485;4740.383750112489;4854.660173787836;4879.39007624047;4945.332380128686;4995.550400463958;4791.089692958335;4852.5147485251455;4856.927146092803;4897.534734200245;4983.725895075779;4490.57339552742;4498.212812757771;4541.250693635546;4591.334256532818;4631.3516107744945;4595.896984723676;4615.423072115986;4633.119707255611;4648.535146485358;4762.714237145782;4356.542563030868;4407.515173330963;4503.301988191835;4532.229520981441;4601.033782905593;4523.570260825217;4524.298733696282;4525.004499010245;4570.520095389969;4571.794269257892;4471.910561788779;4481.955180448186;4521.525239849801;4541.114482675879;4593.885152871205;4742.50203728607;4750.667453278272;4843.273508973647;4855.441624213226;4877.34155888954;5151.871203219912;5161.1742121260795;5176.301199338116;5201.193814958688;5267.999080174793;5215;5236.423993360727;5250.5274525292525;5253;5325.3875804282225;4740.336352910595;4767.713937163781;4837.443693975168;4861.319415281863;4939.75301234944;5419.83740487786;5434.945650543444;5436.10304299794;5457.126859702428;5464.562834973192;5174.068667639785;5175.508326708957;5179.689218646893;5181.5854731621375;5249;5013.448520662724;5126.384833819965;5142.6400151989;5174.990876778992;5388;5164.1995490699;5196.58427325813;5201.985612805466;5256.658317209369;5259.368875734936;5174.7930082796265;5176.870578235499;5185.740712964337;5198.402183748842;5246.081935661244;3905.2970465316516;3925.21495700861;4007.438958545806;4012.9799351003057;4063.512378514597;3628.401313783249;3654.9817250914107;3666.7799932004164;3685.1155722626377;3707.9073023174096;4969.130402179604;4976.0794253063295;4982.800687972513;5005.949940500621;5022.271770593244;5102.285680004802;5174.922376164361;5195.402528709171;5198.896022079537;5378.112611419072;4969.229769385751;4988.700677959261;4997.750112494361;5004.099262132779;5046.091703493333;4647.233206520887;4672.112298663243;4680.180968330528;4703.435587729495;4707.646926480527;5290.550303224269;5399.568034557305;5435.048866448276;5481.177823326533;5527.364353099365;5283.233931080049;5291.656042357235;5301.019311427398;5341.572674186134;5343.332083489564;5492.505674489315;5498.642588231752;5541.3904470509015;5569.860753481195;5578.888422231614;5033.370828646419;5161.793528258828;5231.3199284092825;5234.136367499472;5245.842624721265;5219.164933610604;5225.346831646044;5288.709120998228;5318.149096144598;5322.387925388475;5171.405288391883;5178.456262092426;5186.740662966912;5190.792368305226;5250.238715386171;4970.3290055843445;5125.718085505333;5187.09225885461;5187.688738675692;5199.116150254541;4975.303457516023;5060.645754797276;5065.493450655053;5067.087924173684;5106.131957567148;5166.715830629201;5180.093483640423;5184.144616138295;5196.9740151299;5255.2379904912805;4950.579200767975;5099.133147365031;5113.667611605234;5124.769385377593;5169.560587350117 19:06:11 INFO - 2015-11-15 19:06:11,308 DEBUG : BROWSER_OUTPUT: |1;ext.html;506.1597747738754;511.1489370198619;517.4179048570359;521.9660722053067;536.2787051415844;28297;29288.853555732218;35777.10557236067;36803.815980920124;36854.81572592133;37972.240555188946;38225.42661860067;38530.61469385305;38615.80692096543;38936.22127557447;7432.070991126109;8281.710140145111;8478.279346255576;8488;8505.447145935525;7482.401407887356;7613.276738709841;10155.847662285072;10234.181265498779;10252.692419227398;10021.198304135653;10113.544890479947;10116.190704743603;10117.898821011806;10157.390556566592;7576.166621671612;9763.414195148243;10039.799204015915;10092.293539452241;10101.54543045561;7348.375388091965;9793.265505087147;9946.751331216705;9987.550560224807;10012.749681257954;34855.825720871486;35384.64615353839;35438.64561354405;35466;35471.82264088689;2613.751693589106;2620.174644986842;2655.9601605975927;2735.8905643774224;2901.245676124202;25130.12044578431;25995.870020649963;26401.075962341227;26491;26607.20178394651;2234.7765223477686;2242.136777340719;2259.5254996450767;2272.6818245445484;2340.1224540797202;239828;241291;241635;241742;245393;54156.45843541593;54477;54677.45322546803;54856.451435485935;54947.450525494234;54245;55126.72436637791;59162.40837591655;60666.696666516385;60679.69660151759;13089;13168.341582920815;13175.736485270432;13185.670358241121;13274.269915154566;9852.802943941224;9877.456739879231;9880.40717556949;9882.308238423242;9936.056074672895;17787.555311117325;18121.275148993893;18375.72436413455;18424.539386515175;18431.354902578347;7718.652660630285;8041.3968952328805;8046.758597242092;8097.959510202411;8110.83778324442;896.1002674330331;901.2564634176699;916.9867296637253;1012.9797404051877;1054.1988089052375;25170.496590068095;25332.366690832878;25368.238952831445;28988.27529311742;30544.389112217632;933.1042199488567;954.4273435938381;969.99030009699;989.3766926836191;1008.369768894441;13027.876897857992;13053.934730326288;13168.539101131415;13184.077114601885;13190.076694631476;353388;361193;362609;363524;364595;48530.30143944945;48576;48764.51235487671;49053.26420103701;49091;1250.3185763758772;1263.260992319485;1279.4498365702837;1285.3508977966255;1292.2246652008719;24210.515789683755;24551.263462096165;24779.87610061938;24840.37899052538;24889.377765556004;45664.31503527516;46049;46055.30917036314;46310.07379852317;46334.768326158155;267408;271733;274644;274711;278195;28182.43635127327;28529.572056419587;28633.284167895137;28711.13866584006;28872.2781930445;36440.27119457649;36504.81747591245;37097.443538347485;37310.813445932596;37543.43684844784;32385.514217286287;32708;33016.174595634344;33053;33240.1689957753;34658.30683386369;35541.28917421689;35584.82207588945;35685.1078723034;35906.46140307845;32493.67658778252;32616;33195.50206746852;33320.3351530781;33774;28411;28870.278243044093;28914.421711566072;29013.709862901946;29119.85440072786;22601.88699056494;22712.65931011003;22895.42761430911;22974.885125574267;23000 19:06:11 INFO - 2015-11-15 19:06:11,312 DEBUG : BROWSER_OUTPUT: |2;jquery.html;304.2803769086112;306.37499501017925;307.6923076923077;311.6400557356254;316.2804619490659;12906.548270810523;13310.93344533276;15683.607909802246;15899.920500397497;16352.591185220375;13243.536476223335;13274.933625331883;13285.26931018796;13369.598912032654;15078.246087695627;3988.8005599720045;4122.773247471388;4168.520620128678;4782.832600858979;4965.379327584052;3093.9845300773463;3162.0829959311773;3190.234343757493;4237.6821738369745;4305.311150215966;6156.815295541119;6401.423871851533;6448.193975753031;6483.481321494292;6516.706748196319;6206.565540412173;6371.808845734636;6382.819178452001;6404;6426.0360945858265;5939.227900372967;6127.356627554087;6128.3258841527395;6130.816075517741;6151.446369826693;20421.081051352725;20940.267090651905;21207.469813254636;22591.435214119778;22923.197688081003;1889.5653999580175;1929.366250548402;1950.746402967605;2067.400453868376;2160.405888380692;13214.73570528584;13318.600441986757;13641.317934103354;13728.45086196551;13983.860161398357;1571.6228105254656;1616.5958510372407;1670.189957870432;1728.6024214430752;1733.3846484498074;59291.40708592902;60523;60913.695431523;61054.38945610532;61471.38528614746;14912.62718432048;15564.844351556567;15572.119157955814;15731;15828.920855395649;22742.431439213822;22777.31668049961;22778;22922;23021.539569208522;8018.719344822904;8076.071251806117;8109.797255068553;8154.306883914815;8184.281300926872;6633.9668301658185;6638.834029149213;6655.334466553306;6676.031975363545;6711.060451536789;7364.116306043202;7452.478326517092;7493.4379921505015;7520.811979700551;7527.736529221451;2489.601663733794;2921.28428535006;2945.6465224173235;3000;3016.713412225835;385.0086028476628;386.1909300016461;408.8834682115583;424.6963421153828;436.21263619167075;9604.615815367446;10073.949630251802;10343.224258180666;10419.791604167875;10499.370037797757;386.4677146645757;405.7220803749441;410.452046517896;413.4686927298407;441.3357896365949;5353;5621.747021384048;5652.689102099424;5665.6034077614995;5681.886362272731;88102.55948720344;88380;499972;523862;528228;57601.71199143978;58347.12479312814;58579.70710146422;61383.69308153431;66136.6693166531;447.23746013047673;448.21338550843063;450.1694373880186;450.69127647561527;456.04003572480116;9842.901570984199;9858.802823943337;9949.950250248992;10072;10128.59485620567;24875.25374238776;27386.5892011624;27511.86244068767;27735.445291094467;31607;38141;39004.21991560096;39821.60178398179;40022.799886000386;40072.599274008055;5386.245925570345;5605.103183490622;5624.353199382123;5753.4246575343805;5772.855678608068;10475.161987040867;10627.840582391425;10713.571457141627;10783.946080269548;10834.891651083704;9356.157945784911;9390.201832844285;9419.246460283299;9497.952510237405;9565;9020.233280171258;9184.219341355792;9228.815423691623;9236.307276954121;9324.067593240621;9352.859707104262;9382.390144640576;9697.709068727949;9698.36960597559;9800.754981125529;5647.519960803378;5651.773929042793;5715.514181294637;5723.627964182315;5729.570282228766;9123.498207598646;9203.86194207074;9219.539023048686;9416.199623032118;9508.429494230091 19:06:11 INFO - 2015-11-15 19:06:11,313 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1190.7142285851398;1562.835902230266;1641.2778377513894;1649.1836540912243;1672.1555614414726;6786.423154031907;6968.686409111596;7096.751613693528;7424.628768561563;7467.8879816802655;7224;7349.118105827308;7358.521696089764;7377.557346559211;7395.260473952602;1855.4526414707693;1914.1099388784212;2127.7765834587376;2149.9892500537476;2159.2442645074257;2071.6167509010806;2117.502386939068;2119.586680597284;2121.734783152106;2121.7772133925946;2038.8980550972392;2039.7654269758946;2067.3694523170425;2085.9987206141063;2119.173522326294;1813.8004819469847;1844.382131985773;2073.460900165953;2097.4336929029155;2130.7869213078725;2102.863313884608;2131.79747923947;2136.060133541237;2136.529963408048;2137.4549489880137;6804.08144900437;6877.862442751117;6897.310268973062;6949.722011119549;6980.511364204508;4577.908441831178;4688.320193571913;4701.459332176809;4710.788014539354;4711.646626503026;2668.8932442702267;2680.6515153030177;2713.66079240095;2731.5219836528727;2737.3567211705235;824.7031068815222;843.3127001493824;849.0490650471511;850.5832142250315;863.6070587882498;9815;9820.165285950703;9837.606495740161;9849.113579777782;9861;4145.813438395279;4194.832206711759;4249.915001699948;4257.744535327828;4260.467441569804;8498.872516912252;8539.615717292736;8550;8568.914310856811;8604.010538787994;4670.906581868411;4689.788959496763;4694.647901407408;4698.506656801055;4707.976460117678;4248.681348898845;4254.553271906405;4256.042390462121;4263.360495925574;4268.359746038057;3489.267253876714;3496.5629296337956;3517.700995415418;3537.7700449470703;3555.8621241203086;1122.0686829931137;1136.6021892337615;1144.793937091315;1151.5106079916002;1155.757290968889;1186.7211205366732;1217.446062041769;1232.5686009896465;1238.3003602964297;1242.5526810348267;6519.348065193442;6590.3080176581725;6961.686724097326;7060.505764596429;7070.151581810215;592.351375244107;601.0713447723278;606.3966353478318;618.7679620142446;620.3393386043849;5378.650387724785;5386.461353864583;5421.620486565903;5431.945680543144;5468.316460442445;8653.913460865311;8759.824803503894;8873.91126088731;8874.556272186364;8876.068012858686;8690.782730431663;8763.25512331459;8771.561421929006;8780.868286975701;8797.164269394398;6759.932400675931;6804.523683342119;6870.27862074485;6904.3095690430555;6922.7923162305215;6666.333366663489;6688.030235615711;6702.430293424918;6716.1604799400075;6718.328167183243;7490.475666703496;7711.460197786101;7772.339351154989;7780.84438311242;7801.102873169431;7800.141984381827;8018.118007019107;8041.276285134366;8080.797980050545;8134.877976830234;5895.322037965518;6418.069379939976;6474.870502590016;6480.805575832733;6510.121133647087;7107.360337569644;7123.394511466583;7142.9285707144345;7150.356467917913;7180.066591343092;6572.737090516517;6581.6709164542535;6670.366315200048;6697.09589205451;6790.117284753148;6484.902726459012;6493.090967264681;6599.142111525471;6613.603183808795;6621.106150669598;6056.515478761777;6260.217472815898;6612.603243805194;6634.137562116894;6671.499637527108;5803.0424979879535;5883.411658834082;5898.20374249488;5935.910961335497;5986.700664966821;6086.995645718584;6121.234845644294;6123.601965872204;6145.139680444652;6169.5064394849205 19:06:11 INFO - 2015-11-15 19:06:11,315 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.8359335178948;292.4385180453529;300.60320377102227;301.71940095710994;305.0436880380008;5584.078627026536;5620.156976453534;5706;5728.169415434764;5760.423957604243;5597.580181486394;5669.8582535436635;5738.913916291249;5740.827775166741;5757.913631295534;4399.802008909607;4400.031992961543;4412.735235885841;4415;4452.977735111336;4206.747595144301;4311.590398912114;4320.049589090395;4359.4768627764715;4408.228560002003;4337.1325734853;4348.7825608719595;4379.146066517031;4400.581944715247;4409.933850992237;4281.250781113308;4332.718373305725;4354.412154359153;4373.300271956472;4381.912361752779;3655;3721.5348081489815;3773.8301776419853;3797.4493698413853;3803.1823158021157;5328.280682107905;5522.530584900288;5523.751431185566;5572.164175373686;5659.292588426447;4950;4954.182559877616;4959.8016079356785;4960.70235785854;4979.701217926936;5769.365369809318;6060.969695151496;6084.209052823105;6094.817155485298;6123.2652081750475;4014.1770936957855;4016.2369149861433;4050.756954582705;4128.298189307825;4138.606832350922;6255.468285195764;6306.211723534559;6335.968320158462;6368;6405.071264666643;4141.399497072907;4180.372944058355;4184.184084103571;4207.200631879933;4207.221663992172;4117.526484454266;4210.32634778434;4225.3873188387515;4243.257429949746;4258.127083947783;4879.536444037811;4892.2661600760175;4898.706077635354;4904.55858972687;4904.730239836772;5999;6012.6392416455155;6033.793241351747;6037.516998640098;6042.607230530001;1490.299559207171;1500.4523348977764;1500.8949373543965;1504.1050574907913;1505.284989629917;966.2173639352147;987.3631507677651;988.6984469736799;993.145894530703;1006.6677996261362;5815.098659707752;5841.474267315962;5845.240118784531;5863.882722345529;5869.295684517885;6263.279722831841;6264.906026409608;6280.026595877646;6282.340354262737;6306.49548036156;5830.4461076197695;5842.970785146047;5844.620099693507;5852.824415267549;5857.88284234313;3245.188702824294;3376.037829218661;3399.5240666306736;3400.0819778659625;3429.7599168058496;6539.738410463528;6551.344865513506;6564.376384243585;6574.112494813139;6611.933880661228;6425.325340839145;6438;6455.096286519891;6455.677216139175;6490.2536208335705;6300.936990630126;6555.901661475082;6567.44176744982;6576.177977752685;6578.243501997332;6050.606710563799;6259.061140828912;6273;6299.464545513682;6304.810855674337;6013.458788708862;6040.305364882919;6110.144579758926;6132;6192.535559832941;6546.214454265328;6619.205695316593;6619.867602647823;6621.834454138685;6636.634985075674;4228.450301460914;4236.745795252295;4246.787660616895;4256.723312984646;4306.892327691708;6070.605410648471;6277.340879207617;6300.71646775887;6307.085472606538;6315.242170939517;6106.847328816637;6117.265928088658;6122.479589234965;6136.7852125175405;6167.951448253897;6116.357782432959;6124.203853499017;6130.846728831815;6139.3553676863285;6167.290761562298;5828.853668696513;5956.106584012433;5987.101934709654;5992.550558708027;6024.036154215304;6064.3026052002815;6076.817695469143;6084.847878803065;6113.67680281508;6138.232720909887;5988.6706231157705;5993.940060599338;6007.158997740407;6029.60807547508;6032.939670603413 19:06:11 INFO - 2015-11-15 19:06:11,316 DEBUG : BROWSER_OUTPUT: |5;yui.html;693.8716337477564;704.27459716492;704.464606898757;718.2960698515454;719.0939416335423;12272.693182670426;12441.440135193916;12486.438110285037;12497.375131243447;12633.431495582709;12100.757984840298;12107.636770896865;12107.757844843098;12110.939445302783;12141.57504487343;635.4154178156108;640.6668532363168;649.5745286837106;783.8824176373532;813.947093438926;823.6581818545327;825.5459497276504;842.2209456252972;843.8945131858518;844.2865778417228;813.6419975210918;840.7771940435758;854.5043874552775;857.1214505132258;858.3047731337605;661.0480907493194;672.6603065451916;818.9058258300312;834.1991687979547;852.1478521478522;623.5853157650157;626.2578844069747;629.527854109418;629.5498718416354;633.8922383194868;12266;12428.62714118578;12446.381970343888;12464.376781160996;12470.688232794253;10237.590496380137;10416.375017498975;10615.681529554126;11024.173187011007;11309.886901130965;8616.741497755078;8691.826163476759;8853.291736661116;8917.464952102895;8938.0615035421;3060.219643990768;3079.969200307991;3084.568160457538;3099.876004959799;3108.9895783870334;42369.57630423687;42901;42925;42983.14033719308;43112.3533147003;8278.958605207055;8563.400561960727;8670.826583468295;8673;8673.176048275403;18116.547086322684;18125.456236312933;18235.72646410305;18372.724409133873;18374.54063648393;6373.107764912916;6458.483321334282;6491.350864913471;6602.966985165043;6721.4958878084335;3214.6785321467664;3454;3522.7710198836994;3591.425371940477;3631.2192878530714;2798.0766347105405;2830.3348713052414;2834;2835.078599455185;2867.311845157147;392.0903503870992;402.6677990657661;409.37570205436947;410.24924388369215;413.8220565156951;453.48755905826204;463.666160364537;514.8827045311683;528.6220352447941;569.5073761196535;7321;7439.367653749492;7444.664990075459;7562.697492100365;7596.202398748052;427.7091577727113;499.11407252127765;523.9345081864767;559.6949662433983;571.0577547047405;3482.2513159670793;3506.9123271917897;3532.364174448624;3538.6992105670793;3702.851885924587;52676.473235267156;53241.73379133079;53717.19424208562;53768.462315377124;53842;46030.76984615123;46966.76516617395;48265.5173448268;48272;48508.27237591439;42273;42735.35896961548;42753.35869961953;43491.565084349386;43802.342964855554;7021.719131234898;7100.609466479394;7255.673494692646;7366.558006519626;7408.888866667112;32517.837410812794;33324.66675333216;33457.163570910925;33498.49752253767;33812.661873381934;39486.40770388389;40814.38778418267;41412.171756564094;42185.36721949112;42357.36463952981;7045.788626341218;7082.787516374517;7147.964260178665;7248.130224373109;7330.266973302627;10343;10383.2212584055;10421.895781042092;10459.947700261755;10560.524776385235;9929.056739609725;9947.253955953187;10003.099721025143;10031.097201251923;10132.088112069949;9797.510124493889;9826.705198844045;9904.405735655884;9907.702768916944;9973.451460169761;9580.233581313618;9659.32384733062;9697.854532182164;9797.412155270707;9845.655402060893;8092.312153466786;8137.3490120791375;8444.746657600283;8833.381663283508;9024.548772561215;8200.958995204986;8528.488290702579;8554.059053504234;8635.834162387997;8667.82664346697 19:06:11 INFO - 2015-11-15 19:06:11,316 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:06:11 INFO - 2015-11-15 19:06:11,316 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:06:11 INFO - 2015-11-15 19:06:11,317 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1029 19:06:11 INFO - 2015-11-15 19:06:11,317 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:06:11 INFO - 2015-11-15 19:06:11,317 DEBUG : BROWSER_OUTPUT: __startTimestamp1447643171303__endTimestamp 19:06:11 INFO - 2015-11-15 19:06:11,317 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,317 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:06:11 INFO - 2015-11-15 19:06:11,317 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:06:11 INFO - 2015-11-15 19:06:11,318 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,318 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4901.56 Median:5067.09 stddev:526.80 (10.4%) stddev-sans-first:505.05 19:06:11 INFO - 2015-11-15 19:06:11,319 DEBUG : BROWSER_OUTPUT: Values: 2923.7 2947.6 2971.6 3003.7 3147.2 4740.4 4854.7 4879.4 4945.3 4995.6 4791.1 4852.5 4856.9 4897.5 4983.7 4490.6 4498.2 4541.3 4591.3 4631.4 4595.9 4615.4 4633.1 4648.5 4762.7 4356.5 4407.5 4503.3 4532.2 4601.0 4523.6 4524.3 4525.0 4570.5 4571.8 4471.9 4482.0 4521.5 4541.1 4593.9 4742.5 4750.7 4843.3 4855.4 4877.3 5151.9 5161.2 5176.3 5201.2 5268.0 5215.0 5236.4 5250.5 5253.0 5325.4 4740.3 4767.7 4837.4 4861.3 4939.8 5419.8 5434.9 5436.1 5457.1 5464.6 5174.1 5175.5 5179.7 5181.6 5249.0 5013.4 5126.4 5142.6 5175.0 5388.0 5164.2 5196.6 5202.0 5256.7 5259.4 5174.8 5176.9 5185.7 5198.4 5246.1 3905.3 3925.2 4007.4 4013.0 4063.5 3628.4 3655.0 3666.8 3685.1 3707.9 4969.1 4976.1 4982.8 5005.9 5022.3 5102.3 5174.9 5195.4 5198.9 5378.1 4969.2 4988.7 4997.8 5004.1 5046.1 4647.2 4672.1 4680.2 4703.4 4707.6 5290.6 5399.6 5435.0 5481.2 5527.4 5283.2 5291.7 5301.0 5341.6 5343.3 5492.5 5498.6 5541.4 5569.9 5578.9 5033.4 5161.8 5231.3 5234.1 5245.8 5219.2 5225.3 5288.7 5318.1 5322.4 5171.4 5178.5 5186.7 5190.8 5250.2 4970.3 5125.7 5187.1 5187.7 5199.1 4975.3 5060.6 5065.5 5067.1 5106.1 5166.7 5180.1 5184.1 5197.0 5255.2 4950.6 5099.1 5113.7 5124.8 5169.6 19:06:11 INFO - 2015-11-15 19:06:11,320 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,320 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44587.45 Median:32862.09 stddev:77874.51 (237.0%) stddev-sans-first:78022.64 19:06:11 INFO - 2015-11-15 19:06:11,320 DEBUG : BROWSER_OUTPUT: Values: 506.2 511.1 517.4 522.0 536.3 28297.0 29288.9 35777.1 36803.8 36854.8 37972.2 38225.4 38530.6 38615.8 38936.2 7432.1 8281.7 8478.3 8488.0 8505.4 7482.4 7613.3 10155.8 10234.2 10252.7 10021.2 10113.5 10116.2 10117.9 10157.4 7576.2 9763.4 10039.8 10092.3 10101.5 7348.4 9793.3 9946.8 9987.6 10012.7 34855.8 35384.6 35438.6 35466.0 35471.8 2613.8 2620.2 2656.0 2735.9 2901.2 25130.1 25995.9 26401.1 26491.0 26607.2 2234.8 2242.1 2259.5 2272.7 2340.1 239828.0 241291.0 241635.0 241742.0 245393.0 54156.5 54477.0 54677.5 54856.5 54947.5 54245.0 55126.7 59162.4 60666.7 60679.7 13089.0 13168.3 13175.7 13185.7 13274.3 9852.8 9877.5 9880.4 9882.3 9936.1 17787.6 18121.3 18375.7 18424.5 18431.4 7718.7 8041.4 8046.8 8098.0 8110.8 896.1 901.3 917.0 1013.0 1054.2 25170.5 25332.4 25368.2 28988.3 30544.4 933.1 954.4 970.0 989.4 1008.4 13027.9 13053.9 13168.5 13184.1 13190.1 353388.0 361193.0 362609.0 363524.0 364595.0 48530.3 48576.0 48764.5 49053.3 49091.0 1250.3 1263.3 1279.4 1285.4 1292.2 24210.5 24551.3 24779.9 24840.4 24889.4 45664.3 46049.0 46055.3 46310.1 46334.8 267408.0 271733.0 274644.0 274711.0 278195.0 28182.4 28529.6 28633.3 28711.1 28872.3 36440.3 36504.8 37097.4 37310.8 37543.4 32385.5 32708.0 33016.2 33053.0 33240.2 34658.3 35541.3 35584.8 35685.1 35906.5 32493.7 32616.0 33195.5 33320.3 33774.0 28411.0 28870.3 28914.4 29013.7 29119.9 22601.9 22712.7 22895.4 22974.9 23000.0 19:06:11 INFO - 2015-11-15 19:06:11,320 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,320 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21626.61 Median:449.19 stddev:66759.91 (14862.2%) stddev-sans-first:66927.99 19:06:11 INFO - 2015-11-15 19:06:11,321 DEBUG : BROWSER_OUTPUT: Values: 304.3 306.4 307.7 311.6 316.3 12906.5 13310.9 15683.6 15899.9 16352.6 13243.5 13274.9 13285.3 13369.6 15078.2 3988.8 4122.8 4168.5 4782.8 4965.4 3094.0 3162.1 3190.2 4237.7 4305.3 6156.8 6401.4 6448.2 6483.5 6516.7 6206.6 6371.8 6382.8 6404.0 6426.0 5939.2 6127.4 6128.3 6130.8 6151.4 20421.1 20940.3 21207.5 22591.4 22923.2 1889.6 1929.4 1950.7 2067.4 2160.4 13214.7 13318.6 13641.3 13728.5 13983.9 1571.6 1616.6 1670.2 1728.6 1733.4 59291.4 60523.0 60913.7 61054.4 61471.4 14912.6 15564.8 15572.1 15731.0 15828.9 22742.4 22777.3 22778.0 22922.0 23021.5 8018.7 8076.1 8109.8 8154.3 8184.3 6634.0 6638.8 6655.3 6676.0 6711.1 7364.1 7452.5 7493.4 7520.8 7527.7 2489.6 2921.3 2945.6 3000.0 3016.7 385.0 386.2 408.9 424.7 436.2 9604.6 10073.9 10343.2 10419.8 10499.4 386.5 405.7 410.5 413.5 441.3 5353.0 5621.7 5652.7 5665.6 5681.9 88102.6 88380.0 499972.0 523862.0 528228.0 57601.7 58347.1 58579.7 61383.7 66136.7 447.2 448.2 450.2 450.7 456.0 9842.9 9858.8 9950.0 10072.0 10128.6 24875.3 27386.6 27511.9 27735.4 31607.0 38141.0 39004.2 39821.6 40022.8 40072.6 5386.2 5605.1 5624.4 5753.4 5772.9 10475.2 10627.8 10713.6 10783.9 10834.9 9356.2 9390.2 9419.2 9498.0 9565.0 9020.2 9184.2 9228.8 9236.3 9324.1 9352.9 9382.4 9697.7 9698.4 9800.8 5647.5 5651.8 5715.5 5723.6 5729.6 9123.5 9203.9 9219.5 9416.2 9508.4 19:06:11 INFO - 2015-11-15 19:06:11,322 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,322 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5107.36 Median:619.55 stddev:2641.96 (426.4%) stddev-sans-first:2632.96 19:06:11 INFO - 2015-11-15 19:06:11,323 DEBUG : BROWSER_OUTPUT: Values: 1190.7 1562.8 1641.3 1649.2 1672.2 6786.4 6968.7 7096.8 7424.6 7467.9 7224.0 7349.1 7358.5 7377.6 7395.3 1855.5 1914.1 2127.8 2150.0 2159.2 2071.6 2117.5 2119.6 2121.7 2121.8 2038.9 2039.8 2067.4 2086.0 2119.2 1813.8 1844.4 2073.5 2097.4 2130.8 2102.9 2131.8 2136.1 2136.5 2137.5 6804.1 6877.9 6897.3 6949.7 6980.5 4577.9 4688.3 4701.5 4710.8 4711.6 2668.9 2680.7 2713.7 2731.5 2737.4 824.7 843.3 849.0 850.6 863.6 9815.0 9820.2 9837.6 9849.1 9861.0 4145.8 4194.8 4249.9 4257.7 4260.5 8498.9 8539.6 8550.0 8568.9 8604.0 4670.9 4689.8 4694.6 4698.5 4708.0 4248.7 4254.6 4256.0 4263.4 4268.4 3489.3 3496.6 3517.7 3537.8 3555.9 1122.1 1136.6 1144.8 1151.5 1155.8 1186.7 1217.4 1232.6 1238.3 1242.6 6519.3 6590.3 6961.7 7060.5 7070.2 592.4 601.1 606.4 618.8 620.3 5378.7 5386.5 5421.6 5431.9 5468.3 8653.9 8759.8 8873.9 8874.6 8876.1 8690.8 8763.3 8771.6 8780.9 8797.2 6759.9 6804.5 6870.3 6904.3 6922.8 6666.3 6688.0 6702.4 6716.2 6718.3 7490.5 7711.5 7772.3 7780.8 7801.1 7800.1 8018.1 8041.3 8080.8 8134.9 5895.3 6418.1 6474.9 6480.8 6510.1 7107.4 7123.4 7142.9 7150.4 7180.1 6572.7 6581.7 6670.4 6697.1 6790.1 6484.9 6493.1 6599.1 6613.6 6621.1 6056.5 6260.2 6612.6 6634.1 6671.5 5803.0 5883.4 5898.2 5935.9 5986.7 6087.0 6121.2 6123.6 6145.1 6169.5 19:06:11 INFO - 2015-11-15 19:06:11,324 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,324 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5062.91 Median:5842.22 stddev:1555.55 (26.6%) stddev-sans-first:1518.07 19:06:11 INFO - 2015-11-15 19:06:11,325 DEBUG : BROWSER_OUTPUT: Values: 287.8 292.4 300.6 301.7 305.0 5584.1 5620.2 5706.0 5728.2 5760.4 5597.6 5669.9 5738.9 5740.8 5757.9 4399.8 4400.0 4412.7 4415.0 4453.0 4206.7 4311.6 4320.0 4359.5 4408.2 4337.1 4348.8 4379.1 4400.6 4409.9 4281.3 4332.7 4354.4 4373.3 4381.9 3655.0 3721.5 3773.8 3797.4 3803.2 5328.3 5522.5 5523.8 5572.2 5659.3 4950.0 4954.2 4959.8 4960.7 4979.7 5769.4 6061.0 6084.2 6094.8 6123.3 4014.2 4016.2 4050.8 4128.3 4138.6 6255.5 6306.2 6336.0 6368.0 6405.1 4141.4 4180.4 4184.2 4207.2 4207.2 4117.5 4210.3 4225.4 4243.3 4258.1 4879.5 4892.3 4898.7 4904.6 4904.7 5999.0 6012.6 6033.8 6037.5 6042.6 1490.3 1500.5 1500.9 1504.1 1505.3 966.2 987.4 988.7 993.1 1006.7 5815.1 5841.5 5845.2 5863.9 5869.3 6263.3 6264.9 6280.0 6282.3 6306.5 5830.4 5843.0 5844.6 5852.8 5857.9 3245.2 3376.0 3399.5 3400.1 3429.8 6539.7 6551.3 6564.4 6574.1 6611.9 6425.3 6438.0 6455.1 6455.7 6490.3 6300.9 6555.9 6567.4 6576.2 6578.2 6050.6 6259.1 6273.0 6299.5 6304.8 6013.5 6040.3 6110.1 6132.0 6192.5 6546.2 6619.2 6619.9 6621.8 6636.6 4228.5 4236.7 4246.8 4256.7 4306.9 6070.6 6277.3 6300.7 6307.1 6315.2 6106.8 6117.3 6122.5 6136.8 6168.0 6116.4 6124.2 6130.8 6139.4 6167.3 5828.9 5956.1 5987.1 5992.6 6024.0 6064.3 6076.8 6084.8 6113.7 6138.2 5988.7 5993.9 6007.2 6029.6 6032.9 19:06:11 INFO - 2015-11-15 19:06:11,325 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,325 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12477.16 Median:26885.18 stddev:14827.37 (55.2%) stddev-sans-first:14842.56 19:06:11 INFO - 2015-11-15 19:06:11,327 DEBUG : BROWSER_OUTPUT: Values: 693.9 704.3 704.5 718.3 719.1 12272.7 12441.4 12486.4 12497.4 12633.4 12100.8 12107.6 12107.8 12110.9 12141.6 635.4 640.7 649.6 783.9 813.9 823.7 825.5 842.2 843.9 844.3 813.6 840.8 854.5 857.1 858.3 661.0 672.7 818.9 834.2 852.1 623.6 626.3 629.5 629.5 633.9 12266.0 12428.6 12446.4 12464.4 12470.7 10237.6 10416.4 10615.7 11024.2 11309.9 8616.7 8691.8 8853.3 8917.5 8938.1 3060.2 3080.0 3084.6 3099.9 3109.0 42369.6 42901.0 42925.0 42983.1 43112.4 8279.0 8563.4 8670.8 8673.0 8673.2 18116.5 18125.5 18235.7 18372.7 18374.5 6373.1 6458.5 6491.4 6603.0 6721.5 3214.7 3454.0 3522.8 3591.4 3631.2 2798.1 2830.3 2834.0 2835.1 2867.3 392.1 402.7 409.4 410.2 413.8 453.5 463.7 514.9 528.6 569.5 7321.0 7439.4 7444.7 7562.7 7596.2 427.7 499.1 523.9 559.7 571.1 3482.3 3506.9 3532.4 3538.7 3702.9 52676.5 53241.7 53717.2 53768.5 53842.0 46030.8 46966.8 48265.5 48272.0 48508.3 42273.0 42735.4 42753.4 43491.6 43802.3 7021.7 7100.6 7255.7 7366.6 7408.9 32517.8 33324.7 33457.2 33498.5 33812.7 39486.4 40814.4 41412.2 42185.4 42357.4 7045.8 7082.8 7148.0 7248.1 7330.3 10343.0 10383.2 10421.9 10459.9 10560.5 9929.1 9947.3 10003.1 10031.1 10132.1 9797.5 9826.7 9904.4 9907.7 9973.5 9580.2 9659.3 9697.9 9797.4 9845.7 8092.3 8137.3 8444.7 8833.4 9024.5 8201.0 8528.5 8554.1 8635.8 8667.8 19:06:11 INFO - 2015-11-15 19:06:11,327 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:06:11 INFO - 2015-11-15 19:06:11,327 DEBUG : BROWSER_OUTPUT: 19:06:11 INFO - 2015-11-15 19:06:11,988 INFO : Browser exited with error code: 0 19:06:12 INFO - 2015-11-15 19:06:12,017 INFO : Completed test dromaeo_css (00:18:36) 19:06:12 INFO - 2015-11-15 19:06:12,017 INFO : Starting test kraken 19:06:12 INFO - 2015-11-15 19:06:12,017 DEBUG : operating with platform_type : mac_ 19:06:12 INFO - 2015-11-15 19:06:12,018 INFO : Initialising browser for kraken test... 19:06:12 INFO - 2015-11-15 19:06:12,031 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpZ6mtY4/profile http://localhost:49274/getInfo.html 19:06:14 INFO - 2015-11-15 19:06:14,438 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:06:14 INFO - 2015-11-15 19:06:14,439 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:06:14 INFO - 2015-11-15 19:06:14,439 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:06:14 INFO - 2015-11-15 19:06:14,439 DEBUG : BROWSER_OUTPUT: __metrics 19:06:14 INFO - 2015-11-15 19:06:14,455 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:06:15 INFO - 2015-11-15 19:06:15,171 INFO : Browser initialized. 19:06:15 INFO - 2015-11-15 19:06:15,172 INFO : Running cycle 1/1 for kraken test... 19:06:15 INFO - 2015-11-15 19:06:15,172 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpZ6mtY4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:06:27 INFO - 2015-11-15 19:06:27,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 228282368 19:06:27 INFO - 2015-11-15 19:06:27,160 DEBUG : BROWSER_OUTPUT: 19:06:29 INFO - 2015-11-15 19:06:29,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:30 INFO - 2015-11-15 19:06:30,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 285450240 19:06:30 INFO - 2015-11-15 19:06:30,354 DEBUG : BROWSER_OUTPUT: 19:06:33 INFO - 2015-11-15 19:06:33,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 19:06:33 INFO - 2015-11-15 19:06:33,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 299556864 19:06:33 INFO - 2015-11-15 19:06:33,795 DEBUG : BROWSER_OUTPUT: 19:06:36 INFO - 2015-11-15 19:06:36,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 19:06:37 INFO - 2015-11-15 19:06:37,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 282394624 19:06:37 INFO - 2015-11-15 19:06:37,521 DEBUG : BROWSER_OUTPUT: 19:06:39 INFO - 2015-11-15 19:06:39,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 19:06:40 INFO - 2015-11-15 19:06:40,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 282144768 19:06:40 INFO - 2015-11-15 19:06:40,209 DEBUG : BROWSER_OUTPUT: 19:06:42 INFO - 2015-11-15 19:06:42,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:43 INFO - 2015-11-15 19:06:43,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 283348992 19:06:43 INFO - 2015-11-15 19:06:43,106 DEBUG : BROWSER_OUTPUT: 19:06:46 INFO - 2015-11-15 19:06:46,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:46 INFO - 2015-11-15 19:06:46,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 282210304 19:06:46 INFO - 2015-11-15 19:06:46,945 DEBUG : BROWSER_OUTPUT: 19:06:50 INFO - 2015-11-15 19:06:50,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:50 INFO - 2015-11-15 19:06:50,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 284131328 19:06:50 INFO - 2015-11-15 19:06:50,892 DEBUG : BROWSER_OUTPUT: 19:06:53 INFO - 2015-11-15 19:06:53,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 19:06:54 INFO - 2015-11-15 19:06:54,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 284037120 19:06:54 INFO - 2015-11-15 19:06:54,538 DEBUG : BROWSER_OUTPUT: 19:06:56 INFO - 2015-11-15 19:06:56,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:56 INFO - 2015-11-15 19:06:56,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 320450560 19:06:56 INFO - 2015-11-15 19:06:56,759 DEBUG : BROWSER_OUTPUT: 19:06:58 INFO - 2015-11-15 19:06:58,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:59 INFO - 2015-11-15 19:06:59,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 320569344 19:06:59 INFO - 2015-11-15 19:06:59,324 DEBUG : BROWSER_OUTPUT: 19:07:01 INFO - 2015-11-15 19:07:01,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:02 INFO - 2015-11-15 19:07:02,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 329101312 19:07:02 INFO - 2015-11-15 19:07:02,143 DEBUG : BROWSER_OUTPUT: 19:07:04 INFO - 2015-11-15 19:07:04,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:05 INFO - 2015-11-15 19:07:05,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 330108928 19:07:05 INFO - 2015-11-15 19:07:05,556 DEBUG : BROWSER_OUTPUT: 19:07:08 INFO - 2015-11-15 19:07:08,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:08 INFO - 2015-11-15 19:07:08,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 329588736 19:07:08 INFO - 2015-11-15 19:07:08,959 DEBUG : BROWSER_OUTPUT: 19:07:10 INFO - 2015-11-15 19:07:10,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 19:07:11 INFO - 2015-11-15 19:07:11,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 387817472 19:07:11 INFO - 2015-11-15 19:07:11,042 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,042 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:07:11 INFO - 2015-11-15 19:07:11,043 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:07:11 INFO - 2015-11-15 19:07:11,043 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:07:11 INFO - 2015-11-15 19:07:11,044 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:07:11 INFO - 2015-11-15 19:07:11,044 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;109;106;111;109;111;101;105;111;110 19:07:11 INFO - 2015-11-15 19:07:11,044 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;166;147;168;184;143;166;165;156;179;142 19:07:11 INFO - 2015-11-15 19:07:11,044 DEBUG : BROWSER_OUTPUT: |2;audio-dft;169;172;179;178;175;175;176;179;174;173 19:07:11 INFO - 2015-11-15 19:07:11,044 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;86;95;96;77;78;78;90;92;75 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;102;98;146;100;101;99;146;97;96;144 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;129;129;129;135;129;135;135;124;129;135 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;136;141;141;138;136;141;140;136;142;141 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;110;114;115;114;105;105;104;112;108;104 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;63;61;63;63;66;66;76;65;65 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;74;75;78;75;78;80;78;81;78 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;96;97;95;103;97;97;96;98;97 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;154;140;153;145;152;139;142;144;152;138 19:07:11 INFO - 2015-11-15 19:07:11,045 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;167;162;176;173;173;154;166;172;172;159 19:07:11 INFO - 2015-11-15 19:07:11,046 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;73;76;79;79;81;80;82;78;79 19:07:11 INFO - 2015-11-15 19:07:11,046 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:07:11 INFO - 2015-11-15 19:07:11,046 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:07:11 INFO - 2015-11-15 19:07:11,046 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 19:07:11 INFO - 2015-11-15 19:07:11,046 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:07:11 INFO - 2015-11-15 19:07:11,046 DEBUG : BROWSER_OUTPUT: __startTimestamp1447643231042__endTimestamp 19:07:11 INFO - 2015-11-15 19:07:11,046 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,048 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:07:11 INFO - 2015-11-15 19:07:11,048 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:07:11 INFO - 2015-11-15 19:07:11,048 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,048 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.31 (3.0%) stddev-sans-first:3.44 19:07:11 INFO - 2015-11-15 19:07:11,049 DEBUG : BROWSER_OUTPUT: Values: 106.0 109.0 106.0 111.0 109.0 111.0 101.0 105.0 111.0 110.0 19:07:11 INFO - 2015-11-15 19:07:11,049 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,049 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:161.60 Median:166.00 stddev:14.42 (8.7%) stddev-sans-first:15.20 19:07:11 INFO - 2015-11-15 19:07:11,049 DEBUG : BROWSER_OUTPUT: Values: 166.0 147.0 168.0 184.0 143.0 166.0 165.0 156.0 179.0 142.0 19:07:11 INFO - 2015-11-15 19:07:11,049 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,049 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:175.00 Median:175.50 stddev:3.20 (1.8%) stddev-sans-first:2.55 19:07:11 INFO - 2015-11-15 19:07:11,049 DEBUG : BROWSER_OUTPUT: Values: 169.0 172.0 179.0 178.0 175.0 175.0 176.0 179.0 174.0 173.0 19:07:11 INFO - 2015-11-15 19:07:11,050 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,050 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.60 Median:88.00 stddev:8.11 (9.2%) stddev-sans-first:8.35 19:07:11 INFO - 2015-11-15 19:07:11,050 DEBUG : BROWSER_OUTPUT: Values: 79.0 86.0 95.0 96.0 77.0 78.0 78.0 90.0 92.0 75.0 19:07:11 INFO - 2015-11-15 19:07:11,050 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,050 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:112.90 Median:121.00 stddev:22.46 (18.6%) stddev-sans-first:23.47 19:07:11 INFO - 2015-11-15 19:07:11,050 DEBUG : BROWSER_OUTPUT: Values: 102.0 98.0 146.0 100.0 101.0 99.0 146.0 97.0 96.0 144.0 19:07:11 INFO - 2015-11-15 19:07:11,051 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,051 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:130.90 Median:132.00 stddev:3.84 (2.9%) stddev-sans-first:4.01 19:07:11 INFO - 2015-11-15 19:07:11,051 DEBUG : BROWSER_OUTPUT: Values: 129.0 129.0 129.0 135.0 129.0 135.0 135.0 124.0 129.0 135.0 19:07:11 INFO - 2015-11-15 19:07:11,051 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,051 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:139.20 Median:141.00 stddev:2.44 (1.7%) stddev-sans-first:2.30 19:07:11 INFO - 2015-11-15 19:07:11,052 DEBUG : BROWSER_OUTPUT: Values: 136.0 141.0 141.0 138.0 136.0 141.0 140.0 136.0 142.0 141.0 19:07:11 INFO - 2015-11-15 19:07:11,052 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,052 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:109.10 Median:111.00 stddev:4.46 (4.0%) stddev-sans-first:4.72 19:07:11 INFO - 2015-11-15 19:07:11,052 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 115.0 114.0 105.0 105.0 104.0 112.0 108.0 104.0 19:07:11 INFO - 2015-11-15 19:07:11,052 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,052 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:4.42 (6.8%) stddev-sans-first:4.33 19:07:11 INFO - 2015-11-15 19:07:11,052 DEBUG : BROWSER_OUTPUT: Values: 60.0 63.0 61.0 63.0 63.0 66.0 66.0 76.0 65.0 65.0 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.60 Median:78.00 stddev:3.47 (4.4%) stddev-sans-first:2.35 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: Values: 69.0 74.0 75.0 78.0 75.0 78.0 80.0 78.0 81.0 78.0 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.30 Median:97.00 stddev:3.92 (4.0%) stddev-sans-first:2.29 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: Values: 87.0 96.0 97.0 95.0 103.0 97.0 97.0 96.0 98.0 97.0 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,053 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:148.50 stddev:6.28 (4.2%) stddev-sans-first:5.94 19:07:11 INFO - 2015-11-15 19:07:11,054 DEBUG : BROWSER_OUTPUT: Values: 154.0 140.0 153.0 145.0 152.0 139.0 142.0 144.0 152.0 138.0 19:07:11 INFO - 2015-11-15 19:07:11,054 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,054 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:172.00 stddev:7.15 (4.2%) stddev-sans-first:7.58 19:07:11 INFO - 2015-11-15 19:07:11,055 DEBUG : BROWSER_OUTPUT: Values: 167.0 162.0 176.0 173.0 173.0 154.0 166.0 172.0 172.0 159.0 19:07:11 INFO - 2015-11-15 19:07:11,055 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,055 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:79.00 stddev:3.28 (4.2%) stddev-sans-first:2.70 19:07:11 INFO - 2015-11-15 19:07:11,056 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 76.0 79.0 79.0 81.0 80.0 82.0 78.0 79.0 19:07:11 INFO - 2015-11-15 19:07:11,056 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:07:11 INFO - 2015-11-15 19:07:11,056 DEBUG : BROWSER_OUTPUT: 19:07:11 INFO - 2015-11-15 19:07:11,745 INFO : Browser exited with error code: 0 19:07:11 INFO - 2015-11-15 19:07:11,796 INFO : Completed test kraken (00:00:59) 19:07:11 INFO - 2015-11-15 19:07:11,796 INFO : Starting test v8_7 19:07:11 INFO - 2015-11-15 19:07:11,796 DEBUG : operating with platform_type : mac_ 19:07:11 INFO - 2015-11-15 19:07:11,796 INFO : Initialising browser for v8_7 test... 19:07:11 INFO - 2015-11-15 19:07:11,810 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpCKA6AN/profile http://localhost:49274/getInfo.html 19:07:14 INFO - 2015-11-15 19:07:14,129 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:07:14 INFO - 2015-11-15 19:07:14,129 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:07:14 INFO - 2015-11-15 19:07:14,129 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:07:14 INFO - 2015-11-15 19:07:14,129 DEBUG : BROWSER_OUTPUT: __metrics 19:07:14 INFO - 2015-11-15 19:07:14,145 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:07:14 INFO - 2015-11-15 19:07:14,942 INFO : Browser initialized. 19:07:14 INFO - 2015-11-15 19:07:14,942 INFO : Running cycle 1/1 for v8_7 test... 19:07:14 INFO - 2015-11-15 19:07:14,942 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpCKA6AN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:07:26 INFO - 2015-11-15 19:07:26,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 228728832 19:07:26 INFO - 2015-11-15 19:07:26,954 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/v8_7/run.html (next: http://localhost:49274/tests/v8_7/run.html) 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 575447040 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: |0;Richards;170.79419299743807 19:07:48 INFO - 2015-11-15 19:07:48,730 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;211.3718030014796 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |2;Encrypt;357.9098067287044 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6335.443037974684 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2083.3333333333335 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |5;Earley;997.0089730807578 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |6;Boyer;13794.520547945205 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |7;RegExp;31843.75 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |8;Splay;1295.483870967742 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6229.813664596273 19:07:48 INFO - 2015-11-15 19:07:48,731 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:07:48 INFO - 2015-11-15 19:07:48,732 DEBUG : BROWSER_OUTPUT: __startTimestamp1447643268727__endTimestamp 19:07:48 INFO - 2015-11-15 19:07:48,732 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,732 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:07:48 INFO - 2015-11-15 19:07:48,732 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:07:48 INFO - 2015-11-15 19:07:48,732 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,732 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.79 Median:170.79 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,732 DEBUG : BROWSER_OUTPUT: Values: 170.8 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:211.37 Median:211.37 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: Values: 211.4 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:357.91 Median:357.91 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: Values: 357.9 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6335.44 Median:6335.44 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: Values: 6335.4 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2083.33 Median:2083.33 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,733 DEBUG : BROWSER_OUTPUT: Values: 2083.3 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:997.01 Median:997.01 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: Values: 997.0 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13794.52 Median:13794.52 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: Values: 13794.5 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31843.75 Median:31843.75 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: Values: 31843.8 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1295.48 Median:1295.48 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: Values: 1295.5 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-15 19:07:48,734 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6229.81 Median:6229.81 stddev:0.00 (0.0%) 19:07:48 INFO - 2015-11-15 19:07:48,735 DEBUG : BROWSER_OUTPUT: Values: 6229.8 19:07:48 INFO - 2015-11-15 19:07:48,735 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:07:48 INFO - 2015-11-15 19:07:48,735 DEBUG : BROWSER_OUTPUT: 19:07:49 INFO - 2015-11-15 19:07:49,481 INFO : Browser exited with error code: 0 19:07:49 INFO - 2015-11-15 19:07:49,502 INFO : Completed test v8_7 (00:00:37) 19:07:49 INFO - 2015-11-15 19:07:49,804 INFO : Completed test suite (00:20:14) 19:07:49 INFO - 2015-11-15 19:07:49,805 DEBUG : Working with test: dromaeo_css 19:07:49 INFO - 2015-11-15 19:07:49,805 DEBUG : Generating results file: dromaeo_css 19:07:49 INFO - 2015-11-15 19:07:49,805 DEBUG : Working with test: kraken 19:07:49 INFO - 2015-11-15 19:07:49,806 DEBUG : Generating results file: kraken 19:07:49 INFO - 2015-11-15 19:07:49,806 INFO : javascript benchmark 19:07:49 INFO - 2015-11-15 19:07:49,806 DEBUG : Working with test: v8_7 19:07:49 INFO - 2015-11-15 19:07:49,806 DEBUG : Generating results file: v8_7 19:07:49 INFO - 2015-11-15 19:07:49,806 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:49 INFO - 2015-11-15 19:07:49,868 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 19:07:49 INFO - 2015-11-15 19:07:49,869 DEBUG : process_Request line: dromaeo_css 6327.00 graph.html#tests=[[72,1,55]] 19:07:49 INFO - 2015-11-15 19:07:49,869 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:49 INFO - 2015-11-15 19:07:49,896 DEBUG : process_Request line: kraken 1650.10 graph.html#tests=[[232,1,55]] 19:07:49 INFO - 2015-11-15 19:07:49,896 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:50 INFO - 2015-11-15 19:07:50,028 DEBUG : process_Request line: v8_7 15916.88 graph.html#tests=[[230,1,55]] 19:07:50 INFO - 2015-11-15 19:07:50,029 INFO : javascript benchmark 19:07:50 INFO - 2015-11-15 19:07:50,031 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [304.2803769086112, 306.37499501017925, 307.6923076923077, 311.6400557356254, 316.2804619490659, 12906.548270810523, 13310.93344533276, 15683.607909802246, 15899.920500397497, 16352.591185220375, 13243.536476223335, 13274.933625331883, 13285.26931018796, 13369.598912032654, 15078.246087695627, 3988.8005599720045, 4122.773247471388, 4168.520620128678, 4782.832600858979, 4965.379327584052, 3093.9845300773463, 3162.0829959311773, 3190.234343757493, 4237.6821738369745, 4305.311150215966, 6156.815295541119, 6401.423871851533, 6448.193975753031, 6483.481321494292, 6516.706748196319, 6206.565540412173, 6371.808845734636, 6382.819178452001, 6404.0, 6426.0360945858265, 5939.227900372967, 6127.356627554087, 6128.3258841527395, 6130.816075517741, 6151.446369826693, 20421.081051352725, 20940.267090651905, 21207.469813254636, 22591.435214119778, 22923.197688081003, 1889.5653999580175, 1929.366250548402, 1950.746402967605, 2067.400453868376, 2160.405888380692, 13214.73570528584, 13318.600441986757, 13641.317934103354, 13728.45086196551, 13983.860161398357, 1571.6228105254656, 1616.5958510372407, 1670.189957870432, 1728.6024214430752, 1733.3846484498074, 59291.40708592902, 60523.0, 60913.695431523, 61054.38945610532, 61471.38528614746, 14912.62718432048, 15564.844351556567, 15572.119157955814, 15731.0, 15828.920855395649, 22742.431439213822, 22777.31668049961, 22778.0, 22922.0, 23021.539569208522, 8018.719344822904, 8076.071251806117, 8109.797255068553, 8154.306883914815, 8184.281300926872, 6633.9668301658185, 6638.834029149213, 6655.334466553306, 6676.031975363545, 6711.060451536789, 7364.116306043202, 7452.478326517092, 7493.4379921505015, 7520.811979700551, 7527.736529221451, 2489.601663733794, 2921.28428535006, 2945.6465224173235, 3000.0, 3016.713412225835, 385.0086028476628, 386.1909300016461, 408.8834682115583, 424.6963421153828, 436.21263619167075, 9604.615815367446, 10073.949630251802, 10343.224258180666, 10419.791604167875, 10499.370037797757, 386.4677146645757, 405.7220803749441, 410.452046517896, 413.4686927298407, 441.3357896365949, 5353.0, 5621.747021384048, 5652.689102099424, 5665.6034077614995, 5681.886362272731, 88102.55948720344, 88380.0, 499972.0, 523862.0, 528228.0, 57601.71199143978, 58347.12479312814, 58579.70710146422, 61383.69308153431, 66136.6693166531, 447.23746013047673, 448.21338550843063, 450.1694373880186, 450.69127647561527, 456.04003572480116, 9842.901570984199, 9858.802823943337, 9949.950250248992, 10072.0, 10128.59485620567, 24875.25374238776, 27386.5892011624, 27511.86244068767, 27735.445291094467, 31607.0, 38141.0, 39004.21991560096, 39821.60178398179, 40022.799886000386, 40072.599274008055, 5386.245925570345, 5605.103183490622, 5624.353199382123, 5753.4246575343805, 5772.855678608068, 10475.161987040867, 10627.840582391425, 10713.571457141627, 10783.946080269548, 10834.891651083704, 9356.157945784911, 9390.201832844285, 9419.246460283299, 9497.952510237405, 9565.0, 9020.233280171258, 9184.219341355792, 9228.815423691623, 9236.307276954121, 9324.067593240621, 9352.859707104262, 9382.390144640576, 9697.709068727949, 9698.36960597559, 9800.754981125529, 5647.519960803378, 5651.773929042793, 5715.514181294637, 5723.627964182315, 5729.570282228766, 9123.498207598646, 9203.86194207074, 9219.539023048686, 9416.199623032118, 9508.429494230091], "dojo.html": [2923.693012233716, 2947.631546056743, 2971.598834157388, 3003.6846131156226, 3147.181732749485, 4740.383750112489, 4854.660173787836, 4879.39007624047, 4945.332380128686, 4995.550400463958, 4791.089692958335, 4852.5147485251455, 4856.927146092803, 4897.534734200245, 4983.725895075779, 4490.57339552742, 4498.212812757771, 4541.250693635546, 4591.334256532818, 4631.3516107744945, 4595.896984723676, 4615.423072115986, 4633.119707255611, 4648.535146485358, 4762.714237145782, 4356.542563030868, 4407.515173330963, 4503.301988191835, 4532.229520981441, 4601.033782905593, 4523.570260825217, 4524.298733696282, 4525.004499010245, 4570.520095389969, 4571.794269257892, 4471.910561788779, 4481.955180448186, 4521.525239849801, 4541.114482675879, 4593.885152871205, 4742.50203728607, 4750.667453278272, 4843.273508973647, 4855.441624213226, 4877.34155888954, 5151.871203219912, 5161.1742121260795, 5176.301199338116, 5201.193814958688, 5267.999080174793, 5215.0, 5236.423993360727, 5250.5274525292525, 5253.0, 5325.3875804282225, 4740.336352910595, 4767.713937163781, 4837.443693975168, 4861.319415281863, 4939.75301234944, 5419.83740487786, 5434.945650543444, 5436.10304299794, 5457.126859702428, 5464.562834973192, 5174.068667639785, 5175.508326708957, 5179.689218646893, 5181.5854731621375, 5249.0, 5013.448520662724, 5126.384833819965, 5142.6400151989, 5174.990876778992, 5388.0, 5164.1995490699, 5196.58427325813, 5201.985612805466, 5256.658317209369, 5259.368875734936, 5174.7930082796265, 5176.870578235499, 5185.740712964337, 5198.402183748842, 5246.081935661244, 3905.2970465316516, 3925.21495700861, 4007.438958545806, 4012.9799351003057, 4063.512378514597, 3628.401313783249, 3654.9817250914107, 3666.7799932004164, 3685.1155722626377, 3707.9073023174096, 4969.130402179604, 4976.0794253063295, 4982.800687972513, 5005.949940500621, 5022.271770593244, 5102.285680004802, 5174.922376164361, 5195.402528709171, 5198.896022079537, 5378.112611419072, 4969.229769385751, 4988.700677959261, 4997.750112494361, 5004.099262132779, 5046.091703493333, 4647.233206520887, 4672.112298663243, 4680.180968330528, 4703.435587729495, 4707.646926480527, 5290.550303224269, 5399.568034557305, 5435.048866448276, 5481.177823326533, 5527.364353099365, 5283.233931080049, 5291.656042357235, 5301.019311427398, 5341.572674186134, 5343.332083489564, 5492.505674489315, 5498.642588231752, 5541.3904470509015, 5569.860753481195, 5578.888422231614, 5033.370828646419, 5161.793528258828, 5231.3199284092825, 5234.136367499472, 5245.842624721265, 5219.164933610604, 5225.346831646044, 5288.709120998228, 5318.149096144598, 5322.387925388475, 5171.405288391883, 5178.456262092426, 5186.740662966912, 5190.792368305226, 5250.238715386171, 4970.3290055843445, 5125.718085505333, 5187.09225885461, 5187.688738675692, 5199.116150254541, 4975.303457516023, 5060.645754797276, 5065.493450655053, 5067.087924173684, 5106.131957567148, 5166.715830629201, 5180.093483640423, 5184.144616138295, 5196.9740151299, 5255.2379904912805, 4950.579200767975, 5099.133147365031, 5113.667611605234, 5124.769385377593, 5169.560587350117], "mootools.html": [1190.7142285851398, 1562.835902230266, 1641.2778377513894, 1649.1836540912243, 1672.1555614414726, 6786.423154031907, 6968.686409111596, 7096.751613693528, 7424.628768561563, 7467.8879816802655, 7224.0, 7349.118105827308, 7358.521696089764, 7377.557346559211, 7395.260473952602, 1855.4526414707693, 1914.1099388784212, 2127.7765834587376, 2149.9892500537476, 2159.2442645074257, 2071.6167509010806, 2117.502386939068, 2119.586680597284, 2121.734783152106, 2121.7772133925946, 2038.8980550972392, 2039.7654269758946, 2067.3694523170425, 2085.9987206141063, 2119.173522326294, 1813.8004819469847, 1844.382131985773, 2073.460900165953, 2097.4336929029155, 2130.7869213078725, 2102.863313884608, 2131.79747923947, 2136.060133541237, 2136.529963408048, 2137.4549489880137, 6804.08144900437, 6877.862442751117, 6897.310268973062, 6949.722011119549, 6980.511364204508, 4577.908441831178, 4688.320193571913, 4701.459332176809, 4710.788014539354, 4711.646626503026, 2668.8932442702267, 2680.6515153030177, 2713.66079240095, 2731.5219836528727, 2737.3567211705235, 824.7031068815222, 843.3127001493824, 849.0490650471511, 850.5832142250315, 863.6070587882498, 9815.0, 9820.165285950703, 9837.606495740161, 9849.113579777782, 9861.0, 4145.813438395279, 4194.832206711759, 4249.915001699948, 4257.744535327828, 4260.467441569804, 8498.872516912252, 8539.615717292736, 8550.0, 8568.914310856811, 8604.010538787994, 4670.906581868411, 4689.788959496763, 4694.647901407408, 4698.506656801055, 4707.976460117678, 4248.681348898845, 4254.553271906405, 4256.042390462121, 4263.360495925574, 4268.359746038057, 3489.267253876714, 3496.5629296337956, 3517.700995415418, 3537.7700449470703, 3555.8621241203086, 1122.0686829931137, 1136.6021892337615, 1144.793937091315, 1151.5106079916002, 1155.757290968889, 1186.7211205366732, 1217.446062041769, 1232.5686009896465, 1238.3003602964297, 1242.5526810348267, 6519.348065193442, 6590.3080176581725, 6961.686724097326, 7060.505764596429, 7070.151581810215, 592.351375244107, 601.0713447723278, 606.3966353478318, 618.7679620142446, 620.3393386043849, 5378.650387724785, 5386.461353864583, 5421.620486565903, 5431.945680543144, 5468.316460442445, 8653.913460865311, 8759.824803503894, 8873.91126088731, 8874.556272186364, 8876.068012858686, 8690.782730431663, 8763.25512331459, 8771.561421929006, 8780.868286975701, 8797.164269394398, 6759.932400675931, 6804.523683342119, 6870.27862074485, 6904.3095690430555, 6922.7923162305215, 6666.333366663489, 6688.030235615711, 6702.430293424918, 6716.1604799400075, 6718.328167183243, 7490.475666703496, 7711.460197786101, 7772.339351154989, 7780.84438311242, 7801.102873169431, 7800.141984381827, 8018.118007019107, 8041.276285134366, 8080.797980050545, 8134.877976830234, 5895.322037965518, 6418.069379939976, 6474.870502590016, 6480.805575832733, 6510.121133647087, 7107.360337569644, 7123.394511466583, 7142.9285707144345, 7150.356467917913, 7180.066591343092, 6572.737090516517, 6581.6709164542535, 6670.366315200048, 6697.09589205451, 6790.117284753148, 6484.902726459012, 6493.090967264681, 6599.142111525471, 6613.603183808795, 6621.106150669598, 6056.515478761777, 6260.217472815898, 6612.603243805194, 6634.137562116894, 6671.499637527108, 5803.0424979879535, 5883.411658834082, 5898.20374249488, 5935.910961335497, 5986.700664966821, 6086.995645718584, 6121.234845644294, 6123.601965872204, 6145.139680444652, 6169.5064394849205], "ext.html": [506.1597747738754, 511.1489370198619, 517.4179048570359, 521.9660722053067, 536.2787051415844, 28297.0, 29288.853555732218, 35777.10557236067, 36803.815980920124, 36854.81572592133, 37972.240555188946, 38225.42661860067, 38530.61469385305, 38615.80692096543, 38936.22127557447, 7432.070991126109, 8281.710140145111, 8478.279346255576, 8488.0, 8505.447145935525, 7482.401407887356, 7613.276738709841, 10155.847662285072, 10234.181265498779, 10252.692419227398, 10021.198304135653, 10113.544890479947, 10116.190704743603, 10117.898821011806, 10157.390556566592, 7576.166621671612, 9763.414195148243, 10039.799204015915, 10092.293539452241, 10101.54543045561, 7348.375388091965, 9793.265505087147, 9946.751331216705, 9987.550560224807, 10012.749681257954, 34855.825720871486, 35384.64615353839, 35438.64561354405, 35466.0, 35471.82264088689, 2613.751693589106, 2620.174644986842, 2655.9601605975927, 2735.8905643774224, 2901.245676124202, 25130.12044578431, 25995.870020649963, 26401.075962341227, 26491.0, 26607.20178394651, 2234.7765223477686, 2242.136777340719, 2259.5254996450767, 2272.6818245445484, 2340.1224540797202, 239828.0, 241291.0, 241635.0, 241742.0, 245393.0, 54156.45843541593, 54477.0, 54677.45322546803, 54856.451435485935, 54947.450525494234, 54245.0, 55126.72436637791, 59162.40837591655, 60666.696666516385, 60679.69660151759, 13089.0, 13168.341582920815, 13175.736485270432, 13185.670358241121, 13274.269915154566, 9852.802943941224, 9877.456739879231, 9880.40717556949, 9882.308238423242, 9936.056074672895, 17787.555311117325, 18121.275148993893, 18375.72436413455, 18424.539386515175, 18431.354902578347, 7718.652660630285, 8041.3968952328805, 8046.758597242092, 8097.959510202411, 8110.83778324442, 896.1002674330331, 901.2564634176699, 916.9867296637253, 1012.9797404051877, 1054.1988089052375, 25170.496590068095, 25332.366690832878, 25368.238952831445, 28988.27529311742, 30544.389112217632, 933.1042199488567, 954.4273435938381, 969.99030009699, 989.3766926836191, 1008.369768894441, 13027.876897857992, 13053.934730326288, 13168.539101131415, 13184.077114601885, 13190.076694631476, 353388.0, 361193.0, 362609.0, 363524.0, 364595.0, 48530.30143944945, 48576.0, 48764.51235487671, 49053.26420103701, 49091.0, 1250.3185763758772, 1263.260992319485, 1279.4498365702837, 1285.3508977966255, 1292.2246652008719, 24210.515789683755, 24551.263462096165, 24779.87610061938, 24840.37899052538, 24889.377765556004, 45664.31503527516, 46049.0, 46055.30917036314, 46310.07379852317, 46334.768326158155, 267408.0, 271733.0, 274644.0, 274711.0, 278195.0, 28182.43635127327, 28529.572056419587, 28633.284167895137, 28711.13866584006, 28872.2781930445, 36440.27119457649, 36504.81747591245, 37097.443538347485, 37310.813445932596, 37543.43684844784, 32385.514217286287, 32708.0, 33016.174595634344, 33053.0, 33240.1689957753, 34658.30683386369, 35541.28917421689, 35584.82207588945, 35685.1078723034, 35906.46140307845, 32493.67658778252, 32616.0, 33195.50206746852, 33320.3351530781, 33774.0, 28411.0, 28870.278243044093, 28914.421711566072, 29013.709862901946, 29119.85440072786, 22601.88699056494, 22712.65931011003, 22895.42761430911, 22974.885125574267, 23000.0], "prototype.html": [287.8359335178948, 292.4385180453529, 300.60320377102227, 301.71940095710994, 305.0436880380008, 5584.078627026536, 5620.156976453534, 5706.0, 5728.169415434764, 5760.423957604243, 5597.580181486394, 5669.8582535436635, 5738.913916291249, 5740.827775166741, 5757.913631295534, 4399.802008909607, 4400.031992961543, 4412.735235885841, 4415.0, 4452.977735111336, 4206.747595144301, 4311.590398912114, 4320.049589090395, 4359.4768627764715, 4408.228560002003, 4337.1325734853, 4348.7825608719595, 4379.146066517031, 4400.581944715247, 4409.933850992237, 4281.250781113308, 4332.718373305725, 4354.412154359153, 4373.300271956472, 4381.912361752779, 3655.0, 3721.5348081489815, 3773.8301776419853, 3797.4493698413853, 3803.1823158021157, 5328.280682107905, 5522.530584900288, 5523.751431185566, 5572.164175373686, 5659.292588426447, 4950.0, 4954.182559877616, 4959.8016079356785, 4960.70235785854, 4979.701217926936, 5769.365369809318, 6060.969695151496, 6084.209052823105, 6094.817155485298, 6123.2652081750475, 4014.1770936957855, 4016.2369149861433, 4050.756954582705, 4128.298189307825, 4138.606832350922, 6255.468285195764, 6306.211723534559, 6335.968320158462, 6368.0, 6405.071264666643, 4141.399497072907, 4180.372944058355, 4184.184084103571, 4207.200631879933, 4207.221663992172, 4117.526484454266, 4210.32634778434, 4225.3873188387515, 4243.257429949746, 4258.127083947783, 4879.536444037811, 4892.2661600760175, 4898.706077635354, 4904.55858972687, 4904.730239836772, 5999.0, 6012.6392416455155, 6033.793241351747, 6037.516998640098, 6042.607230530001, 1490.299559207171, 1500.4523348977764, 1500.8949373543965, 1504.1050574907913, 1505.284989629917, 966.2173639352147, 987.3631507677651, 988.6984469736799, 993.145894530703, 1006.6677996261362, 5815.098659707752, 5841.474267315962, 5845.240118784531, 5863.882722345529, 5869.295684517885, 6263.279722831841, 6264.906026409608, 6280.026595877646, 6282.340354262737, 6306.49548036156, 5830.4461076197695, 5842.970785146047, 5844.620099693507, 5852.824415267549, 5857.88284234313, 3245.188702824294, 3376.037829218661, 3399.5240666306736, 3400.0819778659625, 3429.7599168058496, 6539.738410463528, 6551.344865513506, 6564.376384243585, 6574.112494813139, 6611.933880661228, 6425.325340839145, 6438.0, 6455.096286519891, 6455.677216139175, 6490.2536208335705, 6300.936990630126, 6555.901661475082, 6567.44176744982, 6576.177977752685, 6578.243501997332, 6050.606710563799, 6259.061140828912, 6273.0, 6299.464545513682, 6304.810855674337, 6013.458788708862, 6040.305364882919, 6110.144579758926, 6132.0, 6192.535559832941, 6546.214454265328, 6619.205695316593, 6619.867602647823, 6621.834454138685, 6636.634985075674, 4228.450301460914, 4236.745795252295, 4246.787660616895, 4256.723312984646, 4306.892327691708, 6070.605410648471, 6277.340879207617, 6300.71646775887, 6307.085472606538, 6315.242170939517, 6106.847328816637, 6117.265928088658, 6122.479589234965, 6136.7852125175405, 6167.951448253897, 6116.357782432959, 6124.203853499017, 6130.846728831815, 6139.3553676863285, 6167.290761562298, 5828.853668696513, 5956.106584012433, 5987.101934709654, 5992.550558708027, 6024.036154215304, 6064.3026052002815, 6076.817695469143, 6084.847878803065, 6113.67680281508, 6138.232720909887, 5988.6706231157705, 5993.940060599338, 6007.158997740407, 6029.60807547508, 6032.939670603413], "yui.html": [693.8716337477564, 704.27459716492, 704.464606898757, 718.2960698515454, 719.0939416335423, 12272.693182670426, 12441.440135193916, 12486.438110285037, 12497.375131243447, 12633.431495582709, 12100.757984840298, 12107.636770896865, 12107.757844843098, 12110.939445302783, 12141.57504487343, 635.4154178156108, 640.6668532363168, 649.5745286837106, 783.8824176373532, 813.947093438926, 823.6581818545327, 825.5459497276504, 842.2209456252972, 843.8945131858518, 844.2865778417228, 813.6419975210918, 840.7771940435758, 854.5043874552775, 857.1214505132258, 858.3047731337605, 661.0480907493194, 672.6603065451916, 818.9058258300312, 834.1991687979547, 852.1478521478522, 623.5853157650157, 626.2578844069747, 629.527854109418, 629.5498718416354, 633.8922383194868, 12266.0, 12428.62714118578, 12446.381970343888, 12464.376781160996, 12470.688232794253, 10237.590496380137, 10416.375017498975, 10615.681529554126, 11024.173187011007, 11309.886901130965, 8616.741497755078, 8691.826163476759, 8853.291736661116, 8917.464952102895, 8938.0615035421, 3060.219643990768, 3079.969200307991, 3084.568160457538, 3099.876004959799, 3108.9895783870334, 42369.57630423687, 42901.0, 42925.0, 42983.14033719308, 43112.3533147003, 8278.958605207055, 8563.400561960727, 8670.826583468295, 8673.0, 8673.176048275403, 18116.547086322684, 18125.456236312933, 18235.72646410305, 18372.724409133873, 18374.54063648393, 6373.107764912916, 6458.483321334282, 6491.350864913471, 6602.966985165043, 6721.4958878084335, 3214.6785321467664, 3454.0, 3522.7710198836994, 3591.425371940477, 3631.2192878530714, 2798.0766347105405, 2830.3348713052414, 2834.0, 2835.078599455185, 2867.311845157147, 392.0903503870992, 402.6677990657661, 409.37570205436947, 410.24924388369215, 413.8220565156951, 453.48755905826204, 463.666160364537, 514.8827045311683, 528.6220352447941, 569.5073761196535, 7321.0, 7439.367653749492, 7444.664990075459, 7562.697492100365, 7596.202398748052, 427.7091577727113, 499.11407252127765, 523.9345081864767, 559.6949662433983, 571.0577547047405, 3482.2513159670793, 3506.9123271917897, 3532.364174448624, 3538.6992105670793, 3702.851885924587, 52676.473235267156, 53241.73379133079, 53717.19424208562, 53768.462315377124, 53842.0, 46030.76984615123, 46966.76516617395, 48265.5173448268, 48272.0, 48508.27237591439, 42273.0, 42735.35896961548, 42753.35869961953, 43491.565084349386, 43802.342964855554, 7021.719131234898, 7100.609466479394, 7255.673494692646, 7366.558006519626, 7408.888866667112, 32517.837410812794, 33324.66675333216, 33457.163570910925, 33498.49752253767, 33812.661873381934, 39486.40770388389, 40814.38778418267, 41412.171756564094, 42185.36721949112, 42357.36463952981, 7045.788626341218, 7082.787516374517, 7147.964260178665, 7248.130224373109, 7330.266973302627, 10343.0, 10383.2212584055, 10421.895781042092, 10459.947700261755, 10560.524776385235, 9929.056739609725, 9947.253955953187, 10003.099721025143, 10031.097201251923, 10132.088112069949, 9797.510124493889, 9826.705198844045, 9904.405735655884, 9907.702768916944, 9973.451460169761, 9580.233581313618, 9659.32384733062, 9697.854532182164, 9797.412155270707, 9845.655402060893, 8092.312153466786, 8137.3490120791375, 8444.746657600283, 8833.381663283508, 9024.548772561215, 8200.958995204986, 8528.488290702579, 8554.059053504234, 8635.834162387997, 8667.82664346697]}, "summary": {"lowerIsBetter": false, "suite": 6326.999193456288, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7356.146875810648, "unit": "ms", "value": 7356.146875810648}, "dojo.html": {"lowerIsBetter": false, "filtered": 4868.676337137925, "unit": "ms", "value": 4868.676337137925}, "mootools.html": {"lowerIsBetter": false, "filtered": 4152.079675538417, "unit": "ms", "value": 4152.079675538417}, "ext.html": {"lowerIsBetter": false, "filtered": 17078.16689730165, "unit": "ms", "value": 17078.16689730165}, "prototype.html": {"lowerIsBetter": false, "filtered": 4546.078912094776, "unit": "ms", "value": 4546.078912094776}, "yui.html": {"lowerIsBetter": false, "filtered": 5555.733019995931, "unit": "ms", "value": 5555.733019995931}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0080"}, "testrun": {"date": 1447642055, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115175333", "branch": "Firefox", "revision": "4b04af1dc5f5a99e44905777c2117424d819c3a0"}}, {"talos_counters": {}, "results": {"audio-dft": [169.0, 172.0, 179.0, 178.0, 175.0, 175.0, 176.0, 179.0, 174.0, 173.0], "ai-astar": [106.0, 109.0, 106.0, 111.0, 109.0, 111.0, 101.0, 105.0, 111.0, 110.0], "imaging-gaussian-blur": [129.0, 129.0, 129.0, 135.0, 129.0, 135.0, 135.0, 124.0, 129.0, 135.0], "audio-beat-detection": [166.0, 147.0, 168.0, 184.0, 143.0, 166.0, 165.0, 156.0, 179.0, 142.0], "json-stringify-tinderbox": [69.0, 74.0, 75.0, 78.0, 75.0, 78.0, 80.0, 78.0, 81.0, 78.0], "stanford-crypto-pbkdf2": [167.0, 162.0, 176.0, 173.0, 173.0, 154.0, 166.0, 172.0, 172.0, 159.0], "json-parse-financial": [60.0, 63.0, 61.0, 63.0, 63.0, 66.0, 66.0, 76.0, 65.0, 65.0], "stanford-crypto-sha256-iterative": [72.0, 73.0, 76.0, 79.0, 79.0, 81.0, 80.0, 82.0, 78.0, 79.0], "audio-fft": [79.0, 86.0, 95.0, 96.0, 77.0, 78.0, 78.0, 90.0, 92.0, 75.0], "imaging-darkroom": [136.0, 141.0, 141.0, 138.0, 136.0, 141.0, 140.0, 136.0, 142.0, 141.0], "stanford-crypto-ccm": [154.0, 140.0, 153.0, 145.0, 152.0, 139.0, 142.0, 144.0, 152.0, 138.0], "audio-oscillator": [102.0, 98.0, 146.0, 100.0, 101.0, 99.0, 146.0, 97.0, 96.0, 144.0], "stanford-crypto-aes": [87.0, 96.0, 97.0, 95.0, 103.0, 97.0, 97.0, 96.0, 98.0, 97.0], "imaging-desaturate": [110.0, 114.0, 115.0, 114.0, 105.0, 105.0, 104.0, 112.0, 108.0, 104.0]}, "summary": {"lowerIsBetter": true, "suite": 1650.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 84.6, "unit": "ms", "value": 84.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 167.4, "unit": "ms", "value": 167.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 145.9, "unit": "ms", "value": 145.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 139.2, "unit": "ms", "value": 139.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 64.8, "unit": "ms", "value": 64.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 112.9, "unit": "ms", "value": 112.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.9, "unit": "ms", "value": 107.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 175.0, "unit": "ms", "value": 175.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 77.9, "unit": "ms", "value": 77.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 76.6, "unit": "ms", "value": 76.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 130.9, "unit": "ms", "value": 130.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 96.3, "unit": "ms", "value": 96.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0080"}, "testrun": {"date": 1447642055, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115175333", "branch": "Firefox", "revision": "4b04af1dc5f5a99e44905777c2117424d819c3a0"}}, {"talos_counters": {}, "results": {"DeltaBlue": [211.3718030014796], "Encrypt": [357.9098067287044], "NavierStokes": [6229.813664596273], "Decrypt": [6335.443037974684], "Splay": [1295.483870967742], "Richards": [170.79419299743807], "RegExp": [31843.75], "Earley": [997.0089730807578], "Boyer": [13794.520547945205], "RayTrace": [2083.3333333333335]}, "summary": {"lowerIsBetter": false, "suite": 15916.877359163018, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 312.80425800000006, "unit": "score", "value": 312.80425800000006}, "Encrypt": {"lowerIsBetter": false, "filtered": 743.7097140000003, "unit": "score", "value": 743.7097140000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 238.20937188434678, "unit": "score", "value": 238.20937188434678}, "Decrypt": {"lowerIsBetter": false, "filtered": 42.01458341658341, "unit": "score", "value": 42.01458341658341}, "Splay": {"lowerIsBetter": false, "filtered": 62.90390936254981, "unit": "score", "value": 62.90390936254981}, "RegExp": {"lowerIsBetter": false, "filtered": 28.60796859666341, "unit": "score", "value": 28.60796859666341}, "Richards": {"lowerIsBetter": false, "filtered": 206.69320999999994, "unit": "score", "value": 206.69320999999994}, "Earley": {"lowerIsBetter": false, "filtered": 668.4623889999998, "unit": "score", "value": 668.4623889999998}, "Boyer": {"lowerIsBetter": false, "filtered": 48.31360377358492, "unit": "score", "value": 48.31360377358492}, "RayTrace": {"lowerIsBetter": false, "filtered": 355.19471999999996, "unit": "score", "value": 355.19471999999996}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0080"}, "testrun": {"date": 1447642055, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115175333", "branch": "Firefox", "revision": "4b04af1dc5f5a99e44905777c2117424d819c3a0"}}] 19:07:50 INFO - RETURN: dromaeo_css: 6327.00 19:07:50 INFO - RETURN: kraken: 1650.10 19:07:50 INFO - RETURN: v8_7: 15916.88 19:07:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "15916.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1650.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6327.00"}}} 19:07:50 INFO - Return code: 0 19:07:50 INFO - # TBPL SUCCESS # 19:07:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:07:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:07:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:07:50 INFO - 2015-11-15 19:07:50.124 screenresolution[1664:10823] starting screenresolution argv=screenresolution get 19:07:50 INFO - 2015-11-15 19:07:50.127 screenresolution[1664:10823] Display 0: 1600x1200x32@60 19:07:50 INFO - 2015-11-15 19:07:50.133 screenresolution[1665:10826] starting screenresolution argv=screenresolution list 19:07:50 INFO - Available Modes on Display 0 19:07:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:07:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:07:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:07:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:07:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:07:50 INFO - Intel HD Graphics 3000: 19:07:50 INFO - Chipset Model: Intel HD Graphics 3000 19:07:50 INFO - Type: GPU 19:07:50 INFO - Bus: Built-In 19:07:50 INFO - VRAM (Total): 512 MB 19:07:50 INFO - VRAM (Dynamic, Max): 10 19:07:50 INFO - Vendor: Intel (0x8086) 19:07:50 INFO - Device ID: 0x0116 19:07:50 INFO - Revision ID: 0x0009 19:07:50 INFO - Displays: 19:07:50 INFO - Display: 19:07:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:07:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:07:50 INFO - Display Serial Number: 1600x1200 60 19:07:50 INFO - Main Display: Yes 19:07:50 INFO - Mirror: Off 19:07:50 INFO - Online: Yes 19:07:50 INFO - Rotation: Supported 19:07:50 INFO - Return code: 0 19:07:50 INFO - Running post-action listener: _resource_record_post_action 19:07:50 INFO - Running post-run listener: _resource_record_post_run 19:07:51 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 40494080; Write bytes: 689548288; Read time: 6144; Write time: 54401 19:07:51 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 338784768; Write bytes: 336660480; Read time: 34628; Write time: 9072 19:07:51 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 38552576; Write bytes: 341672960; Read time: 5631; Write time: 44783 19:07:51 INFO - Running post-run listener: _upload_blobber_files 19:07:51 INFO - Blob upload gear active. 19:07:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:07:51 INFO - Copying logs to upload dir... 19:07:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.277741 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-11-15 19:07:51.536061) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 19:07:51.540428) ========= 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.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010190 build_url: 'https://queue.taskcluster.net/v1/task/ps47_epGSXCNA2i6vu18hQ/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-15 19:07:51.569376) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 19:07:51.569831) ========= 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.5YEixAZtEU/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.rniHp7VxmD/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005545 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 19:07:51.619991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 19:07:51.620354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 19:07:51.620861) ========= ========= Total master_lag: 0.50 =========