builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0258 starttime: 1469326522.27 results: success (0) buildid: 20160704030201 builduid: da65cfb24d6a43159876eeba140305ca revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.271558) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.272103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.272403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.310709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.311049) ========= 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.bPbqcW7tK3/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.qR13JmBmUg/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 --2016-07-23 19:15:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-07-23 19:15:22 (18.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.491874 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.826396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.826716) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bPbqcW7tK3/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.qR13JmBmUg/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.026070 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:22.875406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-23 19:15:22.875756) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39dffbba764210b25bfc1e749b4f16db77fa0d46 --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 39dffbba764210b25bfc1e749b4f16db77fa0d46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bPbqcW7tK3/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.qR13JmBmUg/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 2016-07-23 19:15:22,960 truncating revision to first 12 chars 2016-07-23 19:15:22,960 Setting DEBUG logging. 2016-07-23 19:15:22,960 attempt 1/10 2016-07-23 19:15:22,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39dffbba7642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-23 19:15:23,661 unpacking tar archive at: mozilla-central-39dffbba7642/testing/mozharness/ program finished with exit code 0 elapsedTime=0.996856 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-23 19:15:23.894606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:23.894938) ========= script_repo_revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:23.895343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:23.895646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-23 19:15:23.913600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-23 19:15:23.914045) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --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', '--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.bPbqcW7tK3/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.qR13JmBmUg/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:15:24 INFO - MultiFileLogger online at 20160723 19:15:24 in /builds/slave/test 19:15:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:15:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:15:24 INFO - {'append_to_log': False, 19:15:24 INFO - 'base_work_dir': '/builds/slave/test', 19:15:24 INFO - 'blob_upload_branch': 'Firefox', 19:15:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:15:24 INFO - 'branch': 'Firefox', 19:15:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:15:24 INFO - 'config_files': ('talos/mac_config.py',), 19:15:24 INFO - 'default_actions': ('clobber', 19:15:24 INFO - 'read-buildbot-config', 19:15:24 INFO - 'download-and-extract', 19:15:24 INFO - 'populate-webroot', 19:15:24 INFO - 'create-virtualenv', 19:15:24 INFO - 'install', 19:15:24 INFO - 'run-tests'), 19:15:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:15:24 INFO - 'download_minidump_stackwalk': True, 19:15:24 INFO - 'download_symbols': 'ondemand', 19:15:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:15:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:15:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:15:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:15:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:15:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:15:24 INFO - 'installer_path': 'installer.exe', 19:15:24 INFO - 'log_level': 'info', 19:15:24 INFO - 'log_name': 'talos', 19:15:24 INFO - 'log_to_console': True, 19:15:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:15:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:15:24 INFO - 'opt_config_files': (), 19:15:24 INFO - 'pip_index': False, 19:15:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:15:24 INFO - 'cmd': ('bash', 19:15:24 INFO - '-c', 19:15:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:15:24 INFO - 'enabled': True, 19:15:24 INFO - 'halt_on_failure': False, 19:15:24 INFO - 'name': 'check_screen_resolution'},), 19:15:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:15:24 INFO - 'cmd': ('bash', 19:15:24 INFO - '-c', 19:15:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:15:24 INFO - 'enabled': True, 19:15:24 INFO - 'halt_on_failure': False, 19:15:24 INFO - 'name': 'check_screen_resolution'},), 19:15:24 INFO - 'run_cmd_checks_enabled': True, 19:15:24 INFO - 'sps_profile': False, 19:15:24 INFO - 'sps_profile_interval': 0, 19:15:24 INFO - 'suite': 'dromaeojs', 19:15:24 INFO - 'system_bits': '32', 19:15:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:15:24 INFO - 'title': 't-yosemite-r7-0258', 19:15:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:15:24 INFO - 'use_talos_json': True, 19:15:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:15:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:15:24 INFO - 'work_dir': 'build'} 19:15:24 INFO - ##### 19:15:24 INFO - ##### Running clobber step. 19:15:24 INFO - ##### 19:15:24 INFO - Running pre-action listener: _resource_record_pre_action 19:15:24 INFO - Running main action method: clobber 19:15:24 INFO - rmtree: /builds/slave/test/build 19:15:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:15:26 INFO - Running post-action listener: _resource_record_post_action 19:15:26 INFO - ##### 19:15:26 INFO - ##### Finished clobber step (success) 19:15:26 INFO - ##### 19:15:26 INFO - ##### 19:15:26 INFO - ##### Running read-buildbot-config step. 19:15:26 INFO - ##### 19:15:26 INFO - Running pre-action listener: _resource_record_pre_action 19:15:26 INFO - Running main action method: read_buildbot_config 19:15:26 INFO - Using buildbot properties: 19:15:26 INFO - { 19:15:26 INFO - "project": "", 19:15:26 INFO - "product": "firefox", 19:15:26 INFO - "script_repo_revision": "production", 19:15:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:15:26 INFO - "repository": "", 19:15:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:15:26 INFO - "buildid": "20160704030201", 19:15:26 INFO - "stage_platform": "macosx64", 19:15:26 INFO - "basedir": "/builds/slave/test", 19:15:26 INFO - "nightly_build": "True", 19:15:26 INFO - "buildnumber": 18, 19:15:26 INFO - "slavename": "t-yosemite-r7-0258", 19:15:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:15:26 INFO - "platform": "yosemite_r7", 19:15:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:15:26 INFO - "branch": "mozilla-central", 19:15:26 INFO - "repo_path": "mozilla-central", 19:15:26 INFO - "revision": "39dffbba764210b25bfc1e749b4f16db77fa0d46", 19:15:26 INFO - "pgo_build": "False", 19:15:26 INFO - "builduid": "da65cfb24d6a43159876eeba140305ca", 19:15:26 INFO - "slavebuilddir": "test" 19:15:26 INFO - } 19:15:26 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg. 19:15:26 INFO - Running post-action listener: _resource_record_post_action 19:15:26 INFO - ##### 19:15:26 INFO - ##### Finished read-buildbot-config step (success) 19:15:26 INFO - ##### 19:15:26 INFO - ##### 19:15:26 INFO - ##### Running download-and-extract step. 19:15:26 INFO - ##### 19:15:26 INFO - Running pre-action listener: _resource_record_pre_action 19:15:26 INFO - Running main action method: download_and_extract 19:15:26 INFO - mkdir: /builds/slave/test/build/tests 19:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.test_packages.json 19:15:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 19:15:26 INFO - Downloaded 1199 bytes. 19:15:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:15:26 INFO - Using the following test package requirements: 19:15:26 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:15:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:15:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:15:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'jsshell-mac.zip'], 19:15:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:15:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:15:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:15:26 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:15:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:15:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:15:26 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:15:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.common.tests.zip 19:15:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:15:26 INFO - Downloaded 18791473 bytes. 19:15:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:15:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:15:29 INFO - Return code: 0 19:15:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.common.tests.zip 19:15:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:15:29 INFO - Downloaded 18791473 bytes. 19:15:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:15:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:15:33 INFO - Return code: 0 19:15:33 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')]} 19:15:33 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.talos.tests.zip 19:15:33 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:15:37 INFO - Downloaded 14405327 bytes. 19:15:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:15:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:15:38 INFO - Return code: 0 19:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg 19:15:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 19:15:45 INFO - Downloaded 112575649 bytes. 19:15:45 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg 19:15:45 INFO - mkdir: /builds/slave/test/properties 19:15:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:15:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:15:45 INFO - Contents: 19:15:45 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg 19:15:45 INFO - Running post-action listener: _resource_record_post_action 19:15:45 INFO - Running post-action listener: set_extra_try_arguments 19:15:45 INFO - ##### 19:15:45 INFO - ##### Finished download-and-extract step (success) 19:15:45 INFO - ##### 19:15:45 INFO - ##### 19:15:45 INFO - ##### Running populate-webroot step. 19:15:45 INFO - ##### 19:15:45 INFO - Running pre-action listener: _resource_record_pre_action 19:15:45 INFO - Running main action method: populate_webroot 19:15:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:15:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:15:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:15:45 INFO - '--tppagecycles', 19:15:45 INFO - '7'], 19:15:45 INFO - 'tests': ['tsvgm']}}, 19:15:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:15:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:15:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:15:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:15:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:15:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:15:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['damp', 'tps']}, 19:15:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'tests': ['damp', 'tps']}, 19:15:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['dromaeo_dom']}, 19:15:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:15:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['basic_compositor_video']}, 19:15:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:15:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['a11yr', 19:15:45 INFO - 'ts_paint', 19:15:45 INFO - 'tpaint', 19:15:45 INFO - 'sessionrestore', 19:15:45 INFO - 'sessionrestore_no_auto_restore', 19:15:45 INFO - 'tabpaint']}, 19:15:45 INFO - 'other-e10s': {'tests': ['a11yr', 19:15:45 INFO - 'ts_paint', 19:15:45 INFO - 'tpaint', 19:15:45 INFO - 'sessionrestore', 19:15:45 INFO - 'sessionrestore_no_auto_restore', 19:15:45 INFO - 'tabpaint']}, 19:15:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:15:45 INFO - 'ts_paint', 19:15:45 INFO - 'tpaint', 19:15:45 INFO - 'sessionrestore', 19:15:45 INFO - 'sessionrestore_no_auto_restore', 19:15:45 INFO - 'tabpaint']}, 19:15:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:15:45 INFO - 'ts_paint', 19:15:45 INFO - 'tpaint', 19:15:45 INFO - 'sessionrestore', 19:15:45 INFO - 'sessionrestore_no_auto_restore', 19:15:45 INFO - 'tabpaint']}, 19:15:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['a11yr', 19:15:45 INFO - 'ts_paint', 19:15:45 INFO - 'tpaint', 19:15:45 INFO - 'sessionrestore', 19:15:45 INFO - 'sessionrestore_no_auto_restore', 19:15:45 INFO - 'tabpaint']}, 19:15:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['a11yr', 19:15:45 INFO - 'ts_paint', 19:15:45 INFO - 'tpaint', 19:15:45 INFO - 'sessionrestore', 19:15:45 INFO - 'sessionrestore_no_auto_restore', 19:15:45 INFO - 'tabpaint']}, 19:15:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['tsvgx', 19:15:45 INFO - 'tsvgr_opacity', 19:15:45 INFO - 'tart', 19:15:45 INFO - 'tscrollx', 19:15:45 INFO - 'cart']}, 19:15:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:15:45 INFO - 'tsvgr_opacity', 19:15:45 INFO - 'tart', 19:15:45 INFO - 'tscrollx', 19:15:45 INFO - 'cart']}, 19:15:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'talos_options': ['--disable-e10s'], 19:15:45 INFO - 'tests': ['tp5o']}, 19:15:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'tests': ['tp5o']}, 19:15:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'talos_options': ['--disable-e10s', 19:15:45 INFO - '--xperf_path', 19:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:15:45 INFO - 'tests': ['tp5n']}, 19:15:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:15:45 INFO - 'talos_options': ['--xperf_path', 19:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:15:45 INFO - 'tests': ['tp5n']}}, 19:15:45 INFO - 'talos.zip': {'path': '', 19:15:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:15:45 INFO - Running post-action listener: _resource_record_post_action 19:15:45 INFO - ##### 19:15:45 INFO - ##### Finished populate-webroot step (success) 19:15:45 INFO - ##### 19:15:45 INFO - ##### 19:15:45 INFO - ##### Running create-virtualenv step. 19:15:45 INFO - ##### 19:15:45 INFO - Running pre-action listener: _resource_record_pre_action 19:15:45 INFO - Running main action method: create_virtualenv 19:15:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:15:45 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 19:15:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:15:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:15:45 INFO - Using real prefix '/tools/python27' 19:15:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:15:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:15:48 INFO - Installing pip.................done. 19:15:48 INFO - Return code: 0 19:15:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:15: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')]} 19:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15: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')]} 19:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:48 INFO - 'HOME': '/Users/cltbld', 19:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:48 INFO - 'LOGNAME': 'cltbld', 19:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:48 INFO - 'MOZ_NO_REMOTE': '1', 19:15:48 INFO - 'NO_EM_RESTART': '1', 19:15:48 INFO - 'PAGER': '/bin/cat', 19:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:48 INFO - 'PWD': '/builds/slave/test', 19:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:48 INFO - 'SHELL': '/bin/bash', 19:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:15:48 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:48 INFO - 'USER': 'cltbld', 19:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:48 INFO - 'XPC_FLAGS': '0x0', 19:15:48 INFO - 'XPC_SERVICE_NAME': '0', 19:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:49 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 19:15:49 INFO - Cleaning up... 19:15:49 INFO - Return code: 0 19:15:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:15: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')]} 19:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15: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')]} 19:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 19:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 19:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:49 INFO - 'HOME': '/Users/cltbld', 19:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:49 INFO - 'LOGNAME': 'cltbld', 19:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:49 INFO - 'MOZ_NO_REMOTE': '1', 19:15:49 INFO - 'NO_EM_RESTART': '1', 19:15:49 INFO - 'PAGER': '/bin/cat', 19:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:49 INFO - 'PWD': '/builds/slave/test', 19:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:49 INFO - 'SHELL': '/bin/bash', 19:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:15:49 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:49 INFO - 'USER': 'cltbld', 19:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:49 INFO - 'XPC_FLAGS': '0x0', 19:15:49 INFO - 'XPC_SERVICE_NAME': '0', 19:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:49 INFO - Downloading/unpacking psutil>=3.1.1 19:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:15:52 INFO - Installing collected packages: psutil 19:15:52 INFO - Running setup.py install for psutil 19:15:52 INFO - building 'psutil._psutil_osx' extension 19:15:52 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 19:15:53 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 19:15:53 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 19:15:53 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 19:15:53 INFO - building 'psutil._psutil_posix' extension 19:15:53 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 19:15:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:15:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:15:53 INFO - ^ 19:15:53 INFO - 1 warning generated. 19:15:53 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 19:15:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:15:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:15:53 INFO - Successfully installed psutil 19:15:53 INFO - Cleaning up... 19:15:53 INFO - Return code: 0 19:15:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 19:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 19:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:53 INFO - 'HOME': '/Users/cltbld', 19:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:53 INFO - 'LOGNAME': 'cltbld', 19:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:53 INFO - 'MOZ_NO_REMOTE': '1', 19:15:53 INFO - 'NO_EM_RESTART': '1', 19:15:53 INFO - 'PAGER': '/bin/cat', 19:15:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:53 INFO - 'PWD': '/builds/slave/test', 19:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:53 INFO - 'SHELL': '/bin/bash', 19:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:15:53 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:53 INFO - 'USER': 'cltbld', 19:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:53 INFO - 'XPC_FLAGS': '0x0', 19:15:53 INFO - 'XPC_SERVICE_NAME': '0', 19:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:15:56 INFO - Installing collected packages: mozsystemmonitor 19:15:56 INFO - Running setup.py install for mozsystemmonitor 19:15:56 INFO - Successfully installed mozsystemmonitor 19:15:56 INFO - Cleaning up... 19:15:56 INFO - Return code: 0 19:15:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:15: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')]} 19:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15: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')]} 19:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema==2.5.1 19:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:56 INFO - 'HOME': '/Users/cltbld', 19:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:56 INFO - 'LOGNAME': 'cltbld', 19:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:56 INFO - 'MOZ_NO_REMOTE': '1', 19:15:56 INFO - 'NO_EM_RESTART': '1', 19:15:56 INFO - 'PAGER': '/bin/cat', 19:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:56 INFO - 'PWD': '/builds/slave/test', 19:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:56 INFO - 'SHELL': '/bin/bash', 19:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:15:56 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:56 INFO - 'USER': 'cltbld', 19:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:56 INFO - 'XPC_FLAGS': '0x0', 19:15:56 INFO - 'XPC_SERVICE_NAME': '0', 19:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:57 INFO - Downloading/unpacking jsonschema==2.5.1 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:15:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:00 INFO - Downloading functools32-3.2.3-2.tar.gz 19:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:16:00 INFO - warning: no files found matching '*.txt' 19:16:00 INFO - no previously-included directories found matching 'build' 19:16:00 INFO - no previously-included directories found matching 'dist' 19:16:00 INFO - no previously-included directories found matching '.git*' 19:16:00 INFO - Installing collected packages: jsonschema, functools32 19:16:00 INFO - Running setup.py install for functools32 19:16:00 INFO - warning: no files found matching '*.txt' 19:16:00 INFO - no previously-included directories found matching 'build' 19:16:00 INFO - no previously-included directories found matching 'dist' 19:16:00 INFO - no previously-included directories found matching '.git*' 19:16:00 INFO - Successfully installed jsonschema functools32 19:16:00 INFO - Cleaning up... 19:16:00 INFO - Return code: 0 19:16:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:16: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')]} 19:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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')]} 19:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:16:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:16:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:00 INFO - 'HOME': '/Users/cltbld', 19:16:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:00 INFO - 'LOGNAME': 'cltbld', 19:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:00 INFO - 'MOZ_NO_REMOTE': '1', 19:16:00 INFO - 'NO_EM_RESTART': '1', 19:16:00 INFO - 'PAGER': '/bin/cat', 19:16:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:00 INFO - 'PWD': '/builds/slave/test', 19:16:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:00 INFO - 'SHELL': '/bin/bash', 19:16:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:16:00 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:16:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:00 INFO - 'USER': 'cltbld', 19:16:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:00 INFO - 'XPC_FLAGS': '0x0', 19:16:00 INFO - 'XPC_SERVICE_NAME': '0', 19:16:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:00 INFO - Downloading/unpacking blobuploader==1.2.4 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16:03 INFO - Downloading blobuploader-1.2.4.tar.gz 19:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:16:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:16:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16:04 INFO - Downloading docopt-0.6.1.tar.gz 19:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:16:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:16:04 INFO - Running setup.py install for blobuploader 19:16:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:16:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:16:04 INFO - Running setup.py install for requests 19:16:05 INFO - Running setup.py install for docopt 19:16:05 INFO - Successfully installed blobuploader requests docopt 19:16:05 INFO - Cleaning up... 19:16:05 INFO - Return code: 0 19:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 19:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 19:16:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:16:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:05 INFO - 'HOME': '/Users/cltbld', 19:16:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:05 INFO - 'LOGNAME': 'cltbld', 19:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:05 INFO - 'MOZ_NO_REMOTE': '1', 19:16:05 INFO - 'NO_EM_RESTART': '1', 19:16:05 INFO - 'PAGER': '/bin/cat', 19:16:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:05 INFO - 'PWD': '/builds/slave/test', 19:16:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:05 INFO - 'SHELL': '/bin/bash', 19:16:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:16:05 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:16:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:05 INFO - 'USER': 'cltbld', 19:16:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:05 INFO - 'XPC_FLAGS': '0x0', 19:16:05 INFO - 'XPC_SERVICE_NAME': '0', 19:16:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:16:05 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-6UopVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:16:05 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Ob6rtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:16:05 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-wrNns0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-beAEhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-HawnvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-SznRo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-i4N90x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-xdIIhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-xdMCXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-V9myfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rvK_TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:16:06 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-XuatrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:16:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-R5EsF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:16:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-SeYOJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-StjbJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:16:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-65L6Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:16:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-wxokql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:16:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:16:07 INFO - Running setup.py install for manifestparser 19:16:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:16:07 INFO - Running setup.py install for mozcrash 19:16:07 INFO - Running setup.py install for mozdebug 19:16:07 INFO - Running setup.py install for mozdevice 19:16:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Running setup.py install for mozfile 19:16:08 INFO - Running setup.py install for mozhttpd 19:16:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Running setup.py install for mozinfo 19:16:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Running setup.py install for mozInstall 19:16:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:16:08 INFO - Running setup.py install for mozleak 19:16:08 INFO - Running setup.py install for mozlog 19:16:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:16:09 INFO - Running setup.py install for moznetwork 19:16:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:16:09 INFO - Running setup.py install for mozprocess 19:16:09 INFO - Running setup.py install for mozprofile 19:16:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:16:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:16:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:16:09 INFO - Running setup.py install for mozrunner 19:16:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:16:09 INFO - Running setup.py install for mozscreenshot 19:16:09 INFO - Running setup.py install for moztest 19:16:09 INFO - Running setup.py install for mozversion 19:16:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:16:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:16:10 INFO - Cleaning up... 19:16:10 INFO - Return code: 0 19:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16:10 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')]} 19:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:10 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')]} 19:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:16:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:16:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:10 INFO - 'HOME': '/Users/cltbld', 19:16:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:10 INFO - 'LOGNAME': 'cltbld', 19:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:10 INFO - 'MOZ_NO_REMOTE': '1', 19:16:10 INFO - 'NO_EM_RESTART': '1', 19:16:10 INFO - 'PAGER': '/bin/cat', 19:16:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:10 INFO - 'PWD': '/builds/slave/test', 19:16:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:10 INFO - 'SHELL': '/bin/bash', 19:16:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:16:10 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:16:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:10 INFO - 'USER': 'cltbld', 19:16:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:10 INFO - 'XPC_FLAGS': '0x0', 19:16:10 INFO - 'XPC_SERVICE_NAME': '0', 19:16:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:16:10 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-m6uqh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:16:10 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)) 19:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:16:10 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-t4t_ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:16:10 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-lSuPxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:16:10 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)) 19:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:16:10 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-zDUPTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:16:10 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-YoMXDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:16:10 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)) 19:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:16:10 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-CgS3QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:16:11 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-vxG93A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:16:11 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-1ZVs_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:16:11 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-cj84UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:16:11 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-29jYWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-dikIW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:16:11 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-uWNfsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:16:11 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-tF7v69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_lb4Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:16:11 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)) 19:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:11 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-HS6wl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:12 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)) 19:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:16:12 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-eLcqmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:16:12 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)) 19:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:16:12 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-X3oABa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:16:12 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)) 19:16:12 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:16:12 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:16:12 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)) 19:16:12 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:16:12 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:16:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:16:12 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 19:16:12 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 19:16:12 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 19:16:12 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 19:16:12 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 19:16:12 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 19:16:14 INFO - Downloading blessings-1.6.tar.gz 19:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:16:14 INFO - Installing collected packages: blessings 19:16:14 INFO - Running setup.py install for blessings 19:16:14 INFO - Successfully installed blessings 19:16:14 INFO - Cleaning up... 19:16:15 INFO - Return code: 0 19:16:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:16:15 INFO - Reading from file tmpfile_stdout 19:16:15 INFO - Current package versions: 19:16:15 INFO - blessings == 1.6 19:16:15 INFO - blobuploader == 1.2.4 19:16:15 INFO - docopt == 0.6.1 19:16:15 INFO - functools32 == 3.2.3-2 19:16:15 INFO - jsonschema == 2.5.1 19:16:15 INFO - manifestparser == 1.1 19:16:15 INFO - mozInstall == 1.12 19:16:15 INFO - mozcrash == 0.17 19:16:15 INFO - mozdebug == 0.1 19:16:15 INFO - mozdevice == 0.48 19:16:15 INFO - mozfile == 1.2 19:16:15 INFO - mozhttpd == 0.7 19:16:15 INFO - mozinfo == 0.9 19:16:15 INFO - mozleak == 0.1 19:16:15 INFO - mozlog == 3.2 19:16:15 INFO - moznetwork == 0.27 19:16:15 INFO - mozprocess == 0.22 19:16:15 INFO - mozprofile == 0.28 19:16:15 INFO - mozrunner == 6.11 19:16:15 INFO - mozscreenshot == 0.1 19:16:15 INFO - mozsystemmonitor == 0.3 19:16:15 INFO - moztest == 0.7 19:16:15 INFO - mozversion == 1.4 19:16:15 INFO - psutil == 3.1.1 19:16:15 INFO - requests == 1.2.3 19:16:15 INFO - wsgiref == 0.1.2 19:16:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:15 INFO - 'HOME': '/Users/cltbld', 19:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:15 INFO - 'LOGNAME': 'cltbld', 19:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:15 INFO - 'MOZ_NO_REMOTE': '1', 19:16:15 INFO - 'NO_EM_RESTART': '1', 19:16:15 INFO - 'PAGER': '/bin/cat', 19:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:15 INFO - 'PWD': '/builds/slave/test', 19:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:15 INFO - 'SHELL': '/bin/bash', 19:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:16:15 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:15 INFO - 'USER': 'cltbld', 19:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:15 INFO - 'XPC_FLAGS': '0x0', 19:16:15 INFO - 'XPC_SERVICE_NAME': '0', 19:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:16:15 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 2)) 19:16:15 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 3)) 19:16:15 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 4)) 19:16:15 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 5)) 19:16:15 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 6)) 19:16:15 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 7)) 19:16:15 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 8)) 19:16:15 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 9)) 19:16:15 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:16:15 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 4)) 19:16:15 INFO - Cleaning up... 19:16:15 INFO - Return code: 0 19:16:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f221618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc421dc5160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, '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.bPbqcW7tK3/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.qR13JmBmUg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 19:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 19:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 19:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:15 INFO - 'HOME': '/Users/cltbld', 19:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:15 INFO - 'LOGNAME': 'cltbld', 19:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:15 INFO - 'MOZ_NO_REMOTE': '1', 19:16:15 INFO - 'NO_EM_RESTART': '1', 19:16:15 INFO - 'PAGER': '/bin/cat', 19:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:15 INFO - 'PWD': '/builds/slave/test', 19:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:15 INFO - 'SHELL': '/bin/bash', 19:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:16:15 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:15 INFO - 'USER': 'cltbld', 19:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:15 INFO - 'XPC_FLAGS': '0x0', 19:16:15 INFO - 'XPC_SERVICE_NAME': '0', 19:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:16:15 INFO - Cleaning up... 19:16:15 INFO - Return code: 0 19:16:15 INFO - Running post-action listener: _resource_record_post_action 19:16:15 INFO - Running post-action listener: _start_resource_monitoring 19:16:15 INFO - Starting resource monitoring. 19:16:15 INFO - ##### 19:16:15 INFO - ##### Finished create-virtualenv step (success) 19:16:15 INFO - ##### 19:16:15 INFO - ##### 19:16:15 INFO - ##### Running install step. 19:16:15 INFO - ##### 19:16:15 INFO - Running pre-action listener: _resource_record_pre_action 19:16:15 INFO - Running main action method: install 19:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:16:16 INFO - Reading from file tmpfile_stdout 19:16:16 INFO - Detecting whether we're running mozinstall >=1.0... 19:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:16:16 INFO - Reading from file tmpfile_stdout 19:16:16 INFO - Output received: 19:16:16 INFO - Usage: mozinstall [options] installer 19:16:16 INFO - Options: 19:16:16 INFO - -h, --help show this help message and exit 19:16:16 INFO - -d DEST, --destination=DEST 19:16:16 INFO - Directory to install application into. [default: 19:16:16 INFO - "/builds/slave/test"] 19:16:16 INFO - --app=APP Application being installed. [default: firefox] 19:16:16 INFO - mkdir: /builds/slave/test/build/application 19:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:16:50 INFO - Reading from file tmpfile_stdout 19:16:50 INFO - Output received: 19:16:50 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 19:16:50 INFO - Running post-action listener: _resource_record_post_action 19:16:50 INFO - ##### 19:16:50 INFO - ##### Finished install step (success) 19:16:50 INFO - ##### 19:16:50 INFO - ##### 19:16:50 INFO - ##### Running run-tests step. 19:16:50 INFO - ##### 19:16:50 INFO - Running pre-action listener: _resource_record_pre_action 19:16:50 INFO - Running main action method: run_tests 19:16:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:16:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:16:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:16:50 INFO - 2016-07-23 19:16:50.243 screenresolution[3783:28091] starting screenresolution argv=screenresolution get 19:16:50 INFO - 2016-07-23 19:16:50.246 screenresolution[3783:28091] Display 0: 1600x1200x32@60 19:16:50 INFO - 2016-07-23 19:16:50.251 screenresolution[3784:28093] starting screenresolution argv=screenresolution list 19:16:50 INFO - Available Modes on Display 0 19:16:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:16:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:16:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:16:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:16:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:16:50 INFO - Intel Iris: 19:16:50 INFO - Chipset Model: Intel Iris 19:16:50 INFO - Type: GPU 19:16:50 INFO - Bus: Built-In 19:16:50 INFO - VRAM (Dynamic, Max): 1536 MB 19:16:50 INFO - Vendor: Intel (0x8086) 19:16:50 INFO - Device ID: 0x0a2e 19:16:50 INFO - Revision ID: 0x0009 19:16:50 INFO - Displays: 19:16:50 INFO - Display: 19:16:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:16:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:16:50 INFO - Display Serial Number: 1600x1200 60 19:16:50 INFO - Main Display: Yes 19:16:50 INFO - Mirror: Off 19:16:50 INFO - Online: Yes 19:16:50 INFO - Rotation: Supported 19:16:50 INFO - Return code: 0 19:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:16:50 INFO - Python 2.7.3 19:16:50 INFO - Return code: 0 19:16:50 INFO - grabbing minidump binary from tooltool 19:16:50 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')]} 19:16:50 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f0d30>, '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 0x10ee55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0e8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:16:50 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 19:16:50 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 19:16:50 INFO - Calling ['/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'] with output_timeout 600 19:16:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:16:50 INFO - Return code: 0 19:16:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:16:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:16:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:16:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:16:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bPbqcW7tK3/Render', 19:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:50 INFO - 'HOME': '/Users/cltbld', 19:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:50 INFO - 'LOGNAME': 'cltbld', 19:16:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:16:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:50 INFO - 'MOZ_NO_REMOTE': '1', 19:16:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:16:50 INFO - 'NO_EM_RESTART': '1', 19:16:50 INFO - 'PAGER': '/bin/cat', 19:16:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:50 INFO - 'PWD': '/builds/slave/test', 19:16:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:50 INFO - 'SHELL': '/bin/bash', 19:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qR13JmBmUg/Listeners', 19:16:50 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 19:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:50 INFO - 'USER': 'cltbld', 19:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:50 INFO - 'XPC_FLAGS': '0x0', 19:16:50 INFO - 'XPC_SERVICE_NAME': '0', 19:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:16:50 INFO - mozversion application_buildid: 20160704030201 19:16:50 INFO - mozversion application_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 19:16:50 INFO - mozversion application_display_name: Nightly 19:16:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:16:50 INFO - mozversion application_name: Firefox 19:16:50 INFO - mozversion application_remotingname: firefox 19:16:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:16:50 INFO - mozversion application_vendor: Mozilla 19:16:50 INFO - mozversion application_version: 50.0a1 19:16:50 INFO - mozversion platform_buildid: 20160704030201 19:16:50 INFO - mozversion platform_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 19:16:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:16:50 INFO - mozversion platform_version: 50.0a1 19:16:50 INFO - using testdate: 1469326610 19:16:50 INFO - actual date: 1469326610 19:16:50 INFO - starting webserver on 'localhost:49261' 19:16:50 INFO - SUITE-START | Running 2 tests 19:16:50 INFO - TEST-START | dromaeo_css 19:16:50 INFO - operating with platform_type : mac_ 19:16:50 INFO - Initialising browser for dromaeo_css test... 19:16:50 INFO - TEST-INFO | started process 3794 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmp3GH02K/profile http://localhost:49261/getInfo.html) 19:16:53 INFO - PROCESS | 3794 | __metrics Screen width/height:1600/1200 19:16:53 INFO - PROCESS | 3794 | colorDepth:24 19:16:53 INFO - PROCESS | 3794 | Browser inner width/height: 1024/689 19:16:53 INFO - PROCESS | 3794 | __metrics 19:16:53 INFO - PROCESS | 3794 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:16:53 INFO - PROCESS | 3794 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:16:54 INFO - TEST-INFO | 3794: exit 0 19:16:54 INFO - Browser initialized. 19:16:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:16:54 INFO - TEST-INFO | started process 3798 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmp3GH02K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:06 INFO - PROCESS | 3798 | RSS: Main: 243781632 19:17:06 INFO - PROCESS | 3798 | 19:17:56 INFO - PROCESS | 3798 | 1469326676983 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] 19:20:08 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49261/tests/dromaeo/cssquery-ext.html) 19:20:10 INFO - PROCESS | 3798 | RSS: Main: 366145536 19:20:10 INFO - PROCESS | 3798 | 19:23:13 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-ext.html (next: http://localhost:49261/tests/dromaeo/cssquery-jquery.html) 19:23:14 INFO - PROCESS | 3798 | RSS: Main: 383700992 19:23:14 INFO - PROCESS | 3798 | 19:26:16 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49261/tests/dromaeo/cssquery-mootools.html) 19:26:16 INFO - PROCESS | 3798 | RSS: Main: 375853056 19:26:16 INFO - PROCESS | 3798 | 19:29:19 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49261/tests/dromaeo/cssquery-prototype.html) 19:29:19 INFO - PROCESS | 3798 | RSS: Main: 371879936 19:29:19 INFO - PROCESS | 3798 | 19:32:23 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49261/tests/dromaeo/cssquery-yui.html) 19:32:23 INFO - PROCESS | 3798 | RSS: Main: 342753280 19:32:23 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-yui.html (next: http://localhost:49261/tests/dromaeo/cssquery-dojo.html) 19:35:27 INFO - PROCESS | 3798 | RSS: Main: 402743296 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | __start_tp_report 19:35:27 INFO - PROCESS | 3798 | _x_x_mozilla_page_load 19:35:27 INFO - PROCESS | 3798 | _x_x_mozilla_page_load_details 19:35:27 INFO - PROCESS | 3798 | |i|pagename|runs| 19:35:27 INFO - PROCESS | 3798 | |0;dojo.html;3371.8482668279926;3373.4602463605797;3379.831008449577;3396.269801992572;3415.5559777228955;5687.971560142204;5722.54219662427;5803.361630220672;5878.294604647443;5890.793822216228;5852.473277405033;5860.76556937723;5874.500667443262;5877.500412464946;5881.147233651118;5200.32395788547;5239.397469291042;5253.60597955153;5266.92099618506;5311.867203319928;5317.229001794737;5326.094563924123;5328.440513746059;5329.493698098674;5340.305760251162;5210.687358758468;5224.059669259532;5236.738163091849;5246.291750613656;5311.282976798141;5283.920741188886;5313.574914006909;5318.0583065423425;5322.308099947021;5363.517283444469;5089.236614507817;5134.589232861399;5197.740112994373;5260.105782017066;5281.577473802086;4795.424549054101;5714.1428785682065;5720.170575266605;5812.854678633068;5837.270341207349;6191.19514463117;6210.192674952227;6213.347598502182;6229.127922090911;6252.624842509464;6166.568340216187;6230;6271.43557079865;6294.087357333161;6308.589941653778;5996.670183139926;6003.189569408074;6008.909866352008;6013.579049466495;6026.999999999956;6306.873862522815;6333.46165575922;6339.144215530937;6341.524385671093;6345.07996340528;6083.878322433527;6111.449969502766;6165.414285642857;6187.690615469299;6280.466160376328;6281.026440901576;6300.621962682254;6313.147725057151;6315.3053164152825;6333.050042493571;6203.565750397519;6270.3416141305415;6271.090691849748;6285.057241413733;6292.182016337847;6165.506759459233;6211.503079753609;6217.036359364306;6278.6546739929745;6286.465650419674;4897.779599917941;4935.284383764334;4992.326035985168;5014.674046186986;5028.195488721787;4454.665900057508;4454.732716037048;4466.642668586505;4478.312074575313;4496.505384407713;5835.533157347402;5852.648841069549;5873.794417195463;5899.616524925866;5945.256842894638;6113.354685976905;6116.792316687851;6233.657148856856;6242.219722534684;6304.464120549805;5837.678927658934;5871.324797648325;5903.527717782567;5912.083627037816;5985.461308482258;5483.561315094783;5492.972535137299;5504.9449505504435;5505.889882202334;5520.337559492807;6381.968090159612;6385.553011289258;6394.712237949397;6399.8080057598345;6418.037294405876;6193.659348735863;6249.937500624936;6260.874782504234;6281.591696539893;6298.496120310272;6346.048092786119;6361.332060133619;6365.108884756045;6367.87264254703;6370.55406121567;6113.141862489121;6246.469050130608;6263.342349053284;6270.4670103039925;6301.023341382093;6232.25212974446;6257.937420625735;6306.1801965746;6306.747730090745;6313.873722525615;6175.166352542349;6213.37866213375;6219.346968568235;6223.471004964629;6225.439710426083;6046.334903160561;6100.944524685144;6182.289036760651;6207.503399728102;6213.813585592439;4904.681195722266;6036.245469316335;6109.075641173016;6113.358097399709;6115.052166914135;6203.410675985774;6256.405641464054;6268.686565671607;6269.780557680459;6274.749010039547;5387.946120538744;5763.164341170423;5900.1149827526215;5927.347991720993;6116.418940200674 19:35:27 INFO - PROCESS | 3798 | |1;ext.html;530.1305858392236;536.2653165163726;542.3600151820851;543.0198491722442;562.0753859900461;29395.11814645559;31010.53484197736;40699.38950915735;41576.544820931274;41624.791876040654;42866.571334286724;42929.57070429295;43026.78486607563;43091;43162.78418607903;9604.934938988115;9795.118439340458;9804.803903921917;9808.950955245215;9809.411435313905;8659.567021648923;8876.467411955271;11669.533218671242;11930.821037684442;11950.223235489666;11758.529658813637;11816.940915295412;11836;11849.229800062969;11866.821997670042;8680.479171249744;8866.86699699505;11702.473388697528;11741.236819606784;11775.823362649568;8646.78383040429;8688.391812573122;11443.713907152305;11749.588764393291;11757.470913808898;38945.61054389476;40795;41018.974525637095;41096;41229.76310710683;3047.725704686589;3411.539442175324;3490.5287786148797;3532.9646703532894;3627.2020155565733;31106.911258106084;31176.844115779502;31914;32488.512672309935;32539;3294.621118571371;3307.8842240521467;3326.1518312830317;3397.6262611112757;3420.4869269609508;441065;510463;512996;514107;516046.41976789874;61060;61967.690161548904;62017;62136.378636213056;62170;64873.67563162154;64975.35024649693;64983.675081624286;65104.67447662731;65240.67379663071;16151.111688857225;16641.25419305801;16677.16614169311;16693.582660433585;16738.24677889498;9784.804303914025;9821.428571428538;9868.703938881845;12752.80870786939;12809.487620495262;16147;16303.673926521404;16739.748903766453;16854.662906741796;19191.32830350931;6539.771108011197;7567.772966811004;7651.770446886602;7718.729844455529;7800.375969922393;926.3654396738256;933.6462129911655;1081.8972197641212;1132.4202737181586;1154.653603918821;23781.26515450745;28969.85515072411;29915.102546923627;30352;30625.846870765505;1101.0456439819225;1104.7845670094416;1110.5169251375517;1114.6990312615549;1160.9129315301386;15001.024933379296;15092.1699306537;15136.016158949633;15476.690466190614;15542.30059647296;692582;697051;703143;703619;705882;47898.5210147901;55241.51413186416;56722;57029.42970570241;57164;1226.589092653953;1378.3246209357544;1380.0063953953338;1413.3216056293038;1426.5934208750457;24649.507009860063;25753.84107715195;29098.854505727337;30313.93901213535;30871.38257234798;49176.2623560654;49719;49976;50031.49968500269;50033.49966500434;584021;589362;589636;589919.0504047453;590085;23087.88456057709;25499.617505737056;25903;25917.96328146853;26683.599746004213;41125.766227013235;45718.771406142754;45921.31118033166;45927.77036114798;46505.30242046304;35728.82135589305;38122.809385954;38294.85115446541;38742;39283.607163928;37697.86906392813;37831.81084094562;38359.42460863033;38464;38829.61170388373;36668;36793.26413471662;37224.441633374976;37225.6277437233;37431.81284093671;30306.696933030387;31206.063818085495;33166.66833331636;33888.491672624434;33986;23978.52042959166;24364;24747;25020.186358479976;25302.240932772045 19:35:27 INFO - PROCESS | 3798 | |2;jquery.html;353.3039911374591;374.1786778022241;389.3458988898651;389.78561791014937;403.951525816902;15964.042157470545;16118.274677639505;21068.683969740465;21311.467213319676;21327.93360331985;20864.061117249723;21447.82036987969;21712;21748.13007479699;21757;5372.892542149155;6094.786682466126;6263.373662633723;6263.686815659222;6273.654948977804;6159.23009623797;6252.874942501147;6277.560570760026;6277.968610156966;6282.9685851570675;5934.258217722785;6204.534659900503;6206.813795586117;6209.658468784215;6216.658083805389;5949.970250148722;6142.570020098595;6143.170671959273;6211.47202487789;6230.03434467656;5293.602979776532;5325.1479763238085;5327.920081198785;5328.6802791832615;5329.173978033411;21584;25995.350116247057;26512.80692368848;26876.86561567199;26878.924843006258;2484.1802205272215;2672.7460891215305;2881.8414987175697;2956.9556456653168;3156.526521021842;15029.849701503064;15654.060756354655;16162.515124546282;16300.021998680117;16401.83598164027;1811.3660218923403;1823.3344829137402;1835.577817102074;1918.4532408263717;1929.1126082002295;118402.81597184004;120729.79270207361;121959;122810;124933;9328.34701570897;9893.208543316518;9955.950220248853;10163.593456261815;10758.73103172427;12463.75072498545;12500.124991250706;12568.874311256954;12591.559295424617;12593.055520835975;8038.678452861937;8053.436259461899;8081.393895457747;8136.83726325482;8153.184681531918;8522.232999030117;8548.358873084544;8551.957240213758;8652.8702069469;8681.739547813575;3875.147467557133;3930.6855451563806;3931.1154990126993;3969.960300396959;3976.840926362971;1889.4426144287468;1916.9712454313196;1928.6046360496064;1931.65230258552;1938.6122775444685;827.2017503109528;905.4295793649958;917.5962576466467;935.4387367579398;1012.9442880641635;21700.782992170192;22527.88736056309;22541.54916901653;22603.88698056532;22720.886395567915;892.3396686451979;982.4301904895144;992.2062350119875;1008.8385858262643;1013.0527956360826;11171.21801473889;11211.719707007227;11751.529938802523;11755.412229388496;11844.585439509576;470652;587115;612085;613059;629547;144026.2798686;148059.038819223;149919.25040374947;151696;153748;919.72868003939;1014.2494554030112;1022.5449674894601;1022.6880801355658;1067.3809190669392;17208.741868871726;18587;19715.014249287193;20320.491987700425;20365.18539258413;55967;55973.72013139908;56461.58846028718;56913.861722764486;56927.86144277174;80502;81110.18889811262;81984.59007704923;82160;82452;7987.321077708228;8164.632591533514;8186.304164146114;8260.297874680478;8271.503709777433;11854.229475084092;13018.739625207632;13207.66980825487;13367.598972030855;13373.197608143542;11094.5562177512;11161.055041981004;11210.215284929976;11270.661880143609;11493.252938558968;9107.861517310335;10789.676309710721;11158;11206;11488.253263537843;11413.657590272305;11450.312981221154;11529.135314851252;11777.52889884395;11784;8014.318782903519;8160.347172226327;8177.34581233488;8225.670973161006;8352.123027082069;10017.248706347198;11246.437678115897;11437.59968401102;11464.4267786612;11522.942385288019 19:35:27 INFO - PROCESS | 3798 | |3;mootools.html;1104.9337039777608;1349.6558377613708;1511.4256582498651;1670.4404024651742;1910.4173227165709;7761.107472640648;8586.39895207335;8821.867671984925;8847.601857916394;8908.28733701304;7516.849663006737;8545.700900468484;8764.298856091513;8784.033756286819;8802.95598522008;2093.382452176604;2175.0321107107343;2296.7473577906417;2349.5418393413333;2386.1171366594385;2389.390705370128;2418.6372044193336;2419.11702228687;2419.6249581314837;2438.317271164077;2330.6387509935985;2371.1819422299277;2379.3456799380137;2380.297812145421;2382.523495300938;2067.5968186203695;2206.3711842124917;2276.647119696433;2349.9647505287435;2363.444590521226;2361.055577768889;2382.7736365045293;2387.9880600597057;2391.497785465054;2392.820538459605;8748.69379571712;8817.867731984026;8826.646934122627;8835.204831565126;8839.60221790021;5178.922316165261;5189.40321862983;5330.38700549434;5340.359156901158;5371.973140134313;3582.7133829293593;3640.2355505343908;3703.092742278159;3707.3141468828085;3716.996410969023;1068.1721665709138;1087.8912108789057;1091.7925594137168;1106.6569363497342;1113.059464752283;11642.76714465706;11655.242409243372;11656.184067115306;11675.065994720402;11678.416079196091;4574.359589657384;4673.742944138037;4831.622987448561;4831.975840120777;4837.733924634179;9892.060254275977;9897;9898.10917017472;9901.950490247502;9905.80188396228;5356.678599284055;5366.980273747976;5372.167314066326;5372.194170874322;5372.382176049804;4360.956390436118;4524.389207457017;4770.952290477051;4926.729029903389;4926.975365123151;3364.6635336466156;3891.6886649068006;3926.450296958371;4025.7584544926813;4026.469941422241;1158.9536418543332;1254.209847795901;1266.1010682415588;1266.5883587833991;1279.3795009420423;730.846522230327;776.3129630277245;846.5005646668495;859.53449368826;923.93532452729;4852.490488498727;5871.295444546682;5875.324337701134;6009.068594367793;6130.019196928559;913.1918252346721;922.1792604581927;940.9529523523796;946.9005754395689;950.9381890177116;3914.373700207953;3956.8219430125714;4014.277430062617;4032.7983600819844;4041.777702226406;9972.700818975442;10678.733031674115;10700.892991070144;10710.303830251009;10713.571457141627;10284.691459256233;10507.264491485523;10677.83983240252;10678.412687302272;10691.83962240567;8077.555734434663;8154.714584989615;8166.142555031755;8176.3458923286;8217.506949583045;5768;5792.884142317214;5862.530997520103;5886.58793884424;5956.225690660186;9835.557399916877;9897.50512474359;9899.802003960025;9936.304458687822;9942.900570994487;9784.168345690412;9971.85605094908;10206.897931020892;10215.846762298423;10221;7293.927060729537;7313.780586582411;7400.5189662671755;7403.962980185064;7443.441741869273;7883.605819709106;8186.181381861767;8224.465409748347;8235.83528329418;8263.462874913352;7489.251074892467;7526.397888168824;7555.282248186413;7615.923840761521;7695.846083078419;7402.148752893271;7413.481056326005;7496.287852653989;7529.924700753141;7552.471327007057;6083.270007599116;6872.553284036521;6920.757773477904;7034.366906978396;7040.542364746275;5009.474005229398;5023.648344615988;5040.546350828443;5083.161278389024;5161.354830646169;5050.621203409833;5053.772580233825;5058.190689489664;5067.163917953644;5258.368995720538 19:35:27 INFO - PROCESS | 3798 | |4;prototype.html;297.9687132851051;308.21559132009037;311.01098506748536;314.0280830828585;315.6685480245744;4287.249731297026;4300.462442194726;4529.886752831181;4996.700197988123;5189.169732842746;5154.659788455;5157.8452646420665;5161.890193608373;5183.818566350178;5188.6367954243215;3423.2982238641143;3699.833507492156;3757.5303087114044;3946.3291240489043;3985.6612187964056;3264.657210992847;3876.3991581304804;3934.527856657205;3947.539410418149;3962.4650672159178;3506.263684626219;3699.2971335446177;3897.59075297094;3913.8434462621462;3929.803509824512;3393.7794043387225;3703.90740231495;3810.8856734298015;3904.2777086239134;3977.4033894915706;3411.812350320731;3421.469672200813;3430.3243470093366;3435.4846772984;3444.896653100411;3947.8156553033973;5028.7988480460735;5046.26829109777;5093.694378337312;5095.535036175399;4194.538600753915;4253.511271055106;4253.659707223414;4491.236489796743;4526.954730452686;4437.5784300491405;5275.683458992435;5342.439043900412;5352.464753524655;5362.651427657229;2969.688182740803;3229.950266163483;3464;3781.8487260509546;3842.9423558646645;5135.768890399941;5210.062188806051;5329.493698098636;5604.327480702301;5659.490645841894;3565.893023209308;3809.5047643806683;3834.9233015339537;3850.6919446444217;3855.980720096438;3622.673959343619;3737.7757334560015;3930.901727456779;3951.68386529077;3964.524257089168;4080.1227736036894;4275.337322714984;4523.705959112713;4527.705699129546;4527.932081018787;4807.278908163804;4860.392450943632;5118.976204759063;5467.976848566056;5559.833205003856;1271.7790920716031;1296.3859994307147;1300.5693736889345;1301.4729034740944;1312.4159748911834;624.8625302433458;665.4144352969356;783.4476693930765;802.6315132698735;808.8058865872148;4698.2952557116705;4933.026789284243;4935.259711043301;5068.82259120929;5097.566706829887;4347.304431290978;5385.919211211835;5477.835664930059;5526.640768350045;5536.75084621193;4743.217369134123;5017.397912250553;5041.319421878;5074.797008119708;5082.339295891585;2734.5214587447117;2750.7111753265617;2908.9963962432926;2929.604503392015;2933.4133173365412;5093;5128.025745067852;5729.512991395694;5745.454181852718;5781.364049954502;4723.126221649006;5060.544550990355;5280.260763493114;5746.96554620164;5780.826575202751;5160.045391602565;5551.9722401386925;5730.541556675456;5783.045797443375;5793.797217097382;5588.776448941997;5605.80379686709;5607.130894711327;5607.158926161109;5627.634203776742;5172.379314482287;5518.2826232589505;5551.528120109836;5577.470140336662;5580.581456390706;4630.907381852411;5721.628094173865;5761.279840019997;5777.3933736957015;5798.623089499169;3608.9819550902075;3756.286305601927;3763.5295588051495;3766.6421689940507;3780.5652349979005;5477.178423236546;5541.556675466034;5558.388577256579;5571.275734154696;5587.938291724559;4803.327534145293;5039.697618142924;5129.2819005340025;5409.2427060212385;5475.4524547544925;5102.69383836971;5373;5394.433584473731;5397.676139431646;5416.83749487516;5242.68543887368;5310.787568497217;5313.309269794902;5323.574114070788;5328.001999250281;4981.178105612534;5108.233764935289;5278.5513231374225;5325.840224793263;5422.349318081698;5306.991671582387;5309.362876454696;5317.388500322358;5317.627766056339;5367.838964831061 19:35:27 INFO - PROCESS | 3798 | |5;yui.html;603.4200418821148;720.2473415281031;742.7289039500583;808.7371604228623;826.5743142281726;15107.471238506641;16105.597360066004;16360.427385041527;16565.585860353483;16776.161191940384;15130.319135638894;15203.847961520381;15229.238538073107;15247.16140612266;15305.693886122272;705.1397295299727;731.3052600029966;862.0603542139067;872.4808738800435;874.9868751968726;870.0733718589713;887.6493784954939;887.8135591525787;893.3344658229628;899.2715900120891;935.5228833295034;939.3893968920188;944.3578366710634;944.4852555357347;946;740.4409670698589;922.5433410461798;927.7263207353847;932.2402242172642;935.9110884465965;699.1121275979528;699.5557820783839;700.1877821726823;700.7407259314035;704.0354714041745;15177.696446071128;15255.38978440861;15291.464798731991;15295.464658736892;15328.15695136767;14142.717145657029;14219.502317418945;14279.857201427956;14378.209198494078;14604.561863144123;12938.741225175538;13140.60578182656;13180.934095329461;13363.732725345535;13573.932130339284;4575.039620441172;4742.644301677354;4747.311639812242;4753.096911586822;4771.785269662873;120379;120524;129976;130096.34951825275;130242.99999999905;9746.61013559464;11278.379689117177;11436.656900293005;11461.828072578917;11676.824847627293;22908;22951.42621434444;22969.425764355692;22971.196008139636;23019.769802302097;8227.382946279053;8230.382721295926;8324.83350333002;8435.32517398619;8442.831143377098;4518.525554816762;4628.120657075145;4635.768211589474;4644.326572646947;4829.710217386968;3541.964580354215;3631.5460567429072;3632.600413954463;3632.7457078004286;3645.489631451599;677.8136012596575;705.5378726933867;709.2411120101442;721.3688022979893;725.9963700181571;506.60231718101113;578.8176724331822;656.9967150164218;688.7313947560456;710.2116650517921;8298.8340233195;9580.473073980998;9677.870868408938;9720.173785228335;9761.609535618496;534.4094775273345;656.1666683312167;663.867226554691;667.956582822115;684.948628852838;4707.364505791675;4789.976050119727;4818;4849.127157111683;4858.73276969763;93950;94955.050449496;95199;95468.52265738766;103793;113570.43214783873;117803;127805.88776449024;139237;140442.5513193548;97704;103771;105484;108099;109329.36005959917;9770.902290977;10153.492325383553;10204.38773673582;10226.693199204035;10235.437050962268;63864;64513.35486645261;65316.346836532924;65402.672986636666;66427.41008049979;84262.57868710617;89958.55020724854;94544.52727736317;94891;97956;13243;13359.198448093146;13372.93313533465;13394.263315517741;13780.784736358983;14996.896337678461;15222.543323700307;15366.231688415312;15467.303971321542;15640.530784076496;8499.662711797082;14020.649483762987;14461.060031097944;14555.12669239849;14850.40598376096;13980;14143.363862038741;14358.282085895873;14399.42402303938;14667.251310465908;13653.385597648328;13894.305284735925;14221.98041349301;14353.569392918229;14469.565913022627;11261.436928153724;11538.538458461904;11583.362915039754;11634.011109055487;11657.53369865196;10529.498057251558;11355.205135640426;11717.238379505305;11731.178817482694;11756.647300580997 19:35:27 INFO - PROCESS | 3798 | __end_tp_report 19:35:27 INFO - PROCESS | 3798 | __start_cc_report 19:35:27 INFO - PROCESS | 3798 | _x_x_mozilla_cycle_collect,1394 19:35:27 INFO - PROCESS | 3798 | __end_cc_report 19:35:27 INFO - PROCESS | 3798 | __startTimestamp1469327727360__endTimestamp 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | ------- Summary: start ------- 19:35:27 INFO - PROCESS | 3798 | Number of tests: 6 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | [#0] dojo.html Cycles:165 Average:5803.55 Median:6083.88 stddev:649.26 (10.7%) stddev-sans-first:622.59 19:35:27 INFO - PROCESS | 3798 | Values: 3371.8 3373.5 3379.8 3396.3 3415.6 5688.0 5722.5 5803.4 5878.3 5890.8 5852.5 5860.8 5874.5 5877.5 5881.1 5200.3 5239.4 5253.6 5266.9 5311.9 5317.2 5326.1 5328.4 5329.5 5340.3 5210.7 5224.1 5236.7 5246.3 5311.3 5283.9 5313.6 5318.1 5322.3 5363.5 5089.2 5134.6 5197.7 5260.1 5281.6 4795.4 5714.1 5720.2 5812.9 5837.3 6191.2 6210.2 6213.3 6229.1 6252.6 6166.6 6230.0 6271.4 6294.1 6308.6 5996.7 6003.2 6008.9 6013.6 6027.0 6306.9 6333.5 6339.1 6341.5 6345.1 6083.9 6111.4 6165.4 6187.7 6280.5 6281.0 6300.6 6313.1 6315.3 6333.1 6203.6 6270.3 6271.1 6285.1 6292.2 6165.5 6211.5 6217.0 6278.7 6286.5 4897.8 4935.3 4992.3 5014.7 5028.2 4454.7 4454.7 4466.6 4478.3 4496.5 5835.5 5852.6 5873.8 5899.6 5945.3 6113.4 6116.8 6233.7 6242.2 6304.5 5837.7 5871.3 5903.5 5912.1 5985.5 5483.6 5493.0 5504.9 5505.9 5520.3 6382.0 6385.6 6394.7 6399.8 6418.0 6193.7 6249.9 6260.9 6281.6 6298.5 6346.0 6361.3 6365.1 6367.9 6370.6 6113.1 6246.5 6263.3 6270.5 6301.0 6232.3 6257.9 6306.2 6306.7 6313.9 6175.2 6213.4 6219.3 6223.5 6225.4 6046.3 6100.9 6182.3 6207.5 6213.8 4904.7 6036.2 6109.1 6113.4 6115.1 6203.4 6256.4 6268.7 6269.8 6274.7 5387.9 5763.2 5900.1 5927.3 6116.4 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | [#1] ext.html Cycles:180 Average:72252.70 Median:37328.72 stddev:161198.77 (431.8%) stddev-sans-first:161561.03 19:35:27 INFO - PROCESS | 3798 | Values: 530.1 536.3 542.4 543.0 562.1 29395.1 31010.5 40699.4 41576.5 41624.8 42866.6 42929.6 43026.8 43091.0 43162.8 9604.9 9795.1 9804.8 9809.0 9809.4 8659.6 8876.5 11669.5 11930.8 11950.2 11758.5 11816.9 11836.0 11849.2 11866.8 8680.5 8866.9 11702.5 11741.2 11775.8 8646.8 8688.4 11443.7 11749.6 11757.5 38945.6 40795.0 41019.0 41096.0 41229.8 3047.7 3411.5 3490.5 3533.0 3627.2 31106.9 31176.8 31914.0 32488.5 32539.0 3294.6 3307.9 3326.2 3397.6 3420.5 441065.0 510463.0 512996.0 514107.0 516046.4 61060.0 61967.7 62017.0 62136.4 62170.0 64873.7 64975.4 64983.7 65104.7 65240.7 16151.1 16641.3 16677.2 16693.6 16738.2 9784.8 9821.4 9868.7 12752.8 12809.5 16147.0 16303.7 16739.7 16854.7 19191.3 6539.8 7567.8 7651.8 7718.7 7800.4 926.4 933.6 1081.9 1132.4 1154.7 23781.3 28969.9 29915.1 30352.0 30625.8 1101.0 1104.8 1110.5 1114.7 1160.9 15001.0 15092.2 15136.0 15476.7 15542.3 692582.0 697051.0 703143.0 703619.0 705882.0 47898.5 55241.5 56722.0 57029.4 57164.0 1226.6 1378.3 1380.0 1413.3 1426.6 24649.5 25753.8 29098.9 30313.9 30871.4 49176.3 49719.0 49976.0 50031.5 50033.5 584021.0 589362.0 589636.0 589919.1 590085.0 23087.9 25499.6 25903.0 25918.0 26683.6 41125.8 45718.8 45921.3 45927.8 46505.3 35728.8 38122.8 38294.9 38742.0 39283.6 37697.9 37831.8 38359.4 38464.0 38829.6 36668.0 36793.3 37224.4 37225.6 37431.8 30306.7 31206.1 33166.7 33888.5 33986.0 23978.5 24364.0 24747.0 25020.2 25302.2 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | [#2] jquery.html Cycles:180 Average:35673.30 Median:26254.08 stddev:98594.37 (375.5%) stddev-sans-first:98835.28 19:35:27 INFO - PROCESS | 3798 | Values: 353.3 374.2 389.3 389.8 404.0 15964.0 16118.3 21068.7 21311.5 21327.9 20864.1 21447.8 21712.0 21748.1 21757.0 5372.9 6094.8 6263.4 6263.7 6273.7 6159.2 6252.9 6277.6 6278.0 6283.0 5934.3 6204.5 6206.8 6209.7 6216.7 5950.0 6142.6 6143.2 6211.5 6230.0 5293.6 5325.1 5327.9 5328.7 5329.2 21584.0 25995.4 26512.8 26876.9 26878.9 2484.2 2672.7 2881.8 2957.0 3156.5 15029.8 15654.1 16162.5 16300.0 16401.8 1811.4 1823.3 1835.6 1918.5 1929.1 118402.8 120729.8 121959.0 122810.0 124933.0 9328.3 9893.2 9956.0 10163.6 10758.7 12463.8 12500.1 12568.9 12591.6 12593.1 8038.7 8053.4 8081.4 8136.8 8153.2 8522.2 8548.4 8552.0 8652.9 8681.7 3875.1 3930.7 3931.1 3970.0 3976.8 1889.4 1917.0 1928.6 1931.7 1938.6 827.2 905.4 917.6 935.4 1012.9 21700.8 22527.9 22541.5 22603.9 22720.9 892.3 982.4 992.2 1008.8 1013.1 11171.2 11211.7 11751.5 11755.4 11844.6 470652.0 587115.0 612085.0 613059.0 629547.0 144026.3 148059.0 149919.3 151696.0 153748.0 919.7 1014.2 1022.5 1022.7 1067.4 17208.7 18587.0 19715.0 20320.5 20365.2 55967.0 55973.7 56461.6 56913.9 56927.9 80502.0 81110.2 81984.6 82160.0 82452.0 7987.3 8164.6 8186.3 8260.3 8271.5 11854.2 13018.7 13207.7 13367.6 13373.2 11094.6 11161.1 11210.2 11270.7 11493.3 9107.9 10789.7 11158.0 11206.0 11488.3 11413.7 11450.3 11529.1 11777.5 11784.0 8014.3 8160.3 8177.3 8225.7 8352.1 10017.2 11246.4 11437.6 11464.4 11522.9 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | [#3] mootools.html Cycles:180 Average:5687.42 Median:5122.26 stddev:3180.38 (62.1%) stddev-sans-first:3170.65 19:35:27 INFO - PROCESS | 3798 | Values: 1104.9 1349.7 1511.4 1670.4 1910.4 7761.1 8586.4 8821.9 8847.6 8908.3 7516.8 8545.7 8764.3 8784.0 8803.0 2093.4 2175.0 2296.7 2349.5 2386.1 2389.4 2418.6 2419.1 2419.6 2438.3 2330.6 2371.2 2379.3 2380.3 2382.5 2067.6 2206.4 2276.6 2350.0 2363.4 2361.1 2382.8 2388.0 2391.5 2392.8 8748.7 8817.9 8826.6 8835.2 8839.6 5178.9 5189.4 5330.4 5340.4 5372.0 3582.7 3640.2 3703.1 3707.3 3717.0 1068.2 1087.9 1091.8 1106.7 1113.1 11642.8 11655.2 11656.2 11675.1 11678.4 4574.4 4673.7 4831.6 4832.0 4837.7 9892.1 9897.0 9898.1 9902.0 9905.8 5356.7 5367.0 5372.2 5372.2 5372.4 4361.0 4524.4 4771.0 4926.7 4927.0 3364.7 3891.7 3926.5 4025.8 4026.5 1159.0 1254.2 1266.1 1266.6 1279.4 730.8 776.3 846.5 859.5 923.9 4852.5 5871.3 5875.3 6009.1 6130.0 913.2 922.2 941.0 946.9 950.9 3914.4 3956.8 4014.3 4032.8 4041.8 9972.7 10678.7 10700.9 10710.3 10713.6 10284.7 10507.3 10677.8 10678.4 10691.8 8077.6 8154.7 8166.1 8176.3 8217.5 5768.0 5792.9 5862.5 5886.6 5956.2 9835.6 9897.5 9899.8 9936.3 9942.9 9784.2 9971.9 10206.9 10215.8 10221.0 7293.9 7313.8 7400.5 7404.0 7443.4 7883.6 8186.2 8224.5 8235.8 8263.5 7489.3 7526.4 7555.3 7615.9 7695.8 7402.1 7413.5 7496.3 7529.9 7552.5 6083.3 6872.6 6920.8 7034.4 7040.5 5009.5 5023.6 5040.5 5083.2 5161.4 5050.6 5053.8 5058.2 5067.2 5258.4 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | [#4] prototype.html Cycles:180 Average:4383.31 Median:5043.79 stddev:1352.59 (26.8%) stddev-sans-first:1321.17 19:35:27 INFO - PROCESS | 3798 | Values: 298.0 308.2 311.0 314.0 315.7 4287.2 4300.5 4529.9 4996.7 5189.2 5154.7 5157.8 5161.9 5183.8 5188.6 3423.3 3699.8 3757.5 3946.3 3985.7 3264.7 3876.4 3934.5 3947.5 3962.5 3506.3 3699.3 3897.6 3913.8 3929.8 3393.8 3703.9 3810.9 3904.3 3977.4 3411.8 3421.5 3430.3 3435.5 3444.9 3947.8 5028.8 5046.3 5093.7 5095.5 4194.5 4253.5 4253.7 4491.2 4527.0 4437.6 5275.7 5342.4 5352.5 5362.7 2969.7 3230.0 3464.0 3781.8 3842.9 5135.8 5210.1 5329.5 5604.3 5659.5 3565.9 3809.5 3834.9 3850.7 3856.0 3622.7 3737.8 3930.9 3951.7 3964.5 4080.1 4275.3 4523.7 4527.7 4527.9 4807.3 4860.4 5119.0 5468.0 5559.8 1271.8 1296.4 1300.6 1301.5 1312.4 624.9 665.4 783.4 802.6 808.8 4698.3 4933.0 4935.3 5068.8 5097.6 4347.3 5385.9 5477.8 5526.6 5536.8 4743.2 5017.4 5041.3 5074.8 5082.3 2734.5 2750.7 2909.0 2929.6 2933.4 5093.0 5128.0 5729.5 5745.5 5781.4 4723.1 5060.5 5280.3 5747.0 5780.8 5160.0 5552.0 5730.5 5783.0 5793.8 5588.8 5605.8 5607.1 5607.2 5627.6 5172.4 5518.3 5551.5 5577.5 5580.6 4630.9 5721.6 5761.3 5777.4 5798.6 3609.0 3756.3 3763.5 3766.6 3780.6 5477.2 5541.6 5558.4 5571.3 5587.9 4803.3 5039.7 5129.3 5409.2 5475.5 5102.7 5373.0 5394.4 5397.7 5416.8 5242.7 5310.8 5313.3 5323.6 5328.0 4981.2 5108.2 5278.6 5325.8 5422.3 5307.0 5309.4 5317.4 5317.6 5367.8 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - PROCESS | 3798 | [#5] yui.html Cycles:180 Average:24092.87 Median:3639.12 stddev:36631.40 (1006.6%) stddev-sans-first:36691.71 19:35:27 INFO - PROCESS | 3798 | Values: 603.4 720.2 742.7 808.7 826.6 15107.5 16105.6 16360.4 16565.6 16776.2 15130.3 15203.8 15229.2 15247.2 15305.7 705.1 731.3 862.1 872.5 875.0 870.1 887.6 887.8 893.3 899.3 935.5 939.4 944.4 944.5 946.0 740.4 922.5 927.7 932.2 935.9 699.1 699.6 700.2 700.7 704.0 15177.7 15255.4 15291.5 15295.5 15328.2 14142.7 14219.5 14279.9 14378.2 14604.6 12938.7 13140.6 13180.9 13363.7 13573.9 4575.0 4742.6 4747.3 4753.1 4771.8 120379.0 120524.0 129976.0 130096.3 130243.0 9746.6 11278.4 11436.7 11461.8 11676.8 22908.0 22951.4 22969.4 22971.2 23019.8 8227.4 8230.4 8324.8 8435.3 8442.8 4518.5 4628.1 4635.8 4644.3 4829.7 3542.0 3631.5 3632.6 3632.7 3645.5 677.8 705.5 709.2 721.4 726.0 506.6 578.8 657.0 688.7 710.2 8298.8 9580.5 9677.9 9720.2 9761.6 534.4 656.2 663.9 668.0 684.9 4707.4 4790.0 4818.0 4849.1 4858.7 93950.0 94955.1 95199.0 95468.5 103793.0 113570.4 117803.0 127805.9 139237.0 140442.6 97704.0 103771.0 105484.0 108099.0 109329.4 9770.9 10153.5 10204.4 10226.7 10235.4 63864.0 64513.4 65316.3 65402.7 66427.4 84262.6 89958.6 94544.5 94891.0 97956.0 13243.0 13359.2 13372.9 13394.3 13780.8 14996.9 15222.5 15366.2 15467.3 15640.5 8499.7 14020.6 14461.1 14555.1 14850.4 13980.0 14143.4 14358.3 14399.4 14667.3 13653.4 13894.3 14222.0 14353.6 14469.6 11261.4 11538.5 11583.4 11634.0 11657.5 10529.5 11355.2 11717.2 11731.2 11756.6 19:35:27 INFO - PROCESS | 3798 | -------- Summary: end -------- 19:35:27 INFO - PROCESS | 3798 | 19:35:27 INFO - TEST-INFO | 3798: exit 0 19:35:27 INFO - TEST-OK | dromaeo_css | took 1117104ms 19:35:27 INFO - TEST-START | kraken 19:35:27 INFO - operating with platform_type : mac_ 19:35:27 INFO - Initialising browser for kraken test... 19:35:27 INFO - TEST-INFO | started process 3916 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpWfeoKd/profile http://localhost:49261/getInfo.html) 19:35:30 INFO - PROCESS | 3916 | __metrics Screen width/height:1600/1200 19:35:30 INFO - PROCESS | 3916 | colorDepth:24 19:35:30 INFO - PROCESS | 3916 | Browser inner width/height: 1024/689 19:35:30 INFO - PROCESS | 3916 | __metrics 19:35:30 INFO - PROCESS | 3916 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:35:30 INFO - PROCESS | 3916 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:35:31 INFO - TEST-INFO | 3916: exit 0 19:35:31 INFO - Browser initialized. 19:35:31 INFO - Running cycle 1/1 for kraken test... 19:35:31 INFO - TEST-INFO | started process 3918 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpWfeoKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:35:43 INFO - PROCESS | 3918 | RSS: Main: 244686848 19:35:43 INFO - PROCESS | 3918 | 19:35:45 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection) 19:35:46 INFO - PROCESS | 3918 | RSS: Main: 294191104 19:35:46 INFO - PROCESS | 3918 | 19:35:49 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-dft) 19:35:50 INFO - PROCESS | 3918 | RSS: Main: 304484352 19:35:50 INFO - PROCESS | 3918 | 19:35:53 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-fft) 19:35:54 INFO - PROCESS | 3918 | RSS: Main: 389582848 19:35:54 INFO - PROCESS | 3918 | 19:35:56 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator) 19:35:56 INFO - PROCESS | 3918 | RSS: Main: 290324480 19:35:56 INFO - PROCESS | 3918 | 19:35:58 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:35:59 INFO - PROCESS | 3918 | RSS: Main: 294203392 19:35:59 INFO - PROCESS | 3918 | 19:36:02 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom) 19:36:02 INFO - PROCESS | 3918 | RSS: Main: 333160448 19:36:02 INFO - PROCESS | 3918 | 19:36:05 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate) 19:36:06 INFO - PROCESS | 3918 | RSS: Main: 335204352 19:36:06 INFO - PROCESS | 3918 | 19:36:09 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial) 19:36:09 INFO - PROCESS | 3918 | RSS: Main: 334487552 19:36:09 INFO - PROCESS | 3918 | 19:36:11 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:36:12 INFO - PROCESS | 3918 | RSS: Main: 313675776 19:36:12 INFO - PROCESS | 3918 | 19:36:14 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:36:14 INFO - PROCESS | 3918 | RSS: Main: 320663552 19:36:14 INFO - PROCESS | 3918 | 19:36:16 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:36:17 INFO - PROCESS | 3918 | RSS: Main: 320004096 19:36:17 INFO - PROCESS | 3918 | 19:36:20 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:36:21 INFO - PROCESS | 3918 | RSS: Main: 327163904 19:36:21 INFO - PROCESS | 3918 | 19:36:23 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:36:24 INFO - PROCESS | 3918 | RSS: Main: 329609216 19:36:24 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49261/tests/kraken/driver.html?testName=ai-astar) 19:36:26 INFO - PROCESS | 3918 | RSS: Main: 373178368 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | __start_tp_report 19:36:26 INFO - PROCESS | 3918 | _x_x_mozilla_page_load 19:36:26 INFO - PROCESS | 3918 | _x_x_mozilla_page_load_details 19:36:26 INFO - PROCESS | 3918 | |i|pagename|runs| 19:36:26 INFO - PROCESS | 3918 | |0;ai-astar;102;112;116;111;114;113;114;114;113;110 19:36:26 INFO - PROCESS | 3918 | |1;audio-beat-detection;153;137;137;157;106;129;139;109;157;114 19:36:26 INFO - PROCESS | 3918 | |2;audio-dft;183;186;183;185;183;185;185;183;181;185 19:36:26 INFO - PROCESS | 3918 | |3;audio-fft;82;73;58;88;56;56;66;64;81;71 19:36:26 INFO - PROCESS | 3918 | |4;audio-oscillator;82;92;91;70;71;68;96;69;68;99 19:36:26 INFO - PROCESS | 3918 | |5;imaging-gaussian-blur;118;130;97;85;88;85;90;85;88;85 19:36:26 INFO - PROCESS | 3918 | |6;imaging-darkroom;101;145;93;94;93;93;93;93;94;93 19:36:26 INFO - PROCESS | 3918 | |7;imaging-desaturate;84;84;83;84;84;85;85;83;84;84 19:36:26 INFO - PROCESS | 3918 | |8;json-parse-financial;56;56;57;57;55;54;54;54;54;55 19:36:26 INFO - PROCESS | 3918 | |9;json-stringify-tinderbox;68;68;79;106;103;101;74;70;70;70 19:36:26 INFO - PROCESS | 3918 | |10;stanford-crypto-aes;86;82;84;86;83;82;83;83;86;85 19:36:26 INFO - PROCESS | 3918 | |11;stanford-crypto-ccm;140;129;127;145;123;138;146;150;230;143 19:36:26 INFO - PROCESS | 3918 | |12;stanford-crypto-pbkdf2;162;166;162;162;160;162;160;163;161;159 19:36:26 INFO - PROCESS | 3918 | |13;stanford-crypto-sha256-iterative;66;66;66;67;66;67;65;67;66;65 19:36:26 INFO - PROCESS | 3918 | __end_tp_report 19:36:26 INFO - PROCESS | 3918 | __start_cc_report 19:36:26 INFO - PROCESS | 3918 | _x_x_mozilla_cycle_collect,2087 19:36:26 INFO - PROCESS | 3918 | __end_cc_report 19:36:26 INFO - PROCESS | 3918 | __startTimestamp1469327786555__endTimestamp 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | ------- Summary: start ------- 19:36:26 INFO - PROCESS | 3918 | Number of tests: 14 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.87 (3.4%) stddev-sans-first:1.80 19:36:26 INFO - PROCESS | 3918 | Values: 102.0 112.0 116.0 111.0 114.0 113.0 114.0 114.0 113.0 110.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:138.00 stddev:19.14 (13.9%) stddev-sans-first:18.99 19:36:26 INFO - PROCESS | 3918 | Values: 153.0 137.0 137.0 157.0 106.0 129.0 139.0 109.0 157.0 114.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:1.52 (0.8%) stddev-sans-first:1.58 19:36:26 INFO - PROCESS | 3918 | Values: 183.0 186.0 183.0 185.0 183.0 185.0 185.0 183.0 181.0 185.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#3] audio-fft Cycles:10 Average:69.50 Median:72.00 stddev:11.47 (15.9%) stddev-sans-first:11.24 19:36:26 INFO - PROCESS | 3918 | Values: 82.0 73.0 58.0 88.0 56.0 56.0 66.0 64.0 81.0 71.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:86.50 stddev:12.79 (14.8%) stddev-sans-first:13.56 19:36:26 INFO - PROCESS | 3918 | Values: 82.0 92.0 91.0 70.0 71.0 68.0 96.0 69.0 68.0 99.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:86.50 stddev:15.92 (18.4%) stddev-sans-first:14.57 19:36:26 INFO - PROCESS | 3918 | Values: 118.0 130.0 97.0 85.0 88.0 85.0 90.0 85.0 88.0 85.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:93.00 stddev:16.28 (17.5%) stddev-sans-first:17.26 19:36:26 INFO - PROCESS | 3918 | Values: 101.0 145.0 93.0 94.0 93.0 93.0 93.0 93.0 94.0 93.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 19:36:26 INFO - PROCESS | 3918 | Values: 84.0 84.0 83.0 84.0 84.0 85.0 85.0 83.0 84.0 84.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.23 (2.2%) stddev-sans-first:1.27 19:36:26 INFO - PROCESS | 3918 | Values: 56.0 56.0 57.0 57.0 55.0 54.0 54.0 54.0 54.0 55.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#9] json-stringify-tinderbox Cycles:10 Average:80.90 Median:70.00 stddev:15.86 (22.7%) stddev-sans-first:16.12 19:36:26 INFO - PROCESS | 3918 | Values: 68.0 68.0 79.0 106.0 103.0 101.0 74.0 70.0 70.0 70.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.50 stddev:1.63 (1.9%) stddev-sans-first:1.56 19:36:26 INFO - PROCESS | 3918 | Values: 86.0 82.0 84.0 86.0 83.0 82.0 83.0 83.0 86.0 85.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:144.00 stddev:30.46 (21.2%) stddev-sans-first:32.20 19:36:26 INFO - PROCESS | 3918 | Values: 140.0 129.0 127.0 145.0 123.0 138.0 146.0 150.0 230.0 143.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.95 (1.2%) stddev-sans-first:2.06 19:36:26 INFO - PROCESS | 3918 | Values: 162.0 166.0 162.0 162.0 160.0 162.0 160.0 163.0 161.0 159.0 19:36:26 INFO - PROCESS | 3918 | 19:36:26 INFO - PROCESS | 3918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 19:36:26 INFO - PROCESS | 3918 | Values: 66.0 66.0 66.0 67.0 66.0 67.0 65.0 67.0 66.0 65.0 19:36:26 INFO - PROCESS | 3918 | -------- Summary: end -------- 19:36:26 INFO - PROCESS | 3918 | 19:36:27 INFO - TEST-INFO | 3918: exit 0 19:36:27 INFO - TEST-OK | kraken | took 59434ms 19:36:27 INFO - SUITE-END | took 1176s 19:36:27 INFO - Completed test suite (00:19:36) 19:36:27 INFO - javascript benchmark 19:36:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.8482668279926, 3373.4602463605797, 3379.831008449577, 3396.269801992572, 3415.5559777228955, 5687.971560142204, 5722.54219662427, 5803.361630220672, 5878.294604647443, 5890.793822216228, 5852.473277405033, 5860.76556937723, 5874.500667443262, 5877.500412464946, 5881.147233651118, 5200.32395788547, 5239.397469291042, 5253.60597955153, 5266.92099618506, 5311.867203319928, 5317.229001794737, 5326.094563924123, 5328.440513746059, 5329.493698098674, 5340.305760251162, 5210.687358758468, 5224.059669259532, 5236.738163091849, 5246.291750613656, 5311.282976798141, 5283.920741188886, 5313.574914006909, 5318.0583065423425, 5322.308099947021, 5363.517283444469, 5089.236614507817, 5134.589232861399, 5197.740112994373, 5260.105782017066, 5281.577473802086, 4795.424549054101, 5714.1428785682065, 5720.170575266605, 5812.854678633068, 5837.270341207349, 6191.19514463117, 6210.192674952227, 6213.347598502182, 6229.127922090911, 6252.624842509464, 6166.568340216187, 6230.0, 6271.43557079865, 6294.087357333161, 6308.589941653778, 5996.670183139926, 6003.189569408074, 6008.909866352008, 6013.579049466495, 6026.999999999956, 6306.873862522815, 6333.46165575922, 6339.144215530937, 6341.524385671093, 6345.07996340528, 6083.878322433527, 6111.449969502766, 6165.414285642857, 6187.690615469299, 6280.466160376328, 6281.026440901576, 6300.621962682254, 6313.147725057151, 6315.3053164152825, 6333.050042493571, 6203.565750397519, 6270.3416141305415, 6271.090691849748, 6285.057241413733, 6292.182016337847, 6165.506759459233, 6211.503079753609, 6217.036359364306, 6278.6546739929745, 6286.465650419674, 4897.779599917941, 4935.284383764334, 4992.326035985168, 5014.674046186986, 5028.195488721787, 4454.665900057508, 4454.732716037048, 4466.642668586505, 4478.312074575313, 4496.505384407713, 5835.533157347402, 5852.648841069549, 5873.794417195463, 5899.616524925866, 5945.256842894638, 6113.354685976905, 6116.792316687851, 6233.657148856856, 6242.219722534684, 6304.464120549805, 5837.678927658934, 5871.324797648325, 5903.527717782567, 5912.083627037816, 5985.461308482258, 5483.561315094783, 5492.972535137299, 5504.9449505504435, 5505.889882202334, 5520.337559492807, 6381.968090159612, 6385.553011289258, 6394.712237949397, 6399.8080057598345, 6418.037294405876, 6193.659348735863, 6249.937500624936, 6260.874782504234, 6281.591696539893, 6298.496120310272, 6346.048092786119, 6361.332060133619, 6365.108884756045, 6367.87264254703, 6370.55406121567, 6113.141862489121, 6246.469050130608, 6263.342349053284, 6270.4670103039925, 6301.023341382093, 6232.25212974446, 6257.937420625735, 6306.1801965746, 6306.747730090745, 6313.873722525615, 6175.166352542349, 6213.37866213375, 6219.346968568235, 6223.471004964629, 6225.439710426083, 6046.334903160561, 6100.944524685144, 6182.289036760651, 6207.503399728102, 6213.813585592439, 4904.681195722266, 6036.245469316335, 6109.075641173016, 6113.358097399709, 6115.052166914135, 6203.410675985774, 6256.405641464054, 6268.686565671607, 6269.780557680459, 6274.749010039547, 5387.946120538744, 5763.164341170423, 5900.1149827526215, 5927.347991720993, 6116.418940200674], "value": 5761.798165515968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.1305858392236, 536.2653165163726, 542.3600151820851, 543.0198491722442, 562.0753859900461, 29395.11814645559, 31010.53484197736, 40699.38950915735, 41576.544820931274, 41624.791876040654, 42866.571334286724, 42929.57070429295, 43026.78486607563, 43091.0, 43162.78418607903, 9604.934938988115, 9795.118439340458, 9804.803903921917, 9808.950955245215, 9809.411435313905, 8659.567021648923, 8876.467411955271, 11669.533218671242, 11930.821037684442, 11950.223235489666, 11758.529658813637, 11816.940915295412, 11836.0, 11849.229800062969, 11866.821997670042, 8680.479171249744, 8866.86699699505, 11702.473388697528, 11741.236819606784, 11775.823362649568, 8646.78383040429, 8688.391812573122, 11443.713907152305, 11749.588764393291, 11757.470913808898, 38945.61054389476, 40795.0, 41018.974525637095, 41096.0, 41229.76310710683, 3047.725704686589, 3411.539442175324, 3490.5287786148797, 3532.9646703532894, 3627.2020155565733, 31106.911258106084, 31176.844115779502, 31914.0, 32488.512672309935, 32539.0, 3294.621118571371, 3307.8842240521467, 3326.1518312830317, 3397.6262611112757, 3420.4869269609508, 441065.0, 510463.0, 512996.0, 514107.0, 516046.41976789874, 61060.0, 61967.690161548904, 62017.0, 62136.378636213056, 62170.0, 64873.67563162154, 64975.35024649693, 64983.675081624286, 65104.67447662731, 65240.67379663071, 16151.111688857225, 16641.25419305801, 16677.16614169311, 16693.582660433585, 16738.24677889498, 9784.804303914025, 9821.428571428538, 9868.703938881845, 12752.80870786939, 12809.487620495262, 16147.0, 16303.673926521404, 16739.748903766453, 16854.662906741796, 19191.32830350931, 6539.771108011197, 7567.772966811004, 7651.770446886602, 7718.729844455529, 7800.375969922393, 926.3654396738256, 933.6462129911655, 1081.8972197641212, 1132.4202737181586, 1154.653603918821, 23781.26515450745, 28969.85515072411, 29915.102546923627, 30352.0, 30625.846870765505, 1101.0456439819225, 1104.7845670094416, 1110.5169251375517, 1114.6990312615549, 1160.9129315301386, 15001.024933379296, 15092.1699306537, 15136.016158949633, 15476.690466190614, 15542.30059647296, 692582.0, 697051.0, 703143.0, 703619.0, 705882.0, 47898.5210147901, 55241.51413186416, 56722.0, 57029.42970570241, 57164.0, 1226.589092653953, 1378.3246209357544, 1380.0063953953338, 1413.3216056293038, 1426.5934208750457, 24649.507009860063, 25753.84107715195, 29098.854505727337, 30313.93901213535, 30871.38257234798, 49176.2623560654, 49719.0, 49976.0, 50031.49968500269, 50033.49966500434, 584021.0, 589362.0, 589636.0, 589919.0504047453, 590085.0, 23087.88456057709, 25499.617505737056, 25903.0, 25917.96328146853, 26683.599746004213, 41125.766227013235, 45718.771406142754, 45921.31118033166, 45927.77036114798, 46505.30242046304, 35728.82135589305, 38122.809385954, 38294.85115446541, 38742.0, 39283.607163928, 37697.86906392813, 37831.81084094562, 38359.42460863033, 38464.0, 38829.61170388373, 36668.0, 36793.26413471662, 37224.441633374976, 37225.6277437233, 37431.81284093671, 30306.696933030387, 31206.063818085495, 33166.66833331636, 33888.491672624434, 33986.0, 23978.52042959166, 24364.0, 24747.0, 25020.186358479976, 25302.240932772045], "value": 20141.38957501161, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3039911374591, 374.1786778022241, 389.3458988898651, 389.78561791014937, 403.951525816902, 15964.042157470545, 16118.274677639505, 21068.683969740465, 21311.467213319676, 21327.93360331985, 20864.061117249723, 21447.82036987969, 21712.0, 21748.13007479699, 21757.0, 5372.892542149155, 6094.786682466126, 6263.373662633723, 6263.686815659222, 6273.654948977804, 6159.23009623797, 6252.874942501147, 6277.560570760026, 6277.968610156966, 6282.9685851570675, 5934.258217722785, 6204.534659900503, 6206.813795586117, 6209.658468784215, 6216.658083805389, 5949.970250148722, 6142.570020098595, 6143.170671959273, 6211.47202487789, 6230.03434467656, 5293.602979776532, 5325.1479763238085, 5327.920081198785, 5328.6802791832615, 5329.173978033411, 21584.0, 25995.350116247057, 26512.80692368848, 26876.86561567199, 26878.924843006258, 2484.1802205272215, 2672.7460891215305, 2881.8414987175697, 2956.9556456653168, 3156.526521021842, 15029.849701503064, 15654.060756354655, 16162.515124546282, 16300.021998680117, 16401.83598164027, 1811.3660218923403, 1823.3344829137402, 1835.577817102074, 1918.4532408263717, 1929.1126082002295, 118402.81597184004, 120729.79270207361, 121959.0, 122810.0, 124933.0, 9328.34701570897, 9893.208543316518, 9955.950220248853, 10163.593456261815, 10758.73103172427, 12463.75072498545, 12500.124991250706, 12568.874311256954, 12591.559295424617, 12593.055520835975, 8038.678452861937, 8053.436259461899, 8081.393895457747, 8136.83726325482, 8153.184681531918, 8522.232999030117, 8548.358873084544, 8551.957240213758, 8652.8702069469, 8681.739547813575, 3875.147467557133, 3930.6855451563806, 3931.1154990126993, 3969.960300396959, 3976.840926362971, 1889.4426144287468, 1916.9712454313196, 1928.6046360496064, 1931.65230258552, 1938.6122775444685, 827.2017503109528, 905.4295793649958, 917.5962576466467, 935.4387367579398, 1012.9442880641635, 21700.782992170192, 22527.88736056309, 22541.54916901653, 22603.88698056532, 22720.886395567915, 892.3396686451979, 982.4301904895144, 992.2062350119875, 1008.8385858262643, 1013.0527956360826, 11171.21801473889, 11211.719707007227, 11751.529938802523, 11755.412229388496, 11844.585439509576, 470652.0, 587115.0, 612085.0, 613059.0, 629547.0, 144026.2798686, 148059.038819223, 149919.25040374947, 151696.0, 153748.0, 919.72868003939, 1014.2494554030112, 1022.5449674894601, 1022.6880801355658, 1067.3809190669392, 17208.741868871726, 18587.0, 19715.014249287193, 20320.491987700425, 20365.18539258413, 55967.0, 55973.72013139908, 56461.58846028718, 56913.861722764486, 56927.86144277174, 80502.0, 81110.18889811262, 81984.59007704923, 82160.0, 82452.0, 7987.321077708228, 8164.632591533514, 8186.304164146114, 8260.297874680478, 8271.503709777433, 11854.229475084092, 13018.739625207632, 13207.66980825487, 13367.598972030855, 13373.197608143542, 11094.5562177512, 11161.055041981004, 11210.215284929976, 11270.661880143609, 11493.252938558968, 9107.861517310335, 10789.676309710721, 11158.0, 11206.0, 11488.253263537843, 11413.657590272305, 11450.312981221154, 11529.135314851252, 11777.52889884395, 11784.0, 8014.318782903519, 8160.347172226327, 8177.34581233488, 8225.670973161006, 8352.123027082069, 10017.248706347198, 11246.437678115897, 11437.59968401102, 11464.4267786612, 11522.942385288019], "value": 9815.05076814884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1104.9337039777608, 1349.6558377613708, 1511.4256582498651, 1670.4404024651742, 1910.4173227165709, 7761.107472640648, 8586.39895207335, 8821.867671984925, 8847.601857916394, 8908.28733701304, 7516.849663006737, 8545.700900468484, 8764.298856091513, 8784.033756286819, 8802.95598522008, 2093.382452176604, 2175.0321107107343, 2296.7473577906417, 2349.5418393413333, 2386.1171366594385, 2389.390705370128, 2418.6372044193336, 2419.11702228687, 2419.6249581314837, 2438.317271164077, 2330.6387509935985, 2371.1819422299277, 2379.3456799380137, 2380.297812145421, 2382.523495300938, 2067.5968186203695, 2206.3711842124917, 2276.647119696433, 2349.9647505287435, 2363.444590521226, 2361.055577768889, 2382.7736365045293, 2387.9880600597057, 2391.497785465054, 2392.820538459605, 8748.69379571712, 8817.867731984026, 8826.646934122627, 8835.204831565126, 8839.60221790021, 5178.922316165261, 5189.40321862983, 5330.38700549434, 5340.359156901158, 5371.973140134313, 3582.7133829293593, 3640.2355505343908, 3703.092742278159, 3707.3141468828085, 3716.996410969023, 1068.1721665709138, 1087.8912108789057, 1091.7925594137168, 1106.6569363497342, 1113.059464752283, 11642.76714465706, 11655.242409243372, 11656.184067115306, 11675.065994720402, 11678.416079196091, 4574.359589657384, 4673.742944138037, 4831.622987448561, 4831.975840120777, 4837.733924634179, 9892.060254275977, 9897.0, 9898.10917017472, 9901.950490247502, 9905.80188396228, 5356.678599284055, 5366.980273747976, 5372.167314066326, 5372.194170874322, 5372.382176049804, 4360.956390436118, 4524.389207457017, 4770.952290477051, 4926.729029903389, 4926.975365123151, 3364.6635336466156, 3891.6886649068006, 3926.450296958371, 4025.7584544926813, 4026.469941422241, 1158.9536418543332, 1254.209847795901, 1266.1010682415588, 1266.5883587833991, 1279.3795009420423, 730.846522230327, 776.3129630277245, 846.5005646668495, 859.53449368826, 923.93532452729, 4852.490488498727, 5871.295444546682, 5875.324337701134, 6009.068594367793, 6130.019196928559, 913.1918252346721, 922.1792604581927, 940.9529523523796, 946.9005754395689, 950.9381890177116, 3914.373700207953, 3956.8219430125714, 4014.277430062617, 4032.7983600819844, 4041.777702226406, 9972.700818975442, 10678.733031674115, 10700.892991070144, 10710.303830251009, 10713.571457141627, 10284.691459256233, 10507.264491485523, 10677.83983240252, 10678.412687302272, 10691.83962240567, 8077.555734434663, 8154.714584989615, 8166.142555031755, 8176.3458923286, 8217.506949583045, 5768.0, 5792.884142317214, 5862.530997520103, 5886.58793884424, 5956.225690660186, 9835.557399916877, 9897.50512474359, 9899.802003960025, 9936.304458687822, 9942.900570994487, 9784.168345690412, 9971.85605094908, 10206.897931020892, 10215.846762298423, 10221.0, 7293.927060729537, 7313.780586582411, 7400.5189662671755, 7403.962980185064, 7443.441741869273, 7883.605819709106, 8186.181381861767, 8224.465409748347, 8235.83528329418, 8263.462874913352, 7489.251074892467, 7526.397888168824, 7555.282248186413, 7615.923840761521, 7695.846083078419, 7402.148752893271, 7413.481056326005, 7496.287852653989, 7529.924700753141, 7552.471327007057, 6083.270007599116, 6872.553284036521, 6920.757773477904, 7034.366906978396, 7040.542364746275, 5009.474005229398, 5023.648344615988, 5040.546350828443, 5083.161278389024, 5161.354830646169, 5050.621203409833, 5053.772580233825, 5058.190689489664, 5067.163917953644, 5258.368995720538], "value": 4561.562708011303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9687132851051, 308.21559132009037, 311.01098506748536, 314.0280830828585, 315.6685480245744, 4287.249731297026, 4300.462442194726, 4529.886752831181, 4996.700197988123, 5189.169732842746, 5154.659788455, 5157.8452646420665, 5161.890193608373, 5183.818566350178, 5188.6367954243215, 3423.2982238641143, 3699.833507492156, 3757.5303087114044, 3946.3291240489043, 3985.6612187964056, 3264.657210992847, 3876.3991581304804, 3934.527856657205, 3947.539410418149, 3962.4650672159178, 3506.263684626219, 3699.2971335446177, 3897.59075297094, 3913.8434462621462, 3929.803509824512, 3393.7794043387225, 3703.90740231495, 3810.8856734298015, 3904.2777086239134, 3977.4033894915706, 3411.812350320731, 3421.469672200813, 3430.3243470093366, 3435.4846772984, 3444.896653100411, 3947.8156553033973, 5028.7988480460735, 5046.26829109777, 5093.694378337312, 5095.535036175399, 4194.538600753915, 4253.511271055106, 4253.659707223414, 4491.236489796743, 4526.954730452686, 4437.5784300491405, 5275.683458992435, 5342.439043900412, 5352.464753524655, 5362.651427657229, 2969.688182740803, 3229.950266163483, 3464.0, 3781.8487260509546, 3842.9423558646645, 5135.768890399941, 5210.062188806051, 5329.493698098636, 5604.327480702301, 5659.490645841894, 3565.893023209308, 3809.5047643806683, 3834.9233015339537, 3850.6919446444217, 3855.980720096438, 3622.673959343619, 3737.7757334560015, 3930.901727456779, 3951.68386529077, 3964.524257089168, 4080.1227736036894, 4275.337322714984, 4523.705959112713, 4527.705699129546, 4527.932081018787, 4807.278908163804, 4860.392450943632, 5118.976204759063, 5467.976848566056, 5559.833205003856, 1271.7790920716031, 1296.3859994307147, 1300.5693736889345, 1301.4729034740944, 1312.4159748911834, 624.8625302433458, 665.4144352969356, 783.4476693930765, 802.6315132698735, 808.8058865872148, 4698.2952557116705, 4933.026789284243, 4935.259711043301, 5068.82259120929, 5097.566706829887, 4347.304431290978, 5385.919211211835, 5477.835664930059, 5526.640768350045, 5536.75084621193, 4743.217369134123, 5017.397912250553, 5041.319421878, 5074.797008119708, 5082.339295891585, 2734.5214587447117, 2750.7111753265617, 2908.9963962432926, 2929.604503392015, 2933.4133173365412, 5093.0, 5128.025745067852, 5729.512991395694, 5745.454181852718, 5781.364049954502, 4723.126221649006, 5060.544550990355, 5280.260763493114, 5746.96554620164, 5780.826575202751, 5160.045391602565, 5551.9722401386925, 5730.541556675456, 5783.045797443375, 5793.797217097382, 5588.776448941997, 5605.80379686709, 5607.130894711327, 5607.158926161109, 5627.634203776742, 5172.379314482287, 5518.2826232589505, 5551.528120109836, 5577.470140336662, 5580.581456390706, 4630.907381852411, 5721.628094173865, 5761.279840019997, 5777.3933736957015, 5798.623089499169, 3608.9819550902075, 3756.286305601927, 3763.5295588051495, 3766.6421689940507, 3780.5652349979005, 5477.178423236546, 5541.556675466034, 5558.388577256579, 5571.275734154696, 5587.938291724559, 4803.327534145293, 5039.697618142924, 5129.2819005340025, 5409.2427060212385, 5475.4524547544925, 5102.69383836971, 5373.0, 5394.433584473731, 5397.676139431646, 5416.83749487516, 5242.68543887368, 5310.787568497217, 5313.309269794902, 5323.574114070788, 5328.001999250281, 4981.178105612534, 5108.233764935289, 5278.5513231374225, 5325.840224793263, 5422.349318081698, 5306.991671582387, 5309.362876454696, 5317.388500322358, 5317.627766056339, 5367.838964831061], "value": 3945.5552628540695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4200418821148, 720.2473415281031, 742.7289039500583, 808.7371604228623, 826.5743142281726, 15107.471238506641, 16105.597360066004, 16360.427385041527, 16565.585860353483, 16776.161191940384, 15130.319135638894, 15203.847961520381, 15229.238538073107, 15247.16140612266, 15305.693886122272, 705.1397295299727, 731.3052600029966, 862.0603542139067, 872.4808738800435, 874.9868751968726, 870.0733718589713, 887.6493784954939, 887.8135591525787, 893.3344658229628, 899.2715900120891, 935.5228833295034, 939.3893968920188, 944.3578366710634, 944.4852555357347, 946.0, 740.4409670698589, 922.5433410461798, 927.7263207353847, 932.2402242172642, 935.9110884465965, 699.1121275979528, 699.5557820783839, 700.1877821726823, 700.7407259314035, 704.0354714041745, 15177.696446071128, 15255.38978440861, 15291.464798731991, 15295.464658736892, 15328.15695136767, 14142.717145657029, 14219.502317418945, 14279.857201427956, 14378.209198494078, 14604.561863144123, 12938.741225175538, 13140.60578182656, 13180.934095329461, 13363.732725345535, 13573.932130339284, 4575.039620441172, 4742.644301677354, 4747.311639812242, 4753.096911586822, 4771.785269662873, 120379.0, 120524.0, 129976.0, 130096.34951825275, 130242.99999999905, 9746.61013559464, 11278.379689117177, 11436.656900293005, 11461.828072578917, 11676.824847627293, 22908.0, 22951.42621434444, 22969.425764355692, 22971.196008139636, 23019.769802302097, 8227.382946279053, 8230.382721295926, 8324.83350333002, 8435.32517398619, 8442.831143377098, 4518.525554816762, 4628.120657075145, 4635.768211589474, 4644.326572646947, 4829.710217386968, 3541.964580354215, 3631.5460567429072, 3632.600413954463, 3632.7457078004286, 3645.489631451599, 677.8136012596575, 705.5378726933867, 709.2411120101442, 721.3688022979893, 725.9963700181571, 506.60231718101113, 578.8176724331822, 656.9967150164218, 688.7313947560456, 710.2116650517921, 8298.8340233195, 9580.473073980998, 9677.870868408938, 9720.173785228335, 9761.609535618496, 534.4094775273345, 656.1666683312167, 663.867226554691, 667.956582822115, 684.948628852838, 4707.364505791675, 4789.976050119727, 4818.0, 4849.127157111683, 4858.73276969763, 93950.0, 94955.050449496, 95199.0, 95468.52265738766, 103793.0, 113570.43214783873, 117803.0, 127805.88776449024, 139237.0, 140442.5513193548, 97704.0, 103771.0, 105484.0, 108099.0, 109329.36005959917, 9770.902290977, 10153.492325383553, 10204.38773673582, 10226.693199204035, 10235.437050962268, 63864.0, 64513.35486645261, 65316.346836532924, 65402.672986636666, 66427.41008049979, 84262.57868710617, 89958.55020724854, 94544.52727736317, 94891.0, 97956.0, 13243.0, 13359.198448093146, 13372.93313533465, 13394.263315517741, 13780.784736358983, 14996.896337678461, 15222.543323700307, 15366.231688415312, 15467.303971321542, 15640.530784076496, 8499.662711797082, 14020.649483762987, 14461.060031097944, 14555.12669239849, 14850.40598376096, 13980.0, 14143.363862038741, 14358.282085895873, 14399.42402303938, 14667.251310465908, 13653.385597648328, 13894.305284735925, 14221.98041349301, 14353.569392918229, 14469.565913022627, 11261.436928153724, 11538.538458461904, 11583.362915039754, 11634.011109055487, 11657.53369865196, 10529.498057251558, 11355.205135640426, 11717.238379505305, 11731.178817482694, 11756.647300580997], "value": 8020.294888987277, "unit": "score"}], "name": "dromaeo_css", "value": 7401.733569442897, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 116.0, 111.0, 114.0, 113.0, 114.0, 114.0, 113.0, 110.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 137.0, 137.0, 157.0, 106.0, 129.0, 139.0, 109.0, 157.0, 114.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 183.0, 185.0, 183.0, 185.0, 185.0, 183.0, 181.0, 185.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 58.0, 88.0, 56.0, 56.0, 66.0, 64.0, 81.0, 71.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 92.0, 91.0, 70.0, 71.0, 68.0, 96.0, 69.0, 68.0, 99.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 130.0, 97.0, 85.0, 88.0, 85.0, 90.0, 85.0, 88.0, 85.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 145.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 84.0, 85.0, 85.0, 83.0, 84.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 79.0, 106.0, 103.0, 101.0, 74.0, 70.0, 70.0, 70.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 84.0, 86.0, 83.0, 82.0, 83.0, 83.0, 86.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 129.0, 127.0, 145.0, 123.0, 138.0, 146.0, 150.0, 230.0, 143.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 162.0, 162.0, 160.0, 162.0, 160.0, 163.0, 161.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 65.0, 67.0, 66.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1453.0, "alertThreshold": 2.0}]} 19:36:27 INFO - Return code: 0 19:36:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:36:27 INFO - # TBPL SUCCESS # 19:36:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:36:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:36:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:36:27 INFO - 2016-07-23 19:36:27.892 screenresolution[3928:30318] starting screenresolution argv=screenresolution get 19:36:27 INFO - 2016-07-23 19:36:27.895 screenresolution[3928:30318] Display 0: 1600x1200x32@60 19:36:27 INFO - 2016-07-23 19:36:27.901 screenresolution[3929:30321] starting screenresolution argv=screenresolution list 19:36:27 INFO - Available Modes on Display 0 19:36:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:36:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:36:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:36:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:36:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:36:28 INFO - Intel Iris: 19:36:28 INFO - Chipset Model: Intel Iris 19:36:28 INFO - Type: GPU 19:36:28 INFO - Bus: Built-In 19:36:28 INFO - VRAM (Dynamic, Max): 1536 MB 19:36:28 INFO - Vendor: Intel (0x8086) 19:36:28 INFO - Device ID: 0x0a2e 19:36:28 INFO - Revision ID: 0x0009 19:36:28 INFO - Displays: 19:36:28 INFO - Display: 19:36:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:36:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:36:28 INFO - Display Serial Number: 1600x1200 60 19:36:28 INFO - Main Display: Yes 19:36:28 INFO - Mirror: Off 19:36:28 INFO - Online: Yes 19:36:28 INFO - Rotation: Supported 19:36:28 INFO - Return code: 0 19:36:28 INFO - Running post-action listener: _resource_record_post_action 19:36:28 INFO - ##### 19:36:28 INFO - ##### Finished run-tests step (success) 19:36:28 INFO - ##### 19:36:28 INFO - Running post-run listener: _resource_record_post_run 19:36:28 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 31714816; Write bytes: 709149184; Read time: 194; Write time: 1974 19:36:28 INFO - TinderboxPrint: CPU usage
53.5% 19:36:28 INFO - TinderboxPrint: I/O read bytes / time
31,714,816 / 194 19:36:28 INFO - TinderboxPrint: I/O write bytes / time
709,149,184 / 1,974 19:36:28 INFO - TinderboxPrint: CPU idle
2,254.9 (46.5%) 19:36:28 INFO - TinderboxPrint: CPU system
968.2 (20.0%) 19:36:28 INFO - TinderboxPrint: CPU user
1,622.3 (33.5%) 19:36:28 INFO - TinderboxPrint: Swap in / out
434,438,144 / 0 19:36:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402735616; Write bytes: 397035008; Read time: 29529; Write time: 815 19:36:28 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 29629952; Write bytes: 298281984; Read time: 174; Write time: 1120 19:36:28 INFO - Running post-run listener: _upload_blobber_files 19:36:28 INFO - Blob upload gear active. 19:36:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:36:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:36:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:36:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:36:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:36:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:36:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:36:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:36:30 INFO - (blobuploader) - INFO - Done attempting. 19:36:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:36:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:36:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:36:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:36:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:36:31 INFO - (blobuploader) - INFO - Done attempting. 19:36:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:36:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:36:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:36:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:36:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:36:33 INFO - (blobuploader) - INFO - Done attempting. 19:36:33 INFO - (blobuploader) - INFO - Iteration through files over. 19:36:33 INFO - Return code: 0 19:36:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:36:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:36:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d0f518420372bf6b1b7514ef9bc9a165260f0ad252e7a4d70b84b6e4e16366944a7424dcf6b298b9e2f95e5302b0c221615b2e5b41ec13f80a24e761a1e5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffca6a2369afb2fc97a296cc058e3d5c43dbfcff8912ff2e3d9d40f0721f35c3ccffa8a8a2e229a375b23aa2a8311152abe185c3fa551f22c8e59b545653c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dc075cb0c2a43fcefb65ca4de687f5ce0a7e1159b43948894ad953f10aa3479ef695ae0e2ddf255d52c6c881ae61b5ac7bfe1f328168b31eea5a151d0bf7e99"} 19:36:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:36:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:36:33 INFO - Contents: 19:36:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d0f518420372bf6b1b7514ef9bc9a165260f0ad252e7a4d70b84b6e4e16366944a7424dcf6b298b9e2f95e5302b0c221615b2e5b41ec13f80a24e761a1e5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffca6a2369afb2fc97a296cc058e3d5c43dbfcff8912ff2e3d9d40f0721f35c3ccffa8a8a2e229a375b23aa2a8311152abe185c3fa551f22c8e59b545653c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dc075cb0c2a43fcefb65ca4de687f5ce0a7e1159b43948894ad953f10aa3479ef695ae0e2ddf255d52c6c881ae61b5ac7bfe1f328168b31eea5a151d0bf7e99"} 19:36:33 INFO - Running post-run listener: copy_logs_to_upload_dir 19:36:33 INFO - Copying logs to upload dir... 19:36:33 INFO - mkdir: /builds/slave/test/build/upload/logs 19:36:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.038507 ========= master_lag: 0.71 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-23 19:36:34.663403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-23 19:36:34.666953) ========= 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.bPbqcW7tK3/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.qR13JmBmUg/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d0f518420372bf6b1b7514ef9bc9a165260f0ad252e7a4d70b84b6e4e16366944a7424dcf6b298b9e2f95e5302b0c221615b2e5b41ec13f80a24e761a1e5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffca6a2369afb2fc97a296cc058e3d5c43dbfcff8912ff2e3d9d40f0721f35c3ccffa8a8a2e229a375b23aa2a8311152abe185c3fa551f22c8e59b545653c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dc075cb0c2a43fcefb65ca4de687f5ce0a7e1159b43948894ad953f10aa3479ef695ae0e2ddf255d52c6c881ae61b5ac7bfe1f328168b31eea5a151d0bf7e99"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010942 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467626521/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d0f518420372bf6b1b7514ef9bc9a165260f0ad252e7a4d70b84b6e4e16366944a7424dcf6b298b9e2f95e5302b0c221615b2e5b41ec13f80a24e761a1e5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffca6a2369afb2fc97a296cc058e3d5c43dbfcff8912ff2e3d9d40f0721f35c3ccffa8a8a2e229a375b23aa2a8311152abe185c3fa551f22c8e59b545653c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dc075cb0c2a43fcefb65ca4de687f5ce0a7e1159b43948894ad953f10aa3479ef695ae0e2ddf255d52c6c881ae61b5ac7bfe1f328168b31eea5a151d0bf7e99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-23 19:36:34.700199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 19:36:34.700625) ========= 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.bPbqcW7tK3/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.qR13JmBmUg/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.004999 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 19:36:34.749900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-23 19:36:34.750249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-23 19:36:34.750599) ========= ========= Total master_lag: 0.85 =========