builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1448002831.66 results: success (0) buildid: 20151119205634 builduid: 704f9cb67ce845c4a415f3bc386b24e4 revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.665223) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.665655) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.665972) ========= 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.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005569 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.685894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.686205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.702052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.702505) ========= 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.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005358 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.751314) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.751626) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.751977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.752312) ========= 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.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 23:00:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-19 23:00:31 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184740 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.950706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:31.951048) ========= 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.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:32.000247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:32.000614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 23:00:32,070 truncating revision to first 12 chars 2015-11-19 23:00:32,070 Setting DEBUG logging. 2015-11-19 23:00:32,070 attempt 1/10 2015-11-19 23:00:32,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 23:00:32,791 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.967865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:32.982841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:32.983166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:32.994548) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:32.994885) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 23:00:32.995332) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 23:00:32.995624) ========= /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.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 23:00:33 INFO - MultiFileLogger online at 20151119 23:00:33 in /builds/slave/test 23:00:33 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 23:00:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:00:33 INFO - {'append_to_log': False, 23:00:33 INFO - 'base_work_dir': '/builds/slave/test', 23:00:33 INFO - 'blob_upload_branch': 'Firefox', 23:00:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:00:33 INFO - 'branch': 'Firefox', 23:00:33 INFO - 'buildbot_json_path': 'buildprops.json', 23:00:33 INFO - 'config_files': ('talos/mac_config.py',), 23:00:33 INFO - 'default_actions': ('clobber', 23:00:33 INFO - 'read-buildbot-config', 23:00:33 INFO - 'download-and-extract', 23:00:33 INFO - 'populate-webroot', 23:00:33 INFO - 'create-virtualenv', 23:00:33 INFO - 'install', 23:00:33 INFO - 'run-tests'), 23:00:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:00:33 INFO - 'download_minidump_stackwalk': True, 23:00:33 INFO - 'download_symbols': 'ondemand', 23:00:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:00:33 INFO - 'tooltool.py': '/tools/tooltool.py', 23:00:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:00:33 INFO - '/tools/misc-python/virtualenv.py')}, 23:00:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:00:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:00:33 INFO - 'installer_path': 'installer.exe', 23:00:33 INFO - 'log_level': 'info', 23:00:33 INFO - 'log_name': 'talos', 23:00:33 INFO - 'log_to_console': True, 23:00:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:00:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:00:33 INFO - 'opt_config_files': (), 23:00:33 INFO - 'pip_index': False, 23:00:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:00:33 INFO - 'cmd': ('bash', 23:00:33 INFO - '-c', 23:00:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:00:33 INFO - 'enabled': True, 23:00:33 INFO - 'halt_on_failure': False, 23:00:33 INFO - 'name': 'check_screen_resolution'},), 23:00:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:00:33 INFO - 'cmd': ('bash', 23:00:33 INFO - '-c', 23:00:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:00:33 INFO - 'enabled': True, 23:00:33 INFO - 'halt_on_failure': False, 23:00:33 INFO - 'name': 'check_screen_resolution'},), 23:00:33 INFO - 'run_cmd_checks_enabled': True, 23:00:33 INFO - 'sps_profile': False, 23:00:33 INFO - 'sps_profile_interval': 0, 23:00:33 INFO - 'suite': 'dromaeojs', 23:00:33 INFO - 'system_bits': '64', 23:00:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:00:33 INFO - 'title': 't-yosemite-r7-0036', 23:00:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:00:33 INFO - 'use_talos_json': True, 23:00:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:00:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:00:33 INFO - 'work_dir': 'build'} 23:00:33 INFO - ##### 23:00:33 INFO - ##### Running clobber step. 23:00:33 INFO - ##### 23:00:33 INFO - Running pre-action listener: _resource_record_pre_action 23:00:33 INFO - Running main action method: clobber 23:00:33 INFO - rmtree: /builds/slave/test/build 23:00:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:00:34 INFO - Running post-action listener: _resource_record_post_action 23:00:34 INFO - ##### 23:00:34 INFO - ##### Running read-buildbot-config step. 23:00:34 INFO - ##### 23:00:34 INFO - Running pre-action listener: _resource_record_pre_action 23:00:34 INFO - Running main action method: read_buildbot_config 23:00:34 INFO - Using buildbot properties: 23:00:34 INFO - { 23:00:34 INFO - "properties": { 23:00:34 INFO - "buildnumber": 2, 23:00:34 INFO - "product": "firefox", 23:00:34 INFO - "script_repo_revision": "production", 23:00:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 23:00:34 INFO - "repository": "", 23:00:34 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 23:00:34 INFO - "buildid": "20151119205634", 23:00:34 INFO - "slavename": "t-yosemite-r7-0036", 23:00:34 INFO - "pgo_build": "False", 23:00:34 INFO - "basedir": "/builds/slave/test", 23:00:34 INFO - "project": "", 23:00:34 INFO - "platform": "yosemite_r7", 23:00:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:00:34 INFO - "slavebuilddir": "test", 23:00:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:00:34 INFO - "branch": "mozilla-central", 23:00:34 INFO - "repo_path": "mozilla-central", 23:00:34 INFO - "stage_platform": "macosx64", 23:00:34 INFO - "builduid": "704f9cb67ce845c4a415f3bc386b24e4", 23:00:34 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 23:00:34 INFO - }, 23:00:34 INFO - "sourcestamp": { 23:00:34 INFO - "repository": "", 23:00:34 INFO - "hasPatch": false, 23:00:34 INFO - "project": "", 23:00:34 INFO - "branch": "mozilla-central-macosx64-talos", 23:00:34 INFO - "changes": [ 23:00:34 INFO - { 23:00:34 INFO - "category": null, 23:00:34 INFO - "files": [ 23:00:34 INFO - { 23:00:34 INFO - "url": null, 23:00:34 INFO - "name": "https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 23:00:34 INFO - } 23:00:34 INFO - ], 23:00:34 INFO - "repository": "", 23:00:34 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 23:00:34 INFO - "who": "philringnalda@gmail.com", 23:00:34 INFO - "when": 1448002552, 23:00:34 INFO - "number": 6687115, 23:00:34 INFO - "comments": "Backed out 2 changesets (bug 1225007) for frequent OS X \"Shouldn't return empty rect\" assertion failures, a=backout\n\nBacked out changeset c5b352c74b35 (bug 1225007)\nBacked out changeset 8a513c70ce7c (bug 1225007)", 23:00:34 INFO - "project": "", 23:00:34 INFO - "at": "Thu 19 Nov 2015 22:55:52", 23:00:34 INFO - "branch": "mozilla-central-macosx64-talos", 23:00:34 INFO - "revlink": "", 23:00:34 INFO - "properties": [ 23:00:34 INFO - [ 23:00:34 INFO - "buildid", 23:00:34 INFO - "20151119205634", 23:00:34 INFO - "Change" 23:00:34 INFO - ], 23:00:34 INFO - [ 23:00:34 INFO - "builduid", 23:00:34 INFO - "704f9cb67ce845c4a415f3bc386b24e4", 23:00:34 INFO - "Change" 23:00:34 INFO - ], 23:00:34 INFO - [ 23:00:34 INFO - "pgo_build", 23:00:34 INFO - "False", 23:00:34 INFO - "Change" 23:00:34 INFO - ] 23:00:34 INFO - ], 23:00:34 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 23:00:34 INFO - } 23:00:34 INFO - ], 23:00:34 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 23:00:34 INFO - } 23:00:34 INFO - } 23:00:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 23:00:34 INFO - Running post-action listener: _resource_record_post_action 23:00:34 INFO - ##### 23:00:34 INFO - ##### Running download-and-extract step. 23:00:34 INFO - ##### 23:00:34 INFO - Running pre-action listener: _resource_record_pre_action 23:00:34 INFO - Running main action method: download_and_extract 23:00:34 INFO - mkdir: /builds/slave/test/build/tests 23:00: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')]} 23:00:34 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json 23:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json 23:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:00:35 INFO - Downloaded 1149 bytes. 23:00:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:00:35 INFO - Using the following test package requirements: 23:00:35 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:00:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:00:35 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 23:00:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:00:35 INFO - u'jsshell-mac.zip'], 23:00:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:00:35 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 23:00:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:00:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:00:35 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 23:00:35 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:00:35 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 23:00:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:00:35 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 23:00:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:00:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:00:35 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 23:00:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:00: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')]} 23:00:35 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:00:36 INFO - Downloaded 17522529 bytes. 23:00:36 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 23:00:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:00:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:00:39 INFO - Return code: 0 23:00:39 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 23:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:39 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:00:45 INFO - Downloaded 17522529 bytes. 23:00:45 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 23:00:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:00:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:00:48 INFO - Return code: 0 23:00: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')]} 23:00:48 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:00:49 INFO - Downloaded 11130997 bytes. 23:00:49 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 23:00:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:00:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 23:00:49 INFO - Return code: 0 23:00:49 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')]} 23:00:49 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 23:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:00:52 INFO - Downloaded 109421022 bytes. 23:00:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:00:52 INFO - mkdir: /builds/slave/test/properties 23:00:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:00:52 INFO - Writing to file /builds/slave/test/properties/build_url 23:00:52 INFO - Contents: 23:00:52 INFO - build_url:https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:00:52 INFO - Running post-action listener: _resource_record_post_action 23:00:52 INFO - Running post-action listener: set_extra_try_arguments 23:00:52 INFO - ##### 23:00:52 INFO - ##### Running populate-webroot step. 23:00:52 INFO - ##### 23:00:52 INFO - Running pre-action listener: _resource_record_pre_action 23:00:52 INFO - Running main action method: populate_webroot 23:00:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:00:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:00:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 23:00:52 INFO - '../fennec_ids.txt'], 23:00:52 INFO - 'tests': ['tcheck2']}, 23:00:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:00:52 INFO - '--tppagecycles', 23:00:52 INFO - '7'], 23:00:52 INFO - 'tests': ['tsvgm']}}, 23:00:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:00:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:00:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:00:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:00:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'tests': ['damp', 'tps']}, 23:00:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['damp', 'tps']}, 23:00:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:00:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:00:52 INFO - 'other': {'tests': ['a11yr', 23:00:52 INFO - 'ts_paint', 23:00:52 INFO - 'tpaint', 23:00:52 INFO - 'sessionrestore', 23:00:52 INFO - 'sessionrestore_no_auto_restore']}, 23:00:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['a11yr', 23:00:52 INFO - 'ts_paint', 23:00:52 INFO - 'tpaint', 23:00:52 INFO - 'sessionrestore', 23:00:52 INFO - 'sessionrestore_no_auto_restore']}, 23:00:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['a11yr', 23:00:52 INFO - 'ts_paint', 23:00:52 INFO - 'tpaint', 23:00:52 INFO - 'sessionrestore', 23:00:52 INFO - 'sessionrestore_no_auto_restore']}, 23:00:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['a11yr', 23:00:52 INFO - 'ts_paint', 23:00:52 INFO - 'tpaint', 23:00:52 INFO - 'sessionrestore', 23:00:52 INFO - 'sessionrestore_no_auto_restore']}, 23:00:52 INFO - 'other_l64': {'tests': ['a11yr', 23:00:52 INFO - 'ts_paint', 23:00:52 INFO - 'tpaint', 23:00:52 INFO - 'sessionrestore', 23:00:52 INFO - 'sessionrestore_no_auto_restore']}, 23:00:52 INFO - 'other_nol64': {'tests': ['a11yr', 23:00:52 INFO - 'ts_paint', 23:00:52 INFO - 'tpaint', 23:00:52 INFO - 'sessionrestore', 23:00:52 INFO - 'sessionrestore_no_auto_restore']}, 23:00:52 INFO - 'svgr': {'tests': ['tsvgx', 23:00:52 INFO - 'tsvgr_opacity', 23:00:52 INFO - 'tart', 23:00:52 INFO - 'tscrollx', 23:00:52 INFO - 'cart']}, 23:00:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['tsvgx', 23:00:52 INFO - 'tsvgr_opacity', 23:00:52 INFO - 'tart', 23:00:52 INFO - 'tscrollx', 23:00:52 INFO - 'cart']}, 23:00:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'tests': ['tp5o']}, 23:00:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'talos_options': ['--e10s'], 23:00:52 INFO - 'tests': ['tp5o']}, 23:00:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'talos_options': ['--xperf_path', 23:00:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:52 INFO - 'tests': ['tp5n']}, 23:00:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:52 INFO - 'talos_options': ['--e10s', 23:00:52 INFO - '--xperf_path', 23:00:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:52 INFO - 'tests': ['tp5n']}}, 23:00:52 INFO - 'talos.zip': {'path': '', 23:00:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:00:52 INFO - Running post-action listener: _resource_record_post_action 23:00:52 INFO - ##### 23:00:52 INFO - ##### Running create-virtualenv step. 23:00:52 INFO - ##### 23:00:52 INFO - Running pre-action listener: _resource_record_pre_action 23:00:52 INFO - Running main action method: create_virtualenv 23:00:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:00:52 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 23:00:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:00:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:00:52 INFO - Using real prefix '/tools/python27' 23:00:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:00:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:00:56 INFO - Installing pip.................done. 23:00:56 INFO - Return code: 0 23:00:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:56 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 0x1104ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc072c867c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:00:56 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 23:00:56 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 23:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:00:56 INFO - 'HOME': '/Users/cltbld', 23:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:00:56 INFO - 'LOGNAME': 'cltbld', 23:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:56 INFO - 'MOZ_NO_REMOTE': '1', 23:00:56 INFO - 'NO_EM_RESTART': '1', 23:00:56 INFO - 'PAGER': '/bin/cat', 23:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:56 INFO - 'PWD': '/builds/slave/test', 23:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:00:56 INFO - 'SHELL': '/bin/bash', 23:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:00:56 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:00:56 INFO - 'USER': 'cltbld', 23:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:56 INFO - 'XPC_FLAGS': '0x0', 23:00:56 INFO - 'XPC_SERVICE_NAME': '0', 23:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:56 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 23:00:56 INFO - Cleaning up... 23:00:56 INFO - Return code: 0 23:00:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:56 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 0x1104ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc072c867c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:00:56 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 23:00:56 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 23:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:00:56 INFO - 'HOME': '/Users/cltbld', 23:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:00:56 INFO - 'LOGNAME': 'cltbld', 23:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:56 INFO - 'MOZ_NO_REMOTE': '1', 23:00:56 INFO - 'NO_EM_RESTART': '1', 23:00:56 INFO - 'PAGER': '/bin/cat', 23:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:56 INFO - 'PWD': '/builds/slave/test', 23:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:00:56 INFO - 'SHELL': '/bin/bash', 23:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:00:56 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:00:56 INFO - 'USER': 'cltbld', 23:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:56 INFO - 'XPC_FLAGS': '0x0', 23:00:56 INFO - 'XPC_SERVICE_NAME': '0', 23:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:57 INFO - Downloading/unpacking psutil>=0.7.1 23:00:57 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 23:00:57 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 23:00:57 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 23:00:57 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 23:00:57 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 23:00:57 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 23:00:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:00:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:00:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:59 INFO - Installing collected packages: psutil 23:00:59 INFO - Running setup.py install for psutil 23:00:59 INFO - building 'psutil._psutil_osx' extension 23:00:59 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 23:01:00 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 23:01:00 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 23:01:00 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 23:01:00 INFO - building 'psutil._psutil_posix' extension 23:01:00 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 23:01:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:01:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:01:00 INFO - ^ 23:01:00 INFO - 1 warning generated. 23:01:00 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 23:01:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:01:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:01:00 INFO - Successfully installed psutil 23:01:00 INFO - Cleaning up... 23:01:00 INFO - Return code: 0 23:01:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1104ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc072c867c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:01:00 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 23:01:00 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 23:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:01:00 INFO - 'HOME': '/Users/cltbld', 23:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:01:00 INFO - 'LOGNAME': 'cltbld', 23:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:00 INFO - 'MOZ_NO_REMOTE': '1', 23:01:00 INFO - 'NO_EM_RESTART': '1', 23:01:00 INFO - 'PAGER': '/bin/cat', 23:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:00 INFO - 'PWD': '/builds/slave/test', 23:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:01:00 INFO - 'SHELL': '/bin/bash', 23:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:01:00 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:01:00 INFO - 'USER': 'cltbld', 23:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:00 INFO - 'XPC_FLAGS': '0x0', 23:01:00 INFO - 'XPC_SERVICE_NAME': '0', 23:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:01:00 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 23:01:00 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 23:01:00 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 23:01:00 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 23:01:00 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 23:01:00 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 23:01:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:01:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:01:03 INFO - Installing collected packages: mozsystemmonitor 23:01:03 INFO - Running setup.py install for mozsystemmonitor 23:01:03 INFO - Successfully installed mozsystemmonitor 23:01:03 INFO - Cleaning up... 23:01:03 INFO - Return code: 0 23:01:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:03 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 0x1104ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc072c867c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:01:03 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 23:01:03 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 23:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:01:03 INFO - 'HOME': '/Users/cltbld', 23:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:01:03 INFO - 'LOGNAME': 'cltbld', 23:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:03 INFO - 'MOZ_NO_REMOTE': '1', 23:01:03 INFO - 'NO_EM_RESTART': '1', 23:01:03 INFO - 'PAGER': '/bin/cat', 23:01:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:03 INFO - 'PWD': '/builds/slave/test', 23:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:01:03 INFO - 'SHELL': '/bin/bash', 23:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:01:03 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:01:03 INFO - 'USER': 'cltbld', 23:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:03 INFO - 'XPC_FLAGS': '0x0', 23:01:03 INFO - 'XPC_SERVICE_NAME': '0', 23:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:01:03 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 23:01:03 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 23:01:03 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 23:01:03 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 23:01:03 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 23:01:03 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 23:01:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:01:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:01:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:01:05 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 23:01:05 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 23:01:05 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 23:01:05 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 23:01:05 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 23:01:05 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 23:01:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:01:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:01:06 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 23:01:06 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 23:01:06 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 23:01:06 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 23:01:06 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 23:01:06 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 23:01:06 INFO - Downloading docopt-0.6.1.tar.gz 23:01:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:01:06 INFO - Installing collected packages: blobuploader, requests, docopt 23:01:06 INFO - Running setup.py install for blobuploader 23:01:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:01:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:01:06 INFO - Running setup.py install for requests 23:01:07 INFO - Running setup.py install for docopt 23:01:07 INFO - Successfully installed blobuploader requests docopt 23:01:07 INFO - Cleaning up... 23:01:07 INFO - Return code: 0 23:01:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:07 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')]} 23:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:07 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')]} 23:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:07 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 0x1104ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc072c867c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:01:07 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 23:01:07 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 23:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:01:07 INFO - 'HOME': '/Users/cltbld', 23:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:01:07 INFO - 'LOGNAME': 'cltbld', 23:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:07 INFO - 'MOZ_NO_REMOTE': '1', 23:01:07 INFO - 'NO_EM_RESTART': '1', 23:01:07 INFO - 'PAGER': '/bin/cat', 23:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:07 INFO - 'PWD': '/builds/slave/test', 23:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:01:07 INFO - 'SHELL': '/bin/bash', 23:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:01:07 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:01:07 INFO - 'USER': 'cltbld', 23:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:07 INFO - 'XPC_FLAGS': '0x0', 23:01:07 INFO - 'XPC_SERVICE_NAME': '0', 23:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-zHi3pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-9slixZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-aQPM0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-BAuEqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-oF4qRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-41sx_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-YcIFQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-1bAGz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-2txzuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-DzcQCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-7OIee9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qwzBy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-HQJ5C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-eWkXa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Q57EIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CL3saX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KE4bJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:01:09 INFO - Running setup.py install for manifestparser 23:01:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Running setup.py install for mozcrash 23:01:10 INFO - Running setup.py install for mozdebug 23:01:10 INFO - Running setup.py install for mozdevice 23:01:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Running setup.py install for mozfile 23:01:10 INFO - Running setup.py install for mozhttpd 23:01:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Running setup.py install for mozinfo 23:01:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Running setup.py install for mozInstall 23:01:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Running setup.py install for mozleak 23:01:11 INFO - Running setup.py install for mozlog 23:01:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:01:11 INFO - Running setup.py install for moznetwork 23:01:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:01:11 INFO - Running setup.py install for mozprocess 23:01:11 INFO - Running setup.py install for mozprofile 23:01:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:01:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:01:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:01:11 INFO - Running setup.py install for mozrunner 23:01:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:01:11 INFO - Running setup.py install for mozscreenshot 23:01:12 INFO - Running setup.py install for moztest 23:01:12 INFO - Running setup.py install for mozversion 23:01:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:01:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:01:12 INFO - Cleaning up... 23:01:12 INFO - Return code: 0 23:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x1104ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc072c867c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:01:12 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 23:01:12 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 23:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:01:12 INFO - 'HOME': '/Users/cltbld', 23:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:01:12 INFO - 'LOGNAME': 'cltbld', 23:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:12 INFO - 'MOZ_NO_REMOTE': '1', 23:01:12 INFO - 'NO_EM_RESTART': '1', 23:01:12 INFO - 'PAGER': '/bin/cat', 23:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:12 INFO - 'PWD': '/builds/slave/test', 23:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:01:12 INFO - 'SHELL': '/bin/bash', 23:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:01:12 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:01:12 INFO - 'USER': 'cltbld', 23:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:12 INFO - 'XPC_FLAGS': '0x0', 23:01:12 INFO - 'XPC_SERVICE_NAME': '0', 23:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ljlIZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:12 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)) 23:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CmwLk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:12 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)) 23:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Di6Rmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:12 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)) 23:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-OURTjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-n5M0Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-5LLfPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-_rSUVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-XCUvjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-n5yEBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-rTcWeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-eCB0p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qd6yUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:13 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)) 23:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-LMehx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:14 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)) 23:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:14 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-K2HMSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:14 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)) 23:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:14 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KjNUvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:14 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)) 23:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:14 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CF7F9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:14 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)) 23:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:14 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IboF6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:01:14 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 23:01:14 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 23:01:14 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 23:01:14 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 23:01:14 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 23:01:14 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 23:01:16 INFO - Downloading blessings-1.5.1.tar.gz 23:01:16 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 23:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:01:16 INFO - Installing collected packages: blessings 23:01:16 INFO - Running setup.py install for blessings 23:01:16 INFO - Successfully installed blessings 23:01:16 INFO - Cleaning up... 23:01:16 INFO - Return code: 0 23:01:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:17 INFO - Reading from file tmpfile_stdout 23:01:17 INFO - Current package versions: 23:01:17 INFO - blessings == 1.5.1 23:01:17 INFO - blobuploader == 1.2.4 23:01:17 INFO - docopt == 0.6.1 23:01:17 INFO - manifestparser == 1.1 23:01:17 INFO - mozInstall == 1.12 23:01:17 INFO - mozcrash == 0.16 23:01:17 INFO - mozdebug == 0.1 23:01:17 INFO - mozdevice == 0.47 23:01:17 INFO - mozfile == 1.2 23:01:17 INFO - mozhttpd == 0.7 23:01:17 INFO - mozinfo == 0.9 23:01:17 INFO - mozleak == 0.1 23:01:17 INFO - mozlog == 3.0 23:01:17 INFO - moznetwork == 0.27 23:01:17 INFO - mozprocess == 0.22 23:01:17 INFO - mozprofile == 0.27 23:01:17 INFO - mozrunner == 6.11 23:01:17 INFO - mozscreenshot == 0.1 23:01:17 INFO - mozsystemmonitor == 0.0 23:01:17 INFO - moztest == 0.7 23:01:17 INFO - mozversion == 1.4 23:01:17 INFO - psutil == 3.1.1 23:01:17 INFO - requests == 1.2.3 23:01:17 INFO - wsgiref == 0.1.2 23:01:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:17 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')]} 23:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:17 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')]} 23:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:17 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 0x1104ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc072c867c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/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.Md3vtuo0rx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:01:17 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 23:01:17 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 23:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:01:17 INFO - 'HOME': '/Users/cltbld', 23:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:01:17 INFO - 'LOGNAME': 'cltbld', 23:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:17 INFO - 'MOZ_NO_REMOTE': '1', 23:01:17 INFO - 'NO_EM_RESTART': '1', 23:01:17 INFO - 'PAGER': '/bin/cat', 23:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:17 INFO - 'PWD': '/builds/slave/test', 23:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:01:17 INFO - 'SHELL': '/bin/bash', 23:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:01:17 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:01:17 INFO - 'USER': 'cltbld', 23:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:17 INFO - 'XPC_FLAGS': '0x0', 23:01:17 INFO - 'XPC_SERVICE_NAME': '0', 23:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 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)) 23:01:17 INFO - Cleaning up... 23:01:17 INFO - Return code: 0 23:01:17 INFO - Running post-action listener: _resource_record_post_action 23:01:17 INFO - Running post-action listener: _start_resource_monitoring 23:01:17 INFO - Starting resource monitoring. 23:01:17 INFO - ##### 23:01:17 INFO - ##### Running install step. 23:01:17 INFO - ##### 23:01:17 INFO - Running pre-action listener: _resource_record_pre_action 23:01:17 INFO - Running main action method: install 23:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:17 INFO - Reading from file tmpfile_stdout 23:01:17 INFO - Detecting whether we're running mozinstall >=1.0... 23:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:01:17 INFO - Reading from file tmpfile_stdout 23:01:17 INFO - Output received: 23:01:17 INFO - Usage: mozinstall [options] installer 23:01:17 INFO - Options: 23:01:17 INFO - -h, --help show this help message and exit 23:01:17 INFO - -d DEST, --destination=DEST 23:01:17 INFO - Directory to install application into. [default: 23:01:17 INFO - "/builds/slave/test"] 23:01:17 INFO - --app=APP Application being installed. [default: firefox] 23:01:17 INFO - mkdir: /builds/slave/test/build/application 23:01:17 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'] 23:01:17 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 23:01:49 INFO - Reading from file tmpfile_stdout 23:01:49 INFO - Output received: 23:01:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:01:49 INFO - Running post-action listener: _resource_record_post_action 23:01:49 INFO - ##### 23:01:49 INFO - ##### Running run-tests step. 23:01:49 INFO - ##### 23:01:49 INFO - Running pre-action listener: _resource_record_pre_action 23:01:49 INFO - Running main action method: run_tests 23:01:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:01:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:01:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:01:49 INFO - 2015-11-19 23:01:49.135 screenresolution[1967:14372] starting screenresolution argv=screenresolution get 23:01:49 INFO - 2015-11-19 23:01:49.137 screenresolution[1967:14372] Display 0: 1600x1200x32@60 23:01:49 INFO - 2015-11-19 23:01:49.143 screenresolution[1968:14374] starting screenresolution argv=screenresolution list 23:01:49 INFO - Available Modes on Display 0 23:01:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:01:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:01:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:01:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:01:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:01:49 INFO - Intel Iris: 23:01:49 INFO - Chipset Model: Intel Iris 23:01:49 INFO - Type: GPU 23:01:49 INFO - Bus: Built-In 23:01:49 INFO - VRAM (Dynamic, Max): 1536 MB 23:01:49 INFO - Vendor: Intel (0x8086) 23:01:49 INFO - Device ID: 0x0a2e 23:01:49 INFO - Revision ID: 0x0009 23:01:49 INFO - Displays: 23:01:49 INFO - Display: 23:01:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:01:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:01:49 INFO - Display Serial Number: 1600x1200 60 23:01:49 INFO - Main Display: Yes 23:01:49 INFO - Mirror: Off 23:01:49 INFO - Online: Yes 23:01:49 INFO - Rotation: Supported 23:01:49 INFO - Return code: 0 23:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:01:49 INFO - Python 2.7.3 23:01:49 INFO - Return code: 0 23:01:49 INFO - grabbing minidump binary from tooltool 23:01:49 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')]} 23:01:49 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 0x11040e9f0>, '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 0x11016ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104018c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:01:49 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 23:01:49 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 23:01:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:01:49 INFO - Return code: 0 23:01:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:01:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:01:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:01:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:01:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:01:49 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/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost'] in /builds/slave/test/build 23:01:49 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/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --webServer localhost 23:01:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ay0EpxNimx/Render', 23:01:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:01:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:01:49 INFO - 'HOME': '/Users/cltbld', 23:01:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:01:49 INFO - 'LOGNAME': 'cltbld', 23:01:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:01:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:49 INFO - 'MOZ_NO_REMOTE': '1', 23:01:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:01:49 INFO - 'NO_EM_RESTART': '1', 23:01:49 INFO - 'PAGER': '/bin/cat', 23:01:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:49 INFO - 'PWD': '/builds/slave/test', 23:01:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:01:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:01:49 INFO - 'SHELL': '/bin/bash', 23:01:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Md3vtuo0rx/Listeners', 23:01:49 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 23:01:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:01:49 INFO - 'USER': 'cltbld', 23:01:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:01:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:49 INFO - 'XPC_FLAGS': '0x0', 23:01:49 INFO - 'XPC_SERVICE_NAME': '0', 23:01:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:01:49 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/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost'] with output_timeout 3600 23:01:49 INFO - mozversion INFO | application_buildid: 20151119205634 23:01:49 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 23:01:49 INFO - mozversion INFO | application_display_name: Nightly 23:01:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:01:49 INFO - mozversion INFO | application_name: Firefox 23:01:49 INFO - mozversion INFO | application_remotingname: firefox 23:01:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 23:01:49 INFO - mozversion INFO | application_vendor: Mozilla 23:01:49 INFO - mozversion INFO | application_version: 45.0a1 23:01:49 INFO - mozversion INFO | platform_buildid: 20151119205634 23:01:49 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 23:01:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 23:01:49 INFO - mozversion INFO | platform_version: 45.0a1 23:01:49 INFO - 2015-11-19 23:01:49,682 DEBUG : using testdate: 1448002909 23:01:49 INFO - 2015-11-19 23:01:49,682 DEBUG : actual date: 1448002909 23:01:50 INFO - 2015-11-19 23:01:50,082 INFO : starting webserver on 'localhost:49496' 23:01:50 INFO - 2015-11-19 23:01:50,083 INFO : Starting test suite t-yosemite-r7-0036 23:01:50 INFO - 2015-11-19 23:01:50,083 INFO : Starting test dromaeo_css 23:01:50 INFO - 2015-11-19 23:01:50,083 DEBUG : operating with platform_type : mac_ 23:01:50 INFO - 2015-11-19 23:01:50,084 INFO : Initialising browser for dromaeo_css test... 23:01:50 INFO - 2015-11-19 23:01:50,096 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpOQLIka/profile http://localhost:49496/getInfo.html 23:01:52 INFO - 2015-11-19 23:01:52,103 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:01:52 INFO - 2015-11-19 23:01:52,103 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:01:52 INFO - 2015-11-19 23:01:52,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:01:52 INFO - 2015-11-19 23:01:52,103 DEBUG : BROWSER_OUTPUT: __metrics 23:01:52 INFO - 2015-11-19 23:01:52,120 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:01:52 INFO - 2015-11-19 23:01:52,943 INFO : Browser initialized. 23:01:52 INFO - 2015-11-19 23:01:52,943 INFO : Running cycle 1/1 for dromaeo_css test... 23:01:52 INFO - 2015-11-19 23:01:52,944 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpOQLIka/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:02:04 INFO - 2015-11-19 23:02:04,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 226340864 23:02:04 INFO - 2015-11-19 23:02:04,728 DEBUG : BROWSER_OUTPUT: 23:02:55 INFO - 2015-11-19 23:02:55,584 DEBUG : BROWSER_OUTPUT: 1448002975582 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] 23:05:07 INFO - 2015-11-19 23:05:07,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49496/tests/dromaeo/cssquery-ext.html) 23:05:09 INFO - 2015-11-19 23:05:09,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 381853696 23:05:09 INFO - 2015-11-19 23:05:09,004 DEBUG : BROWSER_OUTPUT: 23:08:11 INFO - 2015-11-19 23:08:11,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-ext.html (next: http://localhost:49496/tests/dromaeo/cssquery-jquery.html) 23:08:12 INFO - 2015-11-19 23:08:12,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 362450944 23:08:12 INFO - 2015-11-19 23:08:12,297 DEBUG : BROWSER_OUTPUT: 23:11:14 INFO - 2015-11-19 23:11:14,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49496/tests/dromaeo/cssquery-mootools.html) 23:11:15 INFO - 2015-11-19 23:11:15,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 336138240 23:11:15 INFO - 2015-11-19 23:11:15,104 DEBUG : BROWSER_OUTPUT: 23:14:17 INFO - 2015-11-19 23:14:17,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49496/tests/dromaeo/cssquery-prototype.html) 23:14:17 INFO - 2015-11-19 23:14:17,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 322494464 23:14:17 INFO - 2015-11-19 23:14:17,659 DEBUG : BROWSER_OUTPUT: 23:17:20 INFO - 2015-11-19 23:17:20,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49496/tests/dromaeo/cssquery-yui.html) 23:17:21 INFO - 2015-11-19 23:17:21,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 325242880 23:17:21 INFO - 2015-11-19 23:17:21,102 DEBUG : BROWSER_OUTPUT: 23:20:23 INFO - 2015-11-19 23:20:23,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-yui.html (next: http://localhost:49496/tests/dromaeo/cssquery-dojo.html) 23:20:24 INFO - 2015-11-19 23:20:24,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 384012288 23:20:24 INFO - 2015-11-19 23:20:24,213 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,214 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:20:24 INFO - 2015-11-19 23:20:24,214 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:20:24 INFO - 2015-11-19 23:20:24,214 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:20:24 INFO - 2015-11-19 23:20:24,214 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:20:24 INFO - 2015-11-19 23:20:24,218 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3433.587969443666;3435.74231932605;3471.895843124707;3490.4938783876337;3511.0695665648623;5733.713314334287;5899.498542623872;5912.497437717794;6002.339742628313;6056.394360563947;5863.091220860762;5883;5911.497522710575;6003.579749417542;6019.819405417845;5354.250404943311;5369.275147855048;5384.246205531229;5404.540614047791;5450.329338624066;5498.1752737089555;5512.91730624039;5525.696086715229;5543.279373681416;5543.584231182657;5259;5360.490753378423;5373.7581808818695;5386.407495175527;5416.972915135439;5370.650907691027;5384.488473595002;5393.164059570773;5407.215953686733;5407.648502847303;5305.495977882134;5393.6763794172475;5409.999150157233;5411.56707463402;5427.348718153847;5830.7084645767545;5832.125181222808;5832.766689332421;5834.183214349994;5846.649201047908;6252.437280644718;6319.115323854664;6377.2666143393635;6383.616982981036;6386.712597933104;6288.496920246369;6347.52393570484;6363.109164716943;6372.394622510854;6383.61698298099;6115.357887421801;6134.202553667995;6139.6009259398;6141.109539116803;6145.5698101133385;5447.400785913546;6288.748450062038;6363.713632886531;6377.9795232762535;6422.967885160544;6303.842403939938;6384.904226436607;6396.360363963567;6413.871722565523;6415.935840641627;6366.236051673736;6377.96811015942;6379.170707807955;6387.457066149336;6409;6169.444749972435;6227.688615569204;6287.717052732638;6327.082573026885;6354.078658594478;6305.96847015762;6321.304656487782;6321.96839015802;6330.272018717815;6332.33510481402;5060.165072763027;5100.0819852426175;5108.642395032386;5133.281340612317;5162.045021671003;4388;4460.665450091191;4493.73037617744;4513.119941611354;4530.343100250445;5879.647221166743;5907.793227237112;5941.821745347646;5948.762049518057;6017.217761691039;6306.3378345274;6327.17746692927;6374.936250637527;6396.5202609804455;6425.1968503937005;5660.943390566042;5805.071188609802;5808.215890854765;5815.476607105296;5851.707414629252;5422.620416570802;5445.83662490126;5540.584456165804;5546.057170281062;5570.693611851387;6465.838354041187;6482.870342593122;6487.3836985486305;6596.340365963365;6606.504512161607;6328.462080723006;6356.300806911144;6366.204224471941;6379.298277189599;6404.583702059351;6246.031865060922;6301.369863013662;6330.050492426173;6334.239891212899;6496.870062598627;6240.4071613196675;6345.587536810092;6364.204474440695;6365.427111559982;6394.584352017104;6299.181106456132;6325.8734825304155;6356.2054743157105;6371.458426033653;6444.516661250331;5732.45541673557;6124.142620033288;6159.938400616115;6180.227471566054;6185.783497577563;5407.405185429521;6192.783252586138;6296.937030629635;6360.332165122781;6401;6192.164057852313;6251.468625166912;6257.7184026718;6264.49884009269;6268.686565671789;5983.850403739767;6225.221847269091;6234.875302494015;6302.401271879165;6359.650219237987;6001.129836173817;6064.120702498025;6094.268687757498;6096.695165241631;6112.776190144408 23:20:24 INFO - 2015-11-19 23:20:24,218 DEBUG : BROWSER_OUTPUT: |1;ext.html;518.2330105173537;560.2212924035591;576.3458474631298;600.4775845014838;607.9726412311447;31976.880809171682;32446.837765811197;39990.8000459998;40274.7986260069;40344.59655403445;43580;44096.55903440973;44110.33834492485;44212.55787442125;44305.335419968724;8626.913730862705;8758.080401557809;9608.327417080789;9808.019198080206;9811.803763924718;8607.956960215222;11824.527018919232;11912.583059592916;11928.284302941807;11930.701732456715;11670.708232294175;11742.354170520617;11745.588904388349;11749.647510574696;11751.647450576496;8652;8746.431481953652;11705.473253703603;11745.001674857647;11788.115891308185;8601.784955376166;8698.695545655935;8709.172628600272;11647.35939523326;11773.411329433495;40491.59508404908;40623;40672.38991415131;40684;40781.59218407808;3201.4557525220766;3215.0515597898443;3215.1479857837458;3396.762226644136;3636.3636363636524;27720;28645.71354286472;28943;29397.265068373246;30261.546076808867;2798.4962706712786;2840.4603125406106;2879.280179955011;2909.432660631178;2980.2549362659333;456402;504523;505470.47264763806;505521;505865;64664.67667661726;65168;65256;65406.01890971639;65432;67140.32859671439;67357;67370.3262967364;67504.3249567498;67522.66238668874;16147.596310092342;16632.33470661184;16639.833601663828;16645.667086658443;16696.914700544425;12862.035347348987;12923.353832308536;12927.482900684055;12940.288284144273;12952.158109722837;19175.94532300709;19833.206671733256;19889.900550497445;19927.800721992593;20026.99865006744;8409.2431681149;8561.315094792402;8579.399442038997;8629.22336989674;8635.963684357917;940.4827344960381;970.8592254123113;1021.2238698589126;1123.5056575106926;1180.2564384437749;29642.85178574093;29708.55437168444;30321.848390758347;30334.54498182529;30506.54240186399;999.3004896572428;1032.6643840751785;1073.978520429587;1109.0905457524752;1172.9648110556698;13409.195448273134;14111.22388268655;14243.287835608178;14424.495142669955;14431.567052988426;535949;535949;536748;537963;692715;46352;47648.523514765104;56223.87552248932;56350.436495634516;56370.43629563734;1400.5378225185664;1445.6964037552023;1453.7455945209547;1455.86169313915;1459.0151647637801;26963.325916852235;29186.56220156742;30270.84864575663;30394.84802575973;30868.845655771576;52996.735016324674;53458.732706337774;53524.78851268936;53564.928701426536;53581.73209133929;461183;470562;470634;471712;472041.63979179884;30660.540091898194;30985.380292393576;31716.524252136696;31718.524222137148;31766.682333176374;45109.548904510535;45115.09769804651;45189;45254.54745452503;45801.770991146164;37436.2512749738;37705.43441848429;38215.235695286494;38499;38665.61334386733;30449;36877.63122368849;36971.815140924125;37950;38034.239315214094;36909.70816021534;37525.62474375221;37836.81081594574;37994.620053800216;38019.61980380161;33186;33540.66459335375;33638.52692344008;33914.3217135651;33956.32087358288;24895.87552062228;24942;25179.87410062938;25303.620445692963;25530.234092976498 23:20:24 INFO - 2015-11-19 23:20:24,220 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.99292014159704;355.84165046554284;359.40518441978537;359.59725107879177;365.917668524582;16155.94986325891;16645.91677041613;20279.594408111847;20316.59366812663;20972;21329.68005479915;21719.501959284647;21932;22199.556008879812;22208.777912220874;6439.388258115483;6626.171728533934;6632;6633.8341541461605;6646.302138275484;3881.941770873439;3953.7034722395792;3981.5819338969427;5605.7197140142825;6541.542092053558;5726.942730572703;5730.570207234474;5735.111057786029;5737.082066869301;5744.109663002241;5853.50245229156;6346.30190679025;6349.333320001379;6353.9682301588655;6365.681715914232;5430.59270554706;5542.334919809608;5544.77820887164;5550.222968784374;5555.3611334696625;12585.874141258562;13167;13192.868071319355;13199.934000329937;22241.11035558576;1969.428865628966;2077.210659949225;2148.0655914677163;2190.2224710227956;2243.854149480295;8425.747227583182;9792.16527264319;9815.263855210887;9926.45404502752;10183.33808302458;1626.6421387294777;1685.1826863970964;1695.0931251780362;1707.4024091567976;1739.2955852879604;97939;102559.48720256351;102625.48687256516;103345.48327258391;104811.42782858263;10997.12023038155;11001.944990274997;11002.449877506093;11008.064314533194;11093.057090147428;11275.605353812578;13175.430790995855;13285;13289.667758305926;13317.067805253539;8431.704890328809;8493.660253589911;8503.61733721984;8527.104654011364;8533.061363250037;7119.252478489684;8643.394962352575;8647.351448641377;8694.782630434289;8746.518941458153;4272.594103560157;4325.956740432555;4335.588119128678;4374.103308821684;4377.277749171351;1437.5974727076227;1748.3968031029274;1749.8775085743875;1753.3074435597866;1768.6904791661407;781.9374450043982;920.4707293306376;935.7286386947845;984.950752462374;1099.6371197504805;19519.512012199808;19775;20230.089645965672;20795.27216547444;20937.89531052335;842.8351539967383;924.9338443061231;960.3805545423163;975.9463229522445;986.9950650246702;10741.462926853626;11139.610113645984;11170.441477926071;11638.709032274091;11667.35829529384;770133;770356;771472.1426392832;780977;785246;113216;116725;117325;117698.8230117705;128195;1156.2368836567825;1161.181367136167;1174.3306315400139;1197.952081916731;1198.922070065443;18461.723074154168;18773.1552080154;19250.22999080021;19850.305239316556;20608.14859197136;49777.67143227361;51316.23025654544;51934.74032629964;52073.479265206865;56271.15593266186;66521;68771;69777;71052;73664;9699.321047526606;9709.70870873875;10011.149052330633;10108.191344692554;10126;19894.204231830565;19981.80109193395;20173.79826201778;20545.691814622493;20783;15941.68116637684;15993.760093598372;16064;16246.67506649884;16374.181290935167;13613.931930340284;15786.526404207892;16055.518334449986;16056.43802466908;16151.515454536382;12679.93660031694;12911.677208069497;15022.699546009237;15684.764728528853;17090.48728538146;9371.203447707021;9650.262952668307;9767.706968790948;9859.161971232526;9989.950050249703;10115.848262276219;10833.891661083604;15651.139187344805;16101.275442605345;16119.435819746253 23:20:24 INFO - 2015-11-19 23:20:24,224 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1548.2490991868942;1551.557806025283;1565.1469948877861;1779.759732436121;1801.4685667728022;7533;7955.323797477214;7966.561839098855;8125.309348705352;8491;8230.588470576477;8339.33285337173;8347.91652083479;8382.245597896188;8409.453385529936;2346.1905642553334;2371.0041782451412;2372.2883135059415;2376.940576485584;2378.1200955646436;2293.2317673579373;2320.14154762738;2336.404216924682;2338.9649155262687;2348.823838212132;2341.8126549876056;2360.8937597808053;2361.917332893349;2366.3019409274307;2383.463720662846;2336.684547586071;2353.564590550745;2363.1374548289837;2366.656834758959;2378.2389635316704;2365.089440565395;2392.5454163709014;2400.3999000249937;2400.4478969837037;2403.218953840009;8204.220599043141;8241.25828675422;8259.628316725762;8262.17378262175;8289.95855020721;4603.447586289633;4771.236602143675;4780;5048.066107770074;5162.3030890830005;3466.739994500397;3481.6344283850085;3520.5775306963073;3528.8235588220487;3545;1019.0675531888313;1031.097789434245;1039.537405854395;1051.1013083813307;1054.4938429553856;11035.39305338206;11092.057175140042;11095.223334366598;11104.056155226735;11140.665780026613;4617.953820461819;4684.5549672781035;4739.075880203396;4749.881252968635;4765.69023013503;9795.167410770164;9812.558434870449;9814.95092524547;9819.558119884623;9821.214302855755;5224.582033437316;5252.238425428368;5253.369595648546;5264.947350526446;5267.578593712494;4717.150912835723;4774.283857421415;4774.522547745267;4781.928271075936;4790.473047964721;3698.2973235085246;3720.4605332226674;3746.2882052409955;3754.6808521276;3775.244951009809;1208.9516419343304;1229.8647148813623;1237.1772771107112;1238.0961897814645;1240.0637518673525;1081.3403823667556;1108.1078385414062;1222.0529089955178;1393.7769956806862;1396.5391420831102;7834.960825195838;7900.446968712135;7921.762347129596;7924.088729796032;7932.960335198287;498.3645851539316;502.6983809714142;507.41393690287777;507.61421319796483;508.9185730283137;5859.736311865976;6007.429294217042;6026.487748541335;6057.394260573908;6067.908981365283;9119.316051296179;9328.868744060555;9412.482313472688;9447.669331573363;10233.976602339706;9786.608535658635;9814.46020468881;9913.80172396548;10132.696019119438;10151.1371533419;7874.21257874208;7897.24976127267;7930.444868859125;7942.563159026194;7947.761567152995;7531.435142364235;7722.420818438527;7722.961385193038;7724.459287849797;7731.922680773345;7947.801304967422;8039.397045221749;8931.374803763674;9049.59276832531;9061.728148155566;9075.636974520945;9375.624975000923;9376.343655944018;9393.154616084585;9553.952230238805;6280.717367718372;7193.136823581203;7193.964030179815;7279.563226206445;7286.635668216674;7916.920830791619;7974.322182614543;7977.880331794911;7981.321587665114;7982.281594656509;7332.450066244946;7429.925700742923;7555.09338879338;7606.353459955966;7632.084149902047;6333.714982825692;6444.645544495098;7305.269473052652;7348.816279593053;7423.146338170964;7423.146338170964;7450.776476705708;7471.252874712485;7519.812004699707;7523;6833.214180369321;6850.794476165723;6862.382385585322;6867.381935625817;6872.725090996304;6769.901330587533;6901.689423975833;6949.270326615632;6950.582965022115;6975.337342952412 23:20:24 INFO - 2015-11-19 23:20:24,224 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.5127430668231;322.3842460899681;328.19428303514843;329.75268548588554;332.43983887150154;6827.249002609715;6865.107536020317;6897.758578449749;6974.128233970754;6978.441724662028;5485.9725701371535;6833.4191593714595;6851.897221541681;6862.7598034068815;6872.587644741307;4939.43196532398;5057.41839688435;5070.619703522232;5090.440051594322;5108;5059.544640982311;5064.594832413417;5076.111680455924;5087.923681144785;5114.053900028488;5006.574441172486;5010.899782004358;5025.748712564376;5030.471800460954;5031.396232452111;4792.424909010906;4875.049365373754;4887.3890763654545;5044.545990860804;5049.116404629193;4225.302825033897;4253.319468884994;4296.269634162169;4307.073979094478;4309.698321117523;5286.973565132188;6585.2426970898005;6592.703328350236;6614.735410583571;6635.8009259722285;4736.668433209677;5493.835184944458;5701.916635839178;5838.38696936824;5989.580729348947;7390.778276651709;7402.222766609482;7404.592747398891;7411.258874112599;7422.109346878356;3976.940345894814;4804.807807687688;4810.254410566367;4811.59101476375;4821.68659037165;7522.097348318237;7751.147373788879;7822.217778222189;7830.647620857075;7866.803329916798;4915.090708218991;4924.138275801792;4928.063667903087;4931.630127740434;4932.383452068491;4977.104121258136;4988.775505102279;5005;5011.398632164163;5014.373203349582;5828.475437210586;5963.075723262901;5977.043673012384;5988.101784732325;5990.940090599125;7375.704971801175;7411.59236242001;7412.703491860373;7426.9257307427315;7430.331270185709;1719.312275089974;1735.2711861018402;1738.4697667211622;1740.0690630512615;1744.8604111671036;1110.6279396402135;1125.454154734953;1131.7566723154562;1144.2619510415734;1146.8279758036194;6833.726650933907;6858.971154326791;6862.451003919675;6902.827429314308;6903.585784852925;7638.541687498768;7645.847083058307;7653.272939070779;7658.693652253847;7659.731909383145;6674.466042716571;6852.109225800614;6865.27914568973;6882;6910.7581234656545;4062.5937406259136;4094.467719196485;4096.078382363944;4098.282800509958;4101.097758493127;7895.447318687751;7899.131095579596;7931.801704957307;7937.285644291926;7945.364370850318;7662.808429789188;7921.683132674743;7941.086775020946;7941.76902580101;7947.880781788278;7873.724419645285;7897.605119744105;7909.367250619936;7913;7924.881126782988;6763.797086087426;7144.285571442814;7441.702331906879;7662.6934922604705;7696.076470823537;7549.396048316012;7551.584662843597;7555.395568354628;7560.395168386626;7562.2437756223935;7905.881411778943;7914.287714105758;7916.327112195528;7918.762437126896;7923.484973476706;4816.614670826396;4930.408350997904;4951.10880041596;4964.056829202585;4978.411226162448;6173.506119510518;7603.657835397531;7625.23747625233;7631.1605723371495;7631.3513351365755;5985.970070149621;7340.376068034277;7345.5225410350295;7353.448491363062;7360.484766066324;6628.237752658506;6744.5616034957575;7093.964530177316;7328.487005909748;7332.41340692754;5837.328707198726;7178.641067946686;7178.748743793943;7192.71229150849;7201.13586369639;7202.459815513753;7316.158641756053;7338.192798792235;7360.96319518399;7362.852742945004;7186.245444228281;7193.3166349196745;7193.460490463341;7203.495755297288;7227.457940654577 23:20:24 INFO - 2015-11-19 23:20:24,225 DEBUG : BROWSER_OUTPUT: |5;yui.html;699.0562740300592;721.7690339091487;767.9808004799879;788.7791418402845;814.6944895664126;14526.491572794954;14901.478448254313;14906.329215185315;14920.552383428487;14932.850671493281;13628.386722597483;13843.653908652288;13878.306084695776;13880.652983675413;13921.37353819078;745.5005146551823;755.4824944912725;756.0700338583546;937.8593211018351;963.8554216867456;889.1952782731638;950.8858936927544;964.3876138651937;965.5027660754716;967.2310513142033;985.6550207427379;1012.2913960227833;1012.5241136665792;1013.4527355228205;1013.5742987945081;763.1681467200777;786.8662327404355;799.6241766369855;990.8959559246283;993.7366597851575;738.7266711316847;745.02401853572;748.715488114513;749.3630414147985;750.7672621487357;14528.636784080376;14660;14711.70576588473;14719.70560588793;14721.779173312409;10665.893341066567;10952.452377381178;11859.407029648482;12066.396680165957;12223.69440763979;9284.860727089099;9712.465814380277;9895.307328487008;10057.89942100577;10120.038596333337;3496.143444856001;3543.255916257589;3557.217412169319;3563.233904710474;3568.946465802989;81656;82630;85002.57498712529;85052;87356.12643873607;9555.579897035579;9564.856527152098;9734.707958761248;9796.363236389612;10167.644132455329;19496.51258718515;19848;21172;21175.576488470146;21183.364499065054;7379.5203311785635;7384.852302954018;7403.51877127985;7410.814729631695;7461.738839140604;4130.979345103256;4133.111381053028;4174.791260437027;4180.289350810309;4196.055887425366;3462.8095454749728;3499.61504234534;3503.2818272254126;3503.4569641705575;3507.4914137449928;626.7399029402837;635.7361694896658;637.2034956304619;655.0632595388545;656.9671516424255;489.5985292060476;499.071726588545;508.18182725811414;511.51917197833916;534.6177483099602;8460.196281353261;8546.957265213634;8644.827103458021;8656.156566988184;8813.69152079687;472.15719939907103;509.20818127810867;531.8298144593692;548.4378512025206;573.3005733005726;4013.2174226025645;4334.680437060282;4382.846600368972;4488.887777805581;4494.505604383515;98462;100056;101398;101481.98518014872;101738.45653858712;85701.14298857056;86602.13397866067;86847.13152868517;86890;87008.5649571748;75990.62004690051;76054.61972690102;76170.23829761743;76421.61789191018;76787.46425071468;8886.362276344891;8898.154675305836;8939.508327042075;8962.68630597926;9114.13415725505;52817.7359113202;53247.73376133094;53427.93144137173;53806.73096634492;54308.728456359044;72220;76138.61930690311;76141;76149.61925190338;76320.61839690767;10687.572497100029;10816.729581760519;11073.280236784583;11239.606613768807;11294.774104518028;11875.346855923008;11906.52373905034;12153.08851836098;12445.875541244472;12593.307368094842;11248.26886252391;11322.60370887015;11769.352685602375;11785.233959792586;11969.760604788029;10984.835227471754;11203.99164075237;11239.381833999209;11648.650540483799;12227.14409991292;10910.563577457131;11285.943570282096;11383.715407114889;11550.249233799776;12025.63923082309;9022.14289642483;9103.453792772454;9254.537273136451;9399.201067909304;9556.95221523888;8868.689595864114;9164.450132992042;9927.255455840985;9934.105930466292;9988.501724741347 23:20:24 INFO - 2015-11-19 23:20:24,225 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:20:24 INFO - 2015-11-19 23:20:24,225 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1350 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: __startTimestamp1448004024212__endTimestamp 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5893.00 Median:6139.60 stddev:639.52 (10.4%) stddev-sans-first:611.69 23:20:24 INFO - 2015-11-19 23:20:24,227 DEBUG : BROWSER_OUTPUT: Values: 3433.6 3435.7 3471.9 3490.5 3511.1 5733.7 5899.5 5912.5 6002.3 6056.4 5863.1 5883.0 5911.5 6003.6 6019.8 5354.3 5369.3 5384.2 5404.5 5450.3 5498.2 5512.9 5525.7 5543.3 5543.6 5259.0 5360.5 5373.8 5386.4 5417.0 5370.7 5384.5 5393.2 5407.2 5407.6 5305.5 5393.7 5410.0 5411.6 5427.3 5830.7 5832.1 5832.8 5834.2 5846.6 6252.4 6319.1 6377.3 6383.6 6386.7 6288.5 6347.5 6363.1 6372.4 6383.6 6115.4 6134.2 6139.6 6141.1 6145.6 5447.4 6288.7 6363.7 6378.0 6423.0 6303.8 6384.9 6396.4 6413.9 6415.9 6366.2 6378.0 6379.2 6387.5 6409.0 6169.4 6227.7 6287.7 6327.1 6354.1 6306.0 6321.3 6322.0 6330.3 6332.3 5060.2 5100.1 5108.6 5133.3 5162.0 4388.0 4460.7 4493.7 4513.1 4530.3 5879.6 5907.8 5941.8 5948.8 6017.2 6306.3 6327.2 6374.9 6396.5 6425.2 5660.9 5805.1 5808.2 5815.5 5851.7 5422.6 5445.8 5540.6 5546.1 5570.7 6465.8 6482.9 6487.4 6596.3 6606.5 6328.5 6356.3 6366.2 6379.3 6404.6 6246.0 6301.4 6330.1 6334.2 6496.9 6240.4 6345.6 6364.2 6365.4 6394.6 6299.2 6325.9 6356.2 6371.5 6444.5 5732.5 6124.1 6159.9 6180.2 6185.8 5407.4 6192.8 6296.9 6360.3 6401.0 6192.2 6251.5 6257.7 6264.5 6268.7 5983.9 6225.2 6234.9 6302.4 6359.7 6001.1 6064.1 6094.3 6096.7 6112.8 23:20:24 INFO - 2015-11-19 23:20:24,228 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,228 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65663.12 Median:36940.76 stddev:136803.52 (370.3%) stddev-sans-first:137099.85 23:20:24 INFO - 2015-11-19 23:20:24,229 DEBUG : BROWSER_OUTPUT: Values: 518.2 560.2 576.3 600.5 608.0 31976.9 32446.8 39990.8 40274.8 40344.6 43580.0 44096.6 44110.3 44212.6 44305.3 8626.9 8758.1 9608.3 9808.0 9811.8 8608.0 11824.5 11912.6 11928.3 11930.7 11670.7 11742.4 11745.6 11749.6 11751.6 8652.0 8746.4 11705.5 11745.0 11788.1 8601.8 8698.7 8709.2 11647.4 11773.4 40491.6 40623.0 40672.4 40684.0 40781.6 3201.5 3215.1 3215.1 3396.8 3636.4 27720.0 28645.7 28943.0 29397.3 30261.5 2798.5 2840.5 2879.3 2909.4 2980.3 456402.0 504523.0 505470.5 505521.0 505865.0 64664.7 65168.0 65256.0 65406.0 65432.0 67140.3 67357.0 67370.3 67504.3 67522.7 16147.6 16632.3 16639.8 16645.7 16696.9 12862.0 12923.4 12927.5 12940.3 12952.2 19175.9 19833.2 19889.9 19927.8 20027.0 8409.2 8561.3 8579.4 8629.2 8636.0 940.5 970.9 1021.2 1123.5 1180.3 29642.9 29708.6 30321.8 30334.5 30506.5 999.3 1032.7 1074.0 1109.1 1173.0 13409.2 14111.2 14243.3 14424.5 14431.6 535949.0 535949.0 536748.0 537963.0 692715.0 46352.0 47648.5 56223.9 56350.4 56370.4 1400.5 1445.7 1453.7 1455.9 1459.0 26963.3 29186.6 30270.8 30394.8 30868.8 52996.7 53458.7 53524.8 53564.9 53581.7 461183.0 470562.0 470634.0 471712.0 472041.6 30660.5 30985.4 31716.5 31718.5 31766.7 45109.5 45115.1 45189.0 45254.5 45801.8 37436.3 37705.4 38215.2 38499.0 38665.6 30449.0 36877.6 36971.8 37950.0 38034.2 36909.7 37525.6 37836.8 37994.6 38019.6 33186.0 33540.7 33638.5 33914.3 33956.3 24895.9 24942.0 25179.9 25303.6 25530.2 23:20:24 INFO - 2015-11-19 23:20:24,229 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,229 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39385.64 Median:11738.87 stddev:127529.28 (1086.4%) stddev-sans-first:127853.35 23:20:24 INFO - 2015-11-19 23:20:24,230 DEBUG : BROWSER_OUTPUT: Values: 354.0 355.8 359.4 359.6 365.9 16155.9 16645.9 20279.6 20316.6 20972.0 21329.7 21719.5 21932.0 22199.6 22208.8 6439.4 6626.2 6632.0 6633.8 6646.3 3881.9 3953.7 3981.6 5605.7 6541.5 5726.9 5730.6 5735.1 5737.1 5744.1 5853.5 6346.3 6349.3 6354.0 6365.7 5430.6 5542.3 5544.8 5550.2 5555.4 12585.9 13167.0 13192.9 13199.9 22241.1 1969.4 2077.2 2148.1 2190.2 2243.9 8425.7 9792.2 9815.3 9926.5 10183.3 1626.6 1685.2 1695.1 1707.4 1739.3 97939.0 102559.5 102625.5 103345.5 104811.4 10997.1 11001.9 11002.4 11008.1 11093.1 11275.6 13175.4 13285.0 13289.7 13317.1 8431.7 8493.7 8503.6 8527.1 8533.1 7119.3 8643.4 8647.4 8694.8 8746.5 4272.6 4326.0 4335.6 4374.1 4377.3 1437.6 1748.4 1749.9 1753.3 1768.7 781.9 920.5 935.7 985.0 1099.6 19519.5 19775.0 20230.1 20795.3 20937.9 842.8 924.9 960.4 975.9 987.0 10741.5 11139.6 11170.4 11638.7 11667.4 770133.0 770356.0 771472.1 780977.0 785246.0 113216.0 116725.0 117325.0 117698.8 128195.0 1156.2 1161.2 1174.3 1198.0 1198.9 18461.7 18773.2 19250.2 19850.3 20608.1 49777.7 51316.2 51934.7 52073.5 56271.2 66521.0 68771.0 69777.0 71052.0 73664.0 9699.3 9709.7 10011.1 10108.2 10126.0 19894.2 19981.8 20173.8 20545.7 20783.0 15941.7 15993.8 16064.0 16246.7 16374.2 13613.9 15786.5 16055.5 16056.4 16151.5 12679.9 12911.7 15022.7 15684.8 17090.5 9371.2 9650.3 9767.7 9859.2 9990.0 10115.8 10833.9 15651.1 16101.3 16119.4 23:20:24 INFO - 2015-11-19 23:20:24,231 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,231 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5764.51 Median:6041.94 stddev:3007.80 (49.8%) stddev-sans-first:2999.54 23:20:24 INFO - 2015-11-19 23:20:24,232 DEBUG : BROWSER_OUTPUT: Values: 1548.2 1551.6 1565.1 1779.8 1801.5 7533.0 7955.3 7966.6 8125.3 8491.0 8230.6 8339.3 8347.9 8382.2 8409.5 2346.2 2371.0 2372.3 2376.9 2378.1 2293.2 2320.1 2336.4 2339.0 2348.8 2341.8 2360.9 2361.9 2366.3 2383.5 2336.7 2353.6 2363.1 2366.7 2378.2 2365.1 2392.5 2400.4 2400.4 2403.2 8204.2 8241.3 8259.6 8262.2 8290.0 4603.4 4771.2 4780.0 5048.1 5162.3 3466.7 3481.6 3520.6 3528.8 3545.0 1019.1 1031.1 1039.5 1051.1 1054.5 11035.4 11092.1 11095.2 11104.1 11140.7 4618.0 4684.6 4739.1 4749.9 4765.7 9795.2 9812.6 9815.0 9819.6 9821.2 5224.6 5252.2 5253.4 5264.9 5267.6 4717.2 4774.3 4774.5 4781.9 4790.5 3698.3 3720.5 3746.3 3754.7 3775.2 1209.0 1229.9 1237.2 1238.1 1240.1 1081.3 1108.1 1222.1 1393.8 1396.5 7835.0 7900.4 7921.8 7924.1 7933.0 498.4 502.7 507.4 507.6 508.9 5859.7 6007.4 6026.5 6057.4 6067.9 9119.3 9328.9 9412.5 9447.7 10234.0 9786.6 9814.5 9913.8 10132.7 10151.1 7874.2 7897.2 7930.4 7942.6 7947.8 7531.4 7722.4 7723.0 7724.5 7731.9 7947.8 8039.4 8931.4 9049.6 9061.7 9075.6 9375.6 9376.3 9393.2 9554.0 6280.7 7193.1 7194.0 7279.6 7286.6 7916.9 7974.3 7977.9 7981.3 7982.3 7332.5 7429.9 7555.1 7606.4 7632.1 6333.7 6444.6 7305.3 7348.8 7423.1 7423.1 7450.8 7471.3 7519.8 7523.0 6833.2 6850.8 6862.4 6867.4 6872.7 6769.9 6901.7 6949.3 6950.6 6975.3 23:20:24 INFO - 2015-11-19 23:20:24,232 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,232 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5994.70 Median:6842.81 stddev:1914.70 (28.0%) stddev-sans-first:1872.09 23:20:24 INFO - 2015-11-19 23:20:24,233 DEBUG : BROWSER_OUTPUT: Values: 319.5 322.4 328.2 329.8 332.4 6827.2 6865.1 6897.8 6974.1 6978.4 5486.0 6833.4 6851.9 6862.8 6872.6 4939.4 5057.4 5070.6 5090.4 5108.0 5059.5 5064.6 5076.1 5087.9 5114.1 5006.6 5010.9 5025.7 5030.5 5031.4 4792.4 4875.0 4887.4 5044.5 5049.1 4225.3 4253.3 4296.3 4307.1 4309.7 5287.0 6585.2 6592.7 6614.7 6635.8 4736.7 5493.8 5701.9 5838.4 5989.6 7390.8 7402.2 7404.6 7411.3 7422.1 3976.9 4804.8 4810.3 4811.6 4821.7 7522.1 7751.1 7822.2 7830.6 7866.8 4915.1 4924.1 4928.1 4931.6 4932.4 4977.1 4988.8 5005.0 5011.4 5014.4 5828.5 5963.1 5977.0 5988.1 5990.9 7375.7 7411.6 7412.7 7426.9 7430.3 1719.3 1735.3 1738.5 1740.1 1744.9 1110.6 1125.5 1131.8 1144.3 1146.8 6833.7 6859.0 6862.5 6902.8 6903.6 7638.5 7645.8 7653.3 7658.7 7659.7 6674.5 6852.1 6865.3 6882.0 6910.8 4062.6 4094.5 4096.1 4098.3 4101.1 7895.4 7899.1 7931.8 7937.3 7945.4 7662.8 7921.7 7941.1 7941.8 7947.9 7873.7 7897.6 7909.4 7913.0 7924.9 6763.8 7144.3 7441.7 7662.7 7696.1 7549.4 7551.6 7555.4 7560.4 7562.2 7905.9 7914.3 7916.3 7918.8 7923.5 4816.6 4930.4 4951.1 4964.1 4978.4 6173.5 7603.7 7625.2 7631.2 7631.4 5986.0 7340.4 7345.5 7353.4 7360.5 6628.2 6744.6 7094.0 7328.5 7332.4 5837.3 7178.6 7178.7 7192.7 7201.1 7202.5 7316.2 7338.2 7361.0 7362.9 7186.2 7193.3 7193.5 7203.5 7227.5 23:20:24 INFO - 2015-11-19 23:20:24,233 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,233 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19326.90 Median:26981.27 stddev:28050.19 (104.0%) stddev-sans-first:28094.00 23:20:24 INFO - 2015-11-19 23:20:24,234 DEBUG : BROWSER_OUTPUT: Values: 699.1 721.8 768.0 788.8 814.7 14526.5 14901.5 14906.3 14920.6 14932.9 13628.4 13843.7 13878.3 13880.7 13921.4 745.5 755.5 756.1 937.9 963.9 889.2 950.9 964.4 965.5 967.2 985.7 1012.3 1012.5 1013.5 1013.6 763.2 786.9 799.6 990.9 993.7 738.7 745.0 748.7 749.4 750.8 14528.6 14660.0 14711.7 14719.7 14721.8 10665.9 10952.5 11859.4 12066.4 12223.7 9284.9 9712.5 9895.3 10057.9 10120.0 3496.1 3543.3 3557.2 3563.2 3568.9 81656.0 82630.0 85002.6 85052.0 87356.1 9555.6 9564.9 9734.7 9796.4 10167.6 19496.5 19848.0 21172.0 21175.6 21183.4 7379.5 7384.9 7403.5 7410.8 7461.7 4131.0 4133.1 4174.8 4180.3 4196.1 3462.8 3499.6 3503.3 3503.5 3507.5 626.7 635.7 637.2 655.1 657.0 489.6 499.1 508.2 511.5 534.6 8460.2 8547.0 8644.8 8656.2 8813.7 472.2 509.2 531.8 548.4 573.3 4013.2 4334.7 4382.8 4488.9 4494.5 98462.0 100056.0 101398.0 101482.0 101738.5 85701.1 86602.1 86847.1 86890.0 87008.6 75990.6 76054.6 76170.2 76421.6 76787.5 8886.4 8898.2 8939.5 8962.7 9114.1 52817.7 53247.7 53427.9 53806.7 54308.7 72220.0 76138.6 76141.0 76149.6 76320.6 10687.6 10816.7 11073.3 11239.6 11294.8 11875.3 11906.5 12153.1 12445.9 12593.3 11248.3 11322.6 11769.4 11785.2 11969.8 10984.8 11204.0 11239.4 11648.7 12227.1 10910.6 11285.9 11383.7 11550.2 12025.6 9022.1 9103.5 9254.5 9399.2 9557.0 8868.7 9164.5 9927.3 9934.1 9988.5 23:20:24 INFO - 2015-11-19 23:20:24,234 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:20:24 INFO - 2015-11-19 23:20:24,234 DEBUG : BROWSER_OUTPUT: 23:20:24 INFO - 2015-11-19 23:20:24,690 INFO : Browser exited with error code: 0 23:20:24 INFO - 2015-11-19 23:20:24,715 INFO : Completed test dromaeo_css (00:18:34) 23:20:24 INFO - 2015-11-19 23:20:24,715 INFO : Starting test kraken 23:20:24 INFO - 2015-11-19 23:20:24,715 DEBUG : operating with platform_type : mac_ 23:20:24 INFO - 2015-11-19 23:20:24,716 INFO : Initialising browser for kraken test... 23:20:24 INFO - 2015-11-19 23:20:24,728 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmptLJV4o/profile http://localhost:49496/getInfo.html 23:20:26 INFO - 2015-11-19 23:20:26,762 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:20:26 INFO - 2015-11-19 23:20:26,762 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:20:26 INFO - 2015-11-19 23:20:26,762 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:20:26 INFO - 2015-11-19 23:20:26,762 DEBUG : BROWSER_OUTPUT: __metrics 23:20:26 INFO - 2015-11-19 23:20:26,778 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:20:27 INFO - 2015-11-19 23:20:27,452 INFO : Browser initialized. 23:20:27 INFO - 2015-11-19 23:20:27,452 INFO : Running cycle 1/1 for kraken test... 23:20:27 INFO - 2015-11-19 23:20:27,453 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmptLJV4o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:20:39 INFO - 2015-11-19 23:20:39,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 226312192 23:20:39 INFO - 2015-11-19 23:20:39,229 DEBUG : BROWSER_OUTPUT: 23:20:41 INFO - 2015-11-19 23:20:41,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-beat-detection) 23:20:42 INFO - 2015-11-19 23:20:42,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 275439616 23:20:42 INFO - 2015-11-19 23:20:42,352 DEBUG : BROWSER_OUTPUT: 23:20:44 INFO - 2015-11-19 23:20:44,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-dft) 23:20:45 INFO - 2015-11-19 23:20:45,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 289857536 23:20:45 INFO - 2015-11-19 23:20:45,484 DEBUG : BROWSER_OUTPUT: 23:20:48 INFO - 2015-11-19 23:20:48,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-fft) 23:20:49 INFO - 2015-11-19 23:20:49,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 274788352 23:20:49 INFO - 2015-11-19 23:20:49,280 DEBUG : BROWSER_OUTPUT: 23:20:51 INFO - 2015-11-19 23:20:51,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-oscillator) 23:20:51 INFO - 2015-11-19 23:20:51,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 277291008 23:20:51 INFO - 2015-11-19 23:20:51,862 DEBUG : BROWSER_OUTPUT: 23:20:53 INFO - 2015-11-19 23:20:53,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:20:54 INFO - 2015-11-19 23:20:54,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 279273472 23:20:54 INFO - 2015-11-19 23:20:54,566 DEBUG : BROWSER_OUTPUT: 23:20:57 INFO - 2015-11-19 23:20:57,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-darkroom) 23:20:57 INFO - 2015-11-19 23:20:57,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 277749760 23:20:57 INFO - 2015-11-19 23:20:57,851 DEBUG : BROWSER_OUTPUT: 23:21:00 INFO - 2015-11-19 23:21:00,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-desaturate) 23:21:01 INFO - 2015-11-19 23:21:01,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 278028288 23:21:01 INFO - 2015-11-19 23:21:01,222 DEBUG : BROWSER_OUTPUT: 23:21:04 INFO - 2015-11-19 23:21:04,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49496/tests/kraken/driver.html?testName=json-parse-financial) 23:21:04 INFO - 2015-11-19 23:21:04,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 278708224 23:21:04 INFO - 2015-11-19 23:21:04,614 DEBUG : BROWSER_OUTPUT: 23:21:06 INFO - 2015-11-19 23:21:06,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:21:06 INFO - 2015-11-19 23:21:06,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 312078336 23:21:06 INFO - 2015-11-19 23:21:06,692 DEBUG : BROWSER_OUTPUT: 23:21:08 INFO - 2015-11-19 23:21:08,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:21:09 INFO - 2015-11-19 23:21:09,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 313942016 23:21:09 INFO - 2015-11-19 23:21:09,092 DEBUG : BROWSER_OUTPUT: 23:21:11 INFO - 2015-11-19 23:21:11,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:21:11 INFO - 2015-11-19 23:21:11,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 322072576 23:21:11 INFO - 2015-11-19 23:21:11,736 DEBUG : BROWSER_OUTPUT: 23:21:14 INFO - 2015-11-19 23:21:14,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:21:14 INFO - 2015-11-19 23:21:14,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 322691072 23:21:14 INFO - 2015-11-19 23:21:14,840 DEBUG : BROWSER_OUTPUT: 23:21:17 INFO - 2015-11-19 23:21:17,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:21:17 INFO - 2015-11-19 23:21:17,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 323522560 23:21:17 INFO - 2015-11-19 23:21:17,914 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49496/tests/kraken/driver.html?testName=ai-astar) 23:21:19 INFO - 2015-11-19 23:21:19,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 382865408 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;110;110;111;110;111;102;110 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;120;144;153;118;142;141;116;155;116 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;182;183;180;184;185;183;186;186;177 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |3;audio-fft;60;70;74;78;77;79;80;84;75;54 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;86;83;121;75;105;106;135;73;74;115 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;88;87;88;87;87;88;87;86;87 23:21:19 INFO - 2015-11-19 23:21:19,826 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;94;94;94;95;95;95;94;95;94 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;85;86;84;85;85;85;97;132;126 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;55;53;54;54;54;54;63;52;53 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;63;64;65;66;66;66;68;70 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;81;81;81;81;81;80;80;84;81 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;122;124;120;131;124;121;118;123;124 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;126;137;137;138;134;137;169;135;132;121 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;65;66;64;65;66;64;64;64 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1068 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: __startTimestamp1448004079821__endTimestamp 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:21:19 INFO - 2015-11-19 23:21:19,827 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.09 (2.8%) stddev-sans-first:3.28 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 110.0 110.0 111.0 110.0 111.0 102.0 110.0 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.40 Median:143.00 stddev:16.06 (11.2%) stddev-sans-first:16.26 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: Values: 149.0 120.0 144.0 153.0 118.0 142.0 141.0 116.0 155.0 116.0 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.00 Median:184.00 stddev:2.79 (1.5%) stddev-sans-first:2.93 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: Values: 184.0 182.0 183.0 180.0 184.0 185.0 183.0 186.0 186.0 177.0 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.10 Median:77.50 stddev:9.37 (12.1%) stddev-sans-first:8.66 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: Values: 60.0 70.0 74.0 78.0 77.0 79.0 80.0 84.0 75.0 54.0 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,828 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:97.30 Median:73.50 stddev:22.10 (30.1%) stddev-sans-first:23.05 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: Values: 86.0 83.0 121.0 75.0 105.0 106.0 135.0 73.0 74.0 115.0 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:87.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 87.0 88.0 87.0 87.0 88.0 87.0 86.0 87.0 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:85.00 stddev:18.43 (21.7%) stddev-sans-first:19.12 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 84.0 85.0 85.0 85.0 97.0 132.0 126.0 23:21:19 INFO - 2015-11-19 23:21:19,829 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,830 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.23 (6.0%) stddev-sans-first:3.24 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: Values: 58.0 55.0 53.0 54.0 54.0 54.0 54.0 63.0 52.0 53.0 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:2.06 (3.1%) stddev-sans-first:2.17 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 63.0 64.0 65.0 66.0 66.0 66.0 68.0 70.0 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:1.25 (1.5%) stddev-sans-first:1.17 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: Values: 83.0 81.0 81.0 81.0 81.0 81.0 80.0 80.0 84.0 81.0 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:123.50 stddev:3.56 (2.9%) stddev-sans-first:3.64 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: Values: 120.0 122.0 124.0 120.0 131.0 124.0 121.0 118.0 123.0 124.0 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:137.00 stddev:12.64 (9.2%) stddev-sans-first:12.81 23:21:19 INFO - 2015-11-19 23:21:19,831 DEBUG : BROWSER_OUTPUT: Values: 126.0 137.0 137.0 138.0 134.0 137.0 169.0 135.0 132.0 121.0 23:21:19 INFO - 2015-11-19 23:21:19,832 DEBUG : BROWSER_OUTPUT: 23:21:19 INFO - 2015-11-19 23:21:19,832 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 23:21:19 INFO - 2015-11-19 23:21:19,832 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 66.0 64.0 65.0 66.0 64.0 64.0 64.0 23:21:19 INFO - 2015-11-19 23:21:19,832 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:21:19 INFO - 2015-11-19 23:21:19,832 DEBUG : BROWSER_OUTPUT: 23:21:20 INFO - 2015-11-19 23:21:20,442 INFO : Browser exited with error code: 0 23:21:20 INFO - 2015-11-19 23:21:20,490 INFO : Completed test kraken (00:00:55) 23:21:20 INFO - 2015-11-19 23:21:20,490 INFO : Starting test v8_7 23:21:20 INFO - 2015-11-19 23:21:20,491 DEBUG : operating with platform_type : mac_ 23:21:20 INFO - 2015-11-19 23:21:20,491 INFO : Initialising browser for v8_7 test... 23:21:20 INFO - 2015-11-19 23:21:20,504 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpEap5Lj/profile http://localhost:49496/getInfo.html 23:21:22 INFO - 2015-11-19 23:21:22,584 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:21:22 INFO - 2015-11-19 23:21:22,585 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:21:22 INFO - 2015-11-19 23:21:22,585 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:21:22 INFO - 2015-11-19 23:21:22,585 DEBUG : BROWSER_OUTPUT: __metrics 23:21:22 INFO - 2015-11-19 23:21:22,602 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:21:23 INFO - 2015-11-19 23:21:23,263 INFO : Browser initialized. 23:21:23 INFO - 2015-11-19 23:21:23,263 INFO : Running cycle 1/1 for v8_7 test... 23:21:23 INFO - 2015-11-19 23:21:23,263 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpEap5Lj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:21:35 INFO - 2015-11-19 23:21:35,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 226004992 23:21:35 INFO - 2015-11-19 23:21:35,130 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49496/tests/v8_7/run.html (next: http://localhost:49496/tests/v8_7/run.html) 23:21:56 INFO - 2015-11-19 23:21:56,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 726552576 23:21:56 INFO - 2015-11-19 23:21:56,787 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,787 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:21:56 INFO - 2015-11-19 23:21:56,787 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:21:56 INFO - 2015-11-19 23:21:56,787 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:21:56 INFO - 2015-11-19 23:21:56,787 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |0;Richards;148.06040864672786 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;181.8181818181818 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4892.682926829269 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1805.0541516245487 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |5;Earley;843.8818565400844 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |6;Boyer;12625 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |7;RegExp;28055.555555555555 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |8;Splay;745.0284090909091 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4524.886877828054 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: __startTimestamp1448004116781__endTimestamp 23:21:56 INFO - 2015-11-19 23:21:56,788 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.06 Median:148.06 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: Values: 148.1 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:181.82 Median:181.82 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: Values: 181.8 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: Values: 282.1 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4892.68 Median:4892.68 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,789 DEBUG : BROWSER_OUTPUT: Values: 4892.7 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1805.05 Median:1805.05 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: Values: 1805.1 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:843.88 Median:843.88 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: Values: 843.9 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12625.00 Median:12625.00 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: Values: 12625.0 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28055.56 Median:28055.56 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: Values: 28055.6 23:21:56 INFO - 2015-11-19 23:21:56,790 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,791 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:745.03 Median:745.03 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,791 DEBUG : BROWSER_OUTPUT: Values: 745.0 23:21:56 INFO - 2015-11-19 23:21:56,791 DEBUG : BROWSER_OUTPUT: 23:21:56 INFO - 2015-11-19 23:21:56,791 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4524.89 Median:4524.89 stddev:0.00 (0.0%) 23:21:56 INFO - 2015-11-19 23:21:56,791 DEBUG : BROWSER_OUTPUT: Values: 4524.9 23:21:56 INFO - 2015-11-19 23:21:56,791 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:21:56 INFO - 2015-11-19 23:21:56,791 DEBUG : BROWSER_OUTPUT: 23:21:57 INFO - 2015-11-19 23:21:57,505 INFO : Browser exited with error code: 0 23:21:57 INFO - 2015-11-19 23:21:57,523 INFO : Completed test v8_7 (00:00:37) 23:21:57 INFO - 2015-11-19 23:21:57,844 INFO : Completed test suite (00:20:07) 23:21:57 INFO - 2015-11-19 23:21:57,844 DEBUG : Working with test: dromaeo_css 23:21:57 INFO - 2015-11-19 23:21:57,844 DEBUG : Generating results file: dromaeo_css 23:21:57 INFO - 2015-11-19 23:21:57,845 DEBUG : Working with test: kraken 23:21:57 INFO - 2015-11-19 23:21:57,845 DEBUG : Generating results file: kraken 23:21:57 INFO - 2015-11-19 23:21:57,845 INFO : javascript benchmark 23:21:57 INFO - 2015-11-19 23:21:57,846 DEBUG : Working with test: v8_7 23:21:57 INFO - 2015-11-19 23:21:57,846 DEBUG : Generating results file: v8_7 23:21:57 INFO - 2015-11-19 23:21:57,846 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:21:57 INFO - 2015-11-19 23:21:57,984 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 23:21:57 INFO - 2015-11-19 23:21:57,984 DEBUG : process_Request line: dromaeo_css 7661.09 graph.html#tests=[[72,1,59]] 23:21:57 INFO - 2015-11-19 23:21:57,984 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:21:58 INFO - 2015-11-19 23:21:58,107 DEBUG : process_Request line: kraken 1400.10 graph.html#tests=[[232,1,59]] 23:21:58 INFO - 2015-11-19 23:21:58,108 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:21:58 INFO - 2015-11-19 23:21:58,226 DEBUG : process_Request line: v8_7 19793.36 graph.html#tests=[[230,1,59]] 23:21:58 INFO - 2015-11-19 23:21:58,227 INFO : javascript benchmark 23:21:58 INFO - 2015-11-19 23:21:58,229 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3433.587969443666, 3435.74231932605, 3471.895843124707, 3490.4938783876337, 3511.0695665648623, 5733.713314334287, 5899.498542623872, 5912.497437717794, 6002.339742628313, 6056.394360563947, 5863.091220860762, 5883.0, 5911.497522710575, 6003.579749417542, 6019.819405417845, 5354.250404943311, 5369.275147855048, 5384.246205531229, 5404.540614047791, 5450.329338624066, 5498.1752737089555, 5512.91730624039, 5525.696086715229, 5543.279373681416, 5543.584231182657, 5259.0, 5360.490753378423, 5373.7581808818695, 5386.407495175527, 5416.972915135439, 5370.650907691027, 5384.488473595002, 5393.164059570773, 5407.215953686733, 5407.648502847303, 5305.495977882134, 5393.6763794172475, 5409.999150157233, 5411.56707463402, 5427.348718153847, 5830.7084645767545, 5832.125181222808, 5832.766689332421, 5834.183214349994, 5846.649201047908, 6252.437280644718, 6319.115323854664, 6377.2666143393635, 6383.616982981036, 6386.712597933104, 6288.496920246369, 6347.52393570484, 6363.109164716943, 6372.394622510854, 6383.61698298099, 6115.357887421801, 6134.202553667995, 6139.6009259398, 6141.109539116803, 6145.5698101133385, 5447.400785913546, 6288.748450062038, 6363.713632886531, 6377.9795232762535, 6422.967885160544, 6303.842403939938, 6384.904226436607, 6396.360363963567, 6413.871722565523, 6415.935840641627, 6366.236051673736, 6377.96811015942, 6379.170707807955, 6387.457066149336, 6409.0, 6169.444749972435, 6227.688615569204, 6287.717052732638, 6327.082573026885, 6354.078658594478, 6305.96847015762, 6321.304656487782, 6321.96839015802, 6330.272018717815, 6332.33510481402, 5060.165072763027, 5100.0819852426175, 5108.642395032386, 5133.281340612317, 5162.045021671003, 4388.0, 4460.665450091191, 4493.73037617744, 4513.119941611354, 4530.343100250445, 5879.647221166743, 5907.793227237112, 5941.821745347646, 5948.762049518057, 6017.217761691039, 6306.3378345274, 6327.17746692927, 6374.936250637527, 6396.5202609804455, 6425.1968503937005, 5660.943390566042, 5805.071188609802, 5808.215890854765, 5815.476607105296, 5851.707414629252, 5422.620416570802, 5445.83662490126, 5540.584456165804, 5546.057170281062, 5570.693611851387, 6465.838354041187, 6482.870342593122, 6487.3836985486305, 6596.340365963365, 6606.504512161607, 6328.462080723006, 6356.300806911144, 6366.204224471941, 6379.298277189599, 6404.583702059351, 6246.031865060922, 6301.369863013662, 6330.050492426173, 6334.239891212899, 6496.870062598627, 6240.4071613196675, 6345.587536810092, 6364.204474440695, 6365.427111559982, 6394.584352017104, 6299.181106456132, 6325.8734825304155, 6356.2054743157105, 6371.458426033653, 6444.516661250331, 5732.45541673557, 6124.142620033288, 6159.938400616115, 6180.227471566054, 6185.783497577563, 5407.405185429521, 6192.783252586138, 6296.937030629635, 6360.332165122781, 6401.0, 6192.164057852313, 6251.468625166912, 6257.7184026718, 6264.49884009269, 6268.686565671789, 5983.850403739767, 6225.221847269091, 6234.875302494015, 6302.401271879165, 6359.650219237987, 6001.129836173817, 6064.120702498025, 6094.268687757498, 6096.695165241631, 6112.776190144408], "unit": "ms", "name": "dojo.html", "value": 5852.62157014474}, {"lowerIsBetter": false, "replicates": [518.2330105173537, 560.2212924035591, 576.3458474631298, 600.4775845014838, 607.9726412311447, 31976.880809171682, 32446.837765811197, 39990.8000459998, 40274.7986260069, 40344.59655403445, 43580.0, 44096.55903440973, 44110.33834492485, 44212.55787442125, 44305.335419968724, 8626.913730862705, 8758.080401557809, 9608.327417080789, 9808.019198080206, 9811.803763924718, 8607.956960215222, 11824.527018919232, 11912.583059592916, 11928.284302941807, 11930.701732456715, 11670.708232294175, 11742.354170520617, 11745.588904388349, 11749.647510574696, 11751.647450576496, 8652.0, 8746.431481953652, 11705.473253703603, 11745.001674857647, 11788.115891308185, 8601.784955376166, 8698.695545655935, 8709.172628600272, 11647.35939523326, 11773.411329433495, 40491.59508404908, 40623.0, 40672.38991415131, 40684.0, 40781.59218407808, 3201.4557525220766, 3215.0515597898443, 3215.1479857837458, 3396.762226644136, 3636.3636363636524, 27720.0, 28645.71354286472, 28943.0, 29397.265068373246, 30261.546076808867, 2798.4962706712786, 2840.4603125406106, 2879.280179955011, 2909.432660631178, 2980.2549362659333, 456402.0, 504523.0, 505470.47264763806, 505521.0, 505865.0, 64664.67667661726, 65168.0, 65256.0, 65406.01890971639, 65432.0, 67140.32859671439, 67357.0, 67370.3262967364, 67504.3249567498, 67522.66238668874, 16147.596310092342, 16632.33470661184, 16639.833601663828, 16645.667086658443, 16696.914700544425, 12862.035347348987, 12923.353832308536, 12927.482900684055, 12940.288284144273, 12952.158109722837, 19175.94532300709, 19833.206671733256, 19889.900550497445, 19927.800721992593, 20026.99865006744, 8409.2431681149, 8561.315094792402, 8579.399442038997, 8629.22336989674, 8635.963684357917, 940.4827344960381, 970.8592254123113, 1021.2238698589126, 1123.5056575106926, 1180.2564384437749, 29642.85178574093, 29708.55437168444, 30321.848390758347, 30334.54498182529, 30506.54240186399, 999.3004896572428, 1032.6643840751785, 1073.978520429587, 1109.0905457524752, 1172.9648110556698, 13409.195448273134, 14111.22388268655, 14243.287835608178, 14424.495142669955, 14431.567052988426, 535949.0, 535949.0, 536748.0, 537963.0, 692715.0, 46352.0, 47648.523514765104, 56223.87552248932, 56350.436495634516, 56370.43629563734, 1400.5378225185664, 1445.6964037552023, 1453.7455945209547, 1455.86169313915, 1459.0151647637801, 26963.325916852235, 29186.56220156742, 30270.84864575663, 30394.84802575973, 30868.845655771576, 52996.735016324674, 53458.732706337774, 53524.78851268936, 53564.928701426536, 53581.73209133929, 461183.0, 470562.0, 470634.0, 471712.0, 472041.63979179884, 30660.540091898194, 30985.380292393576, 31716.524252136696, 31718.524222137148, 31766.682333176374, 45109.548904510535, 45115.09769804651, 45189.0, 45254.54745452503, 45801.770991146164, 37436.2512749738, 37705.43441848429, 38215.235695286494, 38499.0, 38665.61334386733, 30449.0, 36877.63122368849, 36971.815140924125, 37950.0, 38034.239315214094, 36909.70816021534, 37525.62474375221, 37836.81081594574, 37994.620053800216, 38019.61980380161, 33186.0, 33540.66459335375, 33638.52692344008, 33914.3217135651, 33956.32087358288, 24895.87552062228, 24942.0, 25179.87410062938, 25303.620445692963, 25530.234092976498], "unit": "ms", "name": "ext.html", "value": 20220.878248583773}, {"lowerIsBetter": false, "replicates": [353.99292014159704, 355.84165046554284, 359.40518441978537, 359.59725107879177, 365.917668524582, 16155.94986325891, 16645.91677041613, 20279.594408111847, 20316.59366812663, 20972.0, 21329.68005479915, 21719.501959284647, 21932.0, 22199.556008879812, 22208.777912220874, 6439.388258115483, 6626.171728533934, 6632.0, 6633.8341541461605, 6646.302138275484, 3881.941770873439, 3953.7034722395792, 3981.5819338969427, 5605.7197140142825, 6541.542092053558, 5726.942730572703, 5730.570207234474, 5735.111057786029, 5737.082066869301, 5744.109663002241, 5853.50245229156, 6346.30190679025, 6349.333320001379, 6353.9682301588655, 6365.681715914232, 5430.59270554706, 5542.334919809608, 5544.77820887164, 5550.222968784374, 5555.3611334696625, 12585.874141258562, 13167.0, 13192.868071319355, 13199.934000329937, 22241.11035558576, 1969.428865628966, 2077.210659949225, 2148.0655914677163, 2190.2224710227956, 2243.854149480295, 8425.747227583182, 9792.16527264319, 9815.263855210887, 9926.45404502752, 10183.33808302458, 1626.6421387294777, 1685.1826863970964, 1695.0931251780362, 1707.4024091567976, 1739.2955852879604, 97939.0, 102559.48720256351, 102625.48687256516, 103345.48327258391, 104811.42782858263, 10997.12023038155, 11001.944990274997, 11002.449877506093, 11008.064314533194, 11093.057090147428, 11275.605353812578, 13175.430790995855, 13285.0, 13289.667758305926, 13317.067805253539, 8431.704890328809, 8493.660253589911, 8503.61733721984, 8527.104654011364, 8533.061363250037, 7119.252478489684, 8643.394962352575, 8647.351448641377, 8694.782630434289, 8746.518941458153, 4272.594103560157, 4325.956740432555, 4335.588119128678, 4374.103308821684, 4377.277749171351, 1437.5974727076227, 1748.3968031029274, 1749.8775085743875, 1753.3074435597866, 1768.6904791661407, 781.9374450043982, 920.4707293306376, 935.7286386947845, 984.950752462374, 1099.6371197504805, 19519.512012199808, 19775.0, 20230.089645965672, 20795.27216547444, 20937.89531052335, 842.8351539967383, 924.9338443061231, 960.3805545423163, 975.9463229522445, 986.9950650246702, 10741.462926853626, 11139.610113645984, 11170.441477926071, 11638.709032274091, 11667.35829529384, 770133.0, 770356.0, 771472.1426392832, 780977.0, 785246.0, 113216.0, 116725.0, 117325.0, 117698.8230117705, 128195.0, 1156.2368836567825, 1161.181367136167, 1174.3306315400139, 1197.952081916731, 1198.922070065443, 18461.723074154168, 18773.1552080154, 19250.22999080021, 19850.305239316556, 20608.14859197136, 49777.67143227361, 51316.23025654544, 51934.74032629964, 52073.479265206865, 56271.15593266186, 66521.0, 68771.0, 69777.0, 71052.0, 73664.0, 9699.321047526606, 9709.70870873875, 10011.149052330633, 10108.191344692554, 10126.0, 19894.204231830565, 19981.80109193395, 20173.79826201778, 20545.691814622493, 20783.0, 15941.68116637684, 15993.760093598372, 16064.0, 16246.67506649884, 16374.181290935167, 13613.931930340284, 15786.526404207892, 16055.518334449986, 16056.43802466908, 16151.515454536382, 12679.93660031694, 12911.677208069497, 15022.699546009237, 15684.764728528853, 17090.48728538146, 9371.203447707021, 9650.262952668307, 9767.706968790948, 9859.161971232526, 9989.950050249703, 10115.848262276219, 10833.891661083604, 15651.139187344805, 16101.275442605345, 16119.435819746253], "unit": "ms", "name": "jquery.html", "value": 9840.57621562079}, {"lowerIsBetter": false, "replicates": [1548.2490991868942, 1551.557806025283, 1565.1469948877861, 1779.759732436121, 1801.4685667728022, 7533.0, 7955.323797477214, 7966.561839098855, 8125.309348705352, 8491.0, 8230.588470576477, 8339.33285337173, 8347.91652083479, 8382.245597896188, 8409.453385529936, 2346.1905642553334, 2371.0041782451412, 2372.2883135059415, 2376.940576485584, 2378.1200955646436, 2293.2317673579373, 2320.14154762738, 2336.404216924682, 2338.9649155262687, 2348.823838212132, 2341.8126549876056, 2360.8937597808053, 2361.917332893349, 2366.3019409274307, 2383.463720662846, 2336.684547586071, 2353.564590550745, 2363.1374548289837, 2366.656834758959, 2378.2389635316704, 2365.089440565395, 2392.5454163709014, 2400.3999000249937, 2400.4478969837037, 2403.218953840009, 8204.220599043141, 8241.25828675422, 8259.628316725762, 8262.17378262175, 8289.95855020721, 4603.447586289633, 4771.236602143675, 4780.0, 5048.066107770074, 5162.3030890830005, 3466.739994500397, 3481.6344283850085, 3520.5775306963073, 3528.8235588220487, 3545.0, 1019.0675531888313, 1031.097789434245, 1039.537405854395, 1051.1013083813307, 1054.4938429553856, 11035.39305338206, 11092.057175140042, 11095.223334366598, 11104.056155226735, 11140.665780026613, 4617.953820461819, 4684.5549672781035, 4739.075880203396, 4749.881252968635, 4765.69023013503, 9795.167410770164, 9812.558434870449, 9814.95092524547, 9819.558119884623, 9821.214302855755, 5224.582033437316, 5252.238425428368, 5253.369595648546, 5264.947350526446, 5267.578593712494, 4717.150912835723, 4774.283857421415, 4774.522547745267, 4781.928271075936, 4790.473047964721, 3698.2973235085246, 3720.4605332226674, 3746.2882052409955, 3754.6808521276, 3775.244951009809, 1208.9516419343304, 1229.8647148813623, 1237.1772771107112, 1238.0961897814645, 1240.0637518673525, 1081.3403823667556, 1108.1078385414062, 1222.0529089955178, 1393.7769956806862, 1396.5391420831102, 7834.960825195838, 7900.446968712135, 7921.762347129596, 7924.088729796032, 7932.960335198287, 498.3645851539316, 502.6983809714142, 507.41393690287777, 507.61421319796483, 508.9185730283137, 5859.736311865976, 6007.429294217042, 6026.487748541335, 6057.394260573908, 6067.908981365283, 9119.316051296179, 9328.868744060555, 9412.482313472688, 9447.669331573363, 10233.976602339706, 9786.608535658635, 9814.46020468881, 9913.80172396548, 10132.696019119438, 10151.1371533419, 7874.21257874208, 7897.24976127267, 7930.444868859125, 7942.563159026194, 7947.761567152995, 7531.435142364235, 7722.420818438527, 7722.961385193038, 7724.459287849797, 7731.922680773345, 7947.801304967422, 8039.397045221749, 8931.374803763674, 9049.59276832531, 9061.728148155566, 9075.636974520945, 9375.624975000923, 9376.343655944018, 9393.154616084585, 9553.952230238805, 6280.717367718372, 7193.136823581203, 7193.964030179815, 7279.563226206445, 7286.635668216674, 7916.920830791619, 7974.322182614543, 7977.880331794911, 7981.321587665114, 7982.281594656509, 7332.450066244946, 7429.925700742923, 7555.09338879338, 7606.353459955966, 7632.084149902047, 6333.714982825692, 6444.645544495098, 7305.269473052652, 7348.816279593053, 7423.146338170964, 7423.146338170964, 7450.776476705708, 7471.252874712485, 7519.812004699707, 7523.0, 6833.214180369321, 6850.794476165723, 6862.382385585322, 6867.381935625817, 6872.725090996304, 6769.901330587533, 6901.689423975833, 6949.270326615632, 6950.582965022115, 6975.337342952412], "unit": "ms", "name": "mootools.html", "value": 4643.200794425645}, {"lowerIsBetter": false, "replicates": [319.5127430668231, 322.3842460899681, 328.19428303514843, 329.75268548588554, 332.43983887150154, 6827.249002609715, 6865.107536020317, 6897.758578449749, 6974.128233970754, 6978.441724662028, 5485.9725701371535, 6833.4191593714595, 6851.897221541681, 6862.7598034068815, 6872.587644741307, 4939.43196532398, 5057.41839688435, 5070.619703522232, 5090.440051594322, 5108.0, 5059.544640982311, 5064.594832413417, 5076.111680455924, 5087.923681144785, 5114.053900028488, 5006.574441172486, 5010.899782004358, 5025.748712564376, 5030.471800460954, 5031.396232452111, 4792.424909010906, 4875.049365373754, 4887.3890763654545, 5044.545990860804, 5049.116404629193, 4225.302825033897, 4253.319468884994, 4296.269634162169, 4307.073979094478, 4309.698321117523, 5286.973565132188, 6585.2426970898005, 6592.703328350236, 6614.735410583571, 6635.8009259722285, 4736.668433209677, 5493.835184944458, 5701.916635839178, 5838.38696936824, 5989.580729348947, 7390.778276651709, 7402.222766609482, 7404.592747398891, 7411.258874112599, 7422.109346878356, 3976.940345894814, 4804.807807687688, 4810.254410566367, 4811.59101476375, 4821.68659037165, 7522.097348318237, 7751.147373788879, 7822.217778222189, 7830.647620857075, 7866.803329916798, 4915.090708218991, 4924.138275801792, 4928.063667903087, 4931.630127740434, 4932.383452068491, 4977.104121258136, 4988.775505102279, 5005.0, 5011.398632164163, 5014.373203349582, 5828.475437210586, 5963.075723262901, 5977.043673012384, 5988.101784732325, 5990.940090599125, 7375.704971801175, 7411.59236242001, 7412.703491860373, 7426.9257307427315, 7430.331270185709, 1719.312275089974, 1735.2711861018402, 1738.4697667211622, 1740.0690630512615, 1744.8604111671036, 1110.6279396402135, 1125.454154734953, 1131.7566723154562, 1144.2619510415734, 1146.8279758036194, 6833.726650933907, 6858.971154326791, 6862.451003919675, 6902.827429314308, 6903.585784852925, 7638.541687498768, 7645.847083058307, 7653.272939070779, 7658.693652253847, 7659.731909383145, 6674.466042716571, 6852.109225800614, 6865.27914568973, 6882.0, 6910.7581234656545, 4062.5937406259136, 4094.467719196485, 4096.078382363944, 4098.282800509958, 4101.097758493127, 7895.447318687751, 7899.131095579596, 7931.801704957307, 7937.285644291926, 7945.364370850318, 7662.808429789188, 7921.683132674743, 7941.086775020946, 7941.76902580101, 7947.880781788278, 7873.724419645285, 7897.605119744105, 7909.367250619936, 7913.0, 7924.881126782988, 6763.797086087426, 7144.285571442814, 7441.702331906879, 7662.6934922604705, 7696.076470823537, 7549.396048316012, 7551.584662843597, 7555.395568354628, 7560.395168386626, 7562.2437756223935, 7905.881411778943, 7914.287714105758, 7916.327112195528, 7918.762437126896, 7923.484973476706, 4816.614670826396, 4930.408350997904, 4951.10880041596, 4964.056829202585, 4978.411226162448, 6173.506119510518, 7603.657835397531, 7625.23747625233, 7631.1605723371495, 7631.3513351365755, 5985.970070149621, 7340.376068034277, 7345.5225410350295, 7353.448491363062, 7360.484766066324, 6628.237752658506, 6744.5616034957575, 7093.964530177316, 7328.487005909748, 7332.41340692754, 5837.328707198726, 7178.641067946686, 7178.748743793943, 7192.71229150849, 7201.13586369639, 7202.459815513753, 7316.158641756053, 7338.192798792235, 7360.96319518399, 7362.852742945004, 7186.245444228281, 7193.3166349196745, 7193.460490463341, 7203.495755297288, 7227.457940654577], "unit": "ms", "name": "prototype.html", "value": 5352.796021061609}, {"lowerIsBetter": false, "replicates": [699.0562740300592, 721.7690339091487, 767.9808004799879, 788.7791418402845, 814.6944895664126, 14526.491572794954, 14901.478448254313, 14906.329215185315, 14920.552383428487, 14932.850671493281, 13628.386722597483, 13843.653908652288, 13878.306084695776, 13880.652983675413, 13921.37353819078, 745.5005146551823, 755.4824944912725, 756.0700338583546, 937.8593211018351, 963.8554216867456, 889.1952782731638, 950.8858936927544, 964.3876138651937, 965.5027660754716, 967.2310513142033, 985.6550207427379, 1012.2913960227833, 1012.5241136665792, 1013.4527355228205, 1013.5742987945081, 763.1681467200777, 786.8662327404355, 799.6241766369855, 990.8959559246283, 993.7366597851575, 738.7266711316847, 745.02401853572, 748.715488114513, 749.3630414147985, 750.7672621487357, 14528.636784080376, 14660.0, 14711.70576588473, 14719.70560588793, 14721.779173312409, 10665.893341066567, 10952.452377381178, 11859.407029648482, 12066.396680165957, 12223.69440763979, 9284.860727089099, 9712.465814380277, 9895.307328487008, 10057.89942100577, 10120.038596333337, 3496.143444856001, 3543.255916257589, 3557.217412169319, 3563.233904710474, 3568.946465802989, 81656.0, 82630.0, 85002.57498712529, 85052.0, 87356.12643873607, 9555.579897035579, 9564.856527152098, 9734.707958761248, 9796.363236389612, 10167.644132455329, 19496.51258718515, 19848.0, 21172.0, 21175.576488470146, 21183.364499065054, 7379.5203311785635, 7384.852302954018, 7403.51877127985, 7410.814729631695, 7461.738839140604, 4130.979345103256, 4133.111381053028, 4174.791260437027, 4180.289350810309, 4196.055887425366, 3462.8095454749728, 3499.61504234534, 3503.2818272254126, 3503.4569641705575, 3507.4914137449928, 626.7399029402837, 635.7361694896658, 637.2034956304619, 655.0632595388545, 656.9671516424255, 489.5985292060476, 499.071726588545, 508.18182725811414, 511.51917197833916, 534.6177483099602, 8460.196281353261, 8546.957265213634, 8644.827103458021, 8656.156566988184, 8813.69152079687, 472.15719939907103, 509.20818127810867, 531.8298144593692, 548.4378512025206, 573.3005733005726, 4013.2174226025645, 4334.680437060282, 4382.846600368972, 4488.887777805581, 4494.505604383515, 98462.0, 100056.0, 101398.0, 101481.98518014872, 101738.45653858712, 85701.14298857056, 86602.13397866067, 86847.13152868517, 86890.0, 87008.5649571748, 75990.62004690051, 76054.61972690102, 76170.23829761743, 76421.61789191018, 76787.46425071468, 8886.362276344891, 8898.154675305836, 8939.508327042075, 8962.68630597926, 9114.13415725505, 52817.7359113202, 53247.73376133094, 53427.93144137173, 53806.73096634492, 54308.728456359044, 72220.0, 76138.61930690311, 76141.0, 76149.61925190338, 76320.61839690767, 10687.572497100029, 10816.729581760519, 11073.280236784583, 11239.606613768807, 11294.774104518028, 11875.346855923008, 11906.52373905034, 12153.08851836098, 12445.875541244472, 12593.307368094842, 11248.26886252391, 11322.60370887015, 11769.352685602375, 11785.233959792586, 11969.760604788029, 10984.835227471754, 11203.99164075237, 11239.381833999209, 11648.650540483799, 12227.14409991292, 10910.563577457131, 11285.943570282096, 11383.715407114889, 11550.249233799776, 12025.63923082309, 9022.14289642483, 9103.453792772454, 9254.537273136451, 9399.201067909304, 9556.95221523888, 8868.689595864114, 9164.450132992042, 9927.255455840985, 9934.105930466292, 9988.501724741347], "unit": "ms", "name": "yui.html", "value": 6984.531752840525}], "name": "dromaeo_css", "value": 7661.088765272339}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 110.0, 111.0, 110.0, 111.0, 102.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [149.0, 120.0, 144.0, 153.0, 118.0, 142.0, 141.0, 116.0, 155.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [184.0, 182.0, 183.0, 180.0, 184.0, 185.0, 183.0, 186.0, 186.0, 177.0], "unit": "ms", "name": "audio-dft", "value": 183.0}, {"lowerIsBetter": true, "replicates": [60.0, 70.0, 74.0, 78.0, 77.0, 79.0, 80.0, 84.0, 75.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 121.0, 75.0, 105.0, 106.0, 135.0, 73.0, 74.0, 115.0], "unit": "ms", "name": "audio-oscillator", "value": 97.3}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 87.0, 88.0, 87.0, 87.0, 88.0, 87.0, 86.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 84.0, 85.0, 85.0, 85.0, 97.0, 132.0, 126.0], "unit": "ms", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 63.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 63.0, 64.0, 65.0, 66.0, 66.0, 66.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 81.0, 81.0, 81.0, 81.0, 80.0, 80.0, 84.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [120.0, 122.0, 124.0, 120.0, 131.0, 124.0, 121.0, 118.0, 123.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [126.0, 137.0, 137.0, 138.0, 134.0, 137.0, 169.0, 135.0, 132.0, 121.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 66.0, 64.0, 65.0, 66.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.7}], "name": "kraken", "value": 1400.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.06040864672786], "unit": "score", "name": "Richards", "value": 238.42970799999995}, {"lowerIsBetter": false, "replicates": [181.8181818181818], "unit": "score", "name": "DeltaBlue", "value": 363.649}, {"lowerIsBetter": false, "replicates": [282.08744710860367], "unit": "score", "name": "Encrypt", "value": 943.6116450000002}, {"lowerIsBetter": false, "replicates": [4892.682926829269], "unit": "score", "name": "Decrypt", "value": 54.40389332003988}, {"lowerIsBetter": false, "replicates": [1805.0541516245487], "unit": "score", "name": "RayTrace", "value": 409.95390599999996}, {"lowerIsBetter": false, "replicates": [843.8818565400844], "unit": "score", "name": "Earley", "value": 789.7586550000002}, {"lowerIsBetter": false, "replicates": [12625.0], "unit": "score", "name": "Boyer", "value": 52.78914851485148}, {"lowerIsBetter": false, "replicates": [28055.555555555555], "unit": "score", "name": "RegExp", "value": 32.470752475247544}, {"lowerIsBetter": false, "replicates": [745.0284090909091], "unit": "score", "name": "Splay", "value": 109.37972163965681}, {"lowerIsBetter": false, "replicates": [4524.886877828054], "unit": "score", "name": "NavierStokes", "value": 327.9640000000003}], "name": "v8_7", "value": 19793.360475167337}]} 23:21:58 INFO - RETURN: dromaeo_css: 7661.09 23:21:58 INFO - RETURN: kraken: 1400.10 23:21:58 INFO - RETURN: v8_7: 19793.36 23:21:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "19793.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1400.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7661.09"}}} 23:21:58 INFO - Return code: 0 23:21:58 INFO - # TBPL SUCCESS # 23:21:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:21:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:21:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:21:58 INFO - 2015-11-19 23:21:58.302 screenresolution[1992:16648] starting screenresolution argv=screenresolution get 23:21:58 INFO - 2015-11-19 23:21:58.304 screenresolution[1992:16648] Display 0: 1600x1200x32@60 23:21:58 INFO - 2015-11-19 23:21:58.310 screenresolution[1993:16651] starting screenresolution argv=screenresolution list 23:21:58 INFO - Available Modes on Display 0 23:21:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:21:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:21:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:21:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:21:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:21:58 INFO - Intel Iris: 23:21:58 INFO - Chipset Model: Intel Iris 23:21:58 INFO - Type: GPU 23:21:58 INFO - Bus: Built-In 23:21:58 INFO - VRAM (Dynamic, Max): 1536 MB 23:21:58 INFO - Vendor: Intel (0x8086) 23:21:58 INFO - Device ID: 0x0a2e 23:21:58 INFO - Revision ID: 0x0009 23:21:58 INFO - Displays: 23:21:58 INFO - Display: 23:21:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:21:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:21:58 INFO - Display Serial Number: 1600x1200 60 23:21:58 INFO - Main Display: Yes 23:21:58 INFO - Mirror: Off 23:21:58 INFO - Online: Yes 23:21:58 INFO - Rotation: Supported 23:21:58 INFO - Return code: 0 23:21:58 INFO - Running post-action listener: _resource_record_post_action 23:21:58 INFO - Running post-run listener: _resource_record_post_run 23:21:59 INFO - Total resource usage - Wall time: 1240s; CPU: 53.0%; Read bytes: 1200128; Write bytes: 689751552; Read time: 15; Write time: 2398 23:21:59 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 338442752; Write bytes: 336951296; Read time: 27840; Write time: 573 23:21:59 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 1200128; Write bytes: 341589504; Read time: 15; Write time: 1788 23:21:59 INFO - Running post-run listener: _upload_blobber_files 23:21:59 INFO - Blob upload gear active. 23:21:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:21:59 INFO - Copying logs to upload dir... 23:21:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.635968 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 23:21:59.685065) ========= ========= Started set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-19 23:21:59.689554) ========= 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.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009544 build_url: 'https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 4.91 ========= ========= Finished set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-19 23:22:04.610512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:22:04.610866) ========= 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.Ay0EpxNimx/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.Md3vtuo0rx/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004922 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:22:04.634956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 23:22:04.635323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 23:22:04.635715) ========= ========= Total master_lag: 5.10 =========