builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0314 starttime: 1468372961.49 results: success (0) buildid: 20160712162527 builduid: 572c3ed1d9bf48eaba41e5b218010d1a revision: 04821a70c739a00d12e12df651c0989441e22728 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.491341) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.491783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.492065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.517849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.518127) ========= 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.Zujyr2FiIB/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.BPduKRhoyO/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-12 18:22:41-- 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.5M=0.001s 2016-07-12 18:22:41 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123908 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.668794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.669176) ========= 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.Zujyr2FiIB/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.BPduKRhoyO/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.026787 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:41.718680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 18:22:41.719070) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 04821a70c739a00d12e12df651c0989441e22728 --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 04821a70c739a00d12e12df651c0989441e22728 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zujyr2FiIB/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.BPduKRhoyO/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-12 18:22:41,799 truncating revision to first 12 chars 2016-07-12 18:22:41,799 Setting DEBUG logging. 2016-07-12 18:22:41,799 attempt 1/10 2016-07-12 18:22:41,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/04821a70c739?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 18:22:43,200 unpacking tar archive at: mozilla-central-04821a70c739/testing/mozharness/ program finished with exit code 0 elapsedTime=1.663584 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 18:22:43.406059) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:43.406409) ========= script_repo_revision: 04821a70c739a00d12e12df651c0989441e22728 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:43.406880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:43.407187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:22:43.426355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-12 18:22:43.426811) ========= /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.Zujyr2FiIB/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.BPduKRhoyO/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:22:43 INFO - MultiFileLogger online at 20160712 18:22:43 in /builds/slave/test 18:22:43 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 18:22:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:43 INFO - {'append_to_log': False, 18:22:43 INFO - 'base_work_dir': '/builds/slave/test', 18:22:43 INFO - 'blob_upload_branch': 'Firefox', 18:22:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:43 INFO - 'branch': 'Firefox', 18:22:43 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:43 INFO - 'config_files': ('talos/mac_config.py',), 18:22:43 INFO - 'default_actions': ('clobber', 18:22:43 INFO - 'read-buildbot-config', 18:22:43 INFO - 'download-and-extract', 18:22:43 INFO - 'populate-webroot', 18:22:43 INFO - 'create-virtualenv', 18:22:43 INFO - 'install', 18:22:43 INFO - 'run-tests'), 18:22:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:43 INFO - 'download_minidump_stackwalk': True, 18:22:43 INFO - 'download_symbols': 'ondemand', 18:22:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:43 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:43 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:43 INFO - 'installer_path': 'installer.exe', 18:22:43 INFO - 'log_level': 'info', 18:22:43 INFO - 'log_name': 'talos', 18:22:43 INFO - 'log_to_console': True, 18:22:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:22:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:22:43 INFO - 'opt_config_files': (), 18:22:43 INFO - 'pip_index': False, 18:22:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:22:43 INFO - 'cmd': ('bash', 18:22:43 INFO - '-c', 18:22:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:22:43 INFO - 'enabled': True, 18:22:43 INFO - 'halt_on_failure': False, 18:22:43 INFO - 'name': 'check_screen_resolution'},), 18:22:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:22:43 INFO - 'cmd': ('bash', 18:22:43 INFO - '-c', 18:22:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:22:43 INFO - 'enabled': True, 18:22:43 INFO - 'halt_on_failure': False, 18:22:43 INFO - 'name': 'check_screen_resolution'},), 18:22:43 INFO - 'run_cmd_checks_enabled': True, 18:22:43 INFO - 'sps_profile': False, 18:22:43 INFO - 'sps_profile_interval': 0, 18:22:43 INFO - 'suite': 'dromaeojs', 18:22:43 INFO - 'system_bits': '32', 18:22:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:43 INFO - 'title': 't-yosemite-r7-0314', 18:22:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:43 INFO - 'use_talos_json': True, 18:22:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:43 INFO - 'work_dir': 'build'} 18:22:43 INFO - ##### 18:22:43 INFO - ##### Running clobber step. 18:22:43 INFO - ##### 18:22:43 INFO - Running pre-action listener: _resource_record_pre_action 18:22:43 INFO - Running main action method: clobber 18:22:43 INFO - rmtree: /builds/slave/test/build 18:22:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:45 INFO - Running post-action listener: _resource_record_post_action 18:22:45 INFO - ##### 18:22:45 INFO - ##### Finished clobber step (success) 18:22:45 INFO - ##### 18:22:45 INFO - ##### 18:22:45 INFO - ##### Running read-buildbot-config step. 18:22:45 INFO - ##### 18:22:45 INFO - Running pre-action listener: _resource_record_pre_action 18:22:45 INFO - Running main action method: read_buildbot_config 18:22:45 INFO - Using buildbot properties: 18:22:45 INFO - { 18:22:45 INFO - "project": "", 18:22:45 INFO - "product": "firefox", 18:22:45 INFO - "script_repo_revision": "production", 18:22:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:22:45 INFO - "repository": "", 18:22:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:22:45 INFO - "buildid": "20160712162527", 18:22:45 INFO - "pgo_build": "False", 18:22:45 INFO - "basedir": "/builds/slave/test", 18:22:45 INFO - "buildnumber": 10, 18:22:45 INFO - "slavename": "t-yosemite-r7-0314", 18:22:45 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 18:22:45 INFO - "platform": "yosemite_r7", 18:22:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:22:45 INFO - "branch": "mozilla-central", 18:22:45 INFO - "repo_path": "mozilla-central", 18:22:45 INFO - "revision": "04821a70c739a00d12e12df651c0989441e22728", 18:22:45 INFO - "stage_platform": "macosx64", 18:22:45 INFO - "builduid": "572c3ed1d9bf48eaba41e5b218010d1a", 18:22:45 INFO - "slavebuilddir": "test" 18:22:45 INFO - } 18:22:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 18:22:45 INFO - Running post-action listener: _resource_record_post_action 18:22:45 INFO - ##### 18:22:45 INFO - ##### Finished read-buildbot-config step (success) 18:22:45 INFO - ##### 18:22:45 INFO - ##### 18:22:45 INFO - ##### Running download-and-extract step. 18:22:45 INFO - ##### 18:22:45 INFO - Running pre-action listener: _resource_record_pre_action 18:22:45 INFO - Running main action method: download_and_extract 18:22:45 INFO - mkdir: /builds/slave/test/build/tests 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:45 INFO - https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/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 18:22:46 INFO - Downloaded 1199 bytes. 18:22:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:22:46 INFO - Using the following test package requirements: 18:22:46 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:22:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 18:22:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 18:22:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'jsshell-mac.zip'], 18:22:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 18:22:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:22:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 18:22:46 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 18:22:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 18:22:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:22:46 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 18:22:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:46 INFO - https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/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 18:22:47 INFO - Downloaded 18822739 bytes. 18:22:47 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'] 18:22:47 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 18:22:50 INFO - Return code: 0 18:22:50 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 18:22: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')]} 18:22:50 INFO - https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/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 18:22:52 INFO - Downloaded 18822739 bytes. 18:22:52 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'] 18:22:52 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 18:22:55 INFO - Return code: 0 18:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:55 INFO - https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:22:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:22:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:22:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/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 18:22:57 INFO - Downloaded 14403317 bytes. 18:22:57 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'] 18:22:57 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 18:22:58 INFO - Return code: 0 18:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:58 INFO - https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:22:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:22:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:22:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 18:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 18:23:00 INFO - Downloaded 112775479 bytes. 18:23:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:23:00 INFO - mkdir: /builds/slave/test/properties 18:23:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:00 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:00 INFO - Contents: 18:23:00 INFO - build_url:https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:23:02 INFO - Running post-action listener: _resource_record_post_action 18:23:02 INFO - Running post-action listener: set_extra_try_arguments 18:23:02 INFO - ##### 18:23:02 INFO - ##### Finished download-and-extract step (success) 18:23:02 INFO - ##### 18:23:02 INFO - ##### 18:23:02 INFO - ##### Running populate-webroot step. 18:23:02 INFO - ##### 18:23:02 INFO - Running pre-action listener: _resource_record_pre_action 18:23:02 INFO - Running main action method: populate_webroot 18:23:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:02 INFO - '--tppagecycles', 18:23:02 INFO - '7'], 18:23:02 INFO - 'tests': ['tsvgm']}}, 18:23:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:23:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:23:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:23:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['damp', 'tps']}, 18:23:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'tests': ['damp', 'tps']}, 18:23:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['dromaeo_dom']}, 18:23:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['basic_compositor_video']}, 18:23:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:23:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['a11yr', 18:23:02 INFO - 'ts_paint', 18:23:02 INFO - 'tpaint', 18:23:02 INFO - 'sessionrestore', 18:23:02 INFO - 'sessionrestore_no_auto_restore', 18:23:02 INFO - 'tabpaint']}, 18:23:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:23:02 INFO - 'ts_paint', 18:23:02 INFO - 'tpaint', 18:23:02 INFO - 'sessionrestore', 18:23:02 INFO - 'sessionrestore_no_auto_restore', 18:23:02 INFO - 'tabpaint']}, 18:23:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:23:02 INFO - 'ts_paint', 18:23:02 INFO - 'tpaint', 18:23:02 INFO - 'sessionrestore', 18:23:02 INFO - 'sessionrestore_no_auto_restore', 18:23:02 INFO - 'tabpaint']}, 18:23:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:23:02 INFO - 'ts_paint', 18:23:02 INFO - 'tpaint', 18:23:02 INFO - 'sessionrestore', 18:23:02 INFO - 'sessionrestore_no_auto_restore', 18:23:02 INFO - 'tabpaint']}, 18:23:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['a11yr', 18:23:02 INFO - 'ts_paint', 18:23:02 INFO - 'tpaint', 18:23:02 INFO - 'sessionrestore', 18:23:02 INFO - 'sessionrestore_no_auto_restore', 18:23:02 INFO - 'tabpaint']}, 18:23:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['a11yr', 18:23:02 INFO - 'ts_paint', 18:23:02 INFO - 'tpaint', 18:23:02 INFO - 'sessionrestore', 18:23:02 INFO - 'sessionrestore_no_auto_restore', 18:23:02 INFO - 'tabpaint']}, 18:23:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['tsvgx', 18:23:02 INFO - 'tsvgr_opacity', 18:23:02 INFO - 'tart', 18:23:02 INFO - 'tscrollx', 18:23:02 INFO - 'cart']}, 18:23:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:23:02 INFO - 'tsvgr_opacity', 18:23:02 INFO - 'tart', 18:23:02 INFO - 'tscrollx', 18:23:02 INFO - 'cart']}, 18:23:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'talos_options': ['--disable-e10s'], 18:23:02 INFO - 'tests': ['tp5o']}, 18:23:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'tests': ['tp5o']}, 18:23:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'talos_options': ['--disable-e10s', 18:23:02 INFO - '--xperf_path', 18:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:02 INFO - 'tests': ['tp5n']}, 18:23:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:02 INFO - 'talos_options': ['--xperf_path', 18:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:02 INFO - 'tests': ['tp5n']}}, 18:23:02 INFO - 'talos.zip': {'path': '', 18:23:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:02 INFO - Running post-action listener: _resource_record_post_action 18:23:02 INFO - ##### 18:23:02 INFO - ##### Finished populate-webroot step (success) 18:23:02 INFO - ##### 18:23:02 INFO - ##### 18:23:02 INFO - ##### Running create-virtualenv step. 18:23:02 INFO - ##### 18:23:02 INFO - Running pre-action listener: _resource_record_pre_action 18:23:02 INFO - Running main action method: create_virtualenv 18:23:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:23:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:02 INFO - Using real prefix '/tools/python27' 18:23:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:02 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:06 INFO - Installing pip.................done. 18:23:06 INFO - Return code: 0 18:23:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:06 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:06 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 18:23:06 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 18:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:06 INFO - 'HOME': '/Users/cltbld', 18:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:06 INFO - 'LOGNAME': 'cltbld', 18:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:06 INFO - 'MOZ_NO_REMOTE': '1', 18:23:06 INFO - 'NO_EM_RESTART': '1', 18:23:06 INFO - 'PAGER': '/bin/cat', 18:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:06 INFO - 'PWD': '/builds/slave/test', 18:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:06 INFO - 'SHELL': '/bin/bash', 18:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:06 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:06 INFO - 'USER': 'cltbld', 18:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:06 INFO - 'XPC_FLAGS': '0x0', 18:23:06 INFO - 'XPC_SERVICE_NAME': '0', 18:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:23:06 INFO - Cleaning up... 18:23:06 INFO - Return code: 0 18:23:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:06 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:06 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 18:23:06 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 18:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:06 INFO - 'HOME': '/Users/cltbld', 18:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:06 INFO - 'LOGNAME': 'cltbld', 18:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:06 INFO - 'MOZ_NO_REMOTE': '1', 18:23:06 INFO - 'NO_EM_RESTART': '1', 18:23:06 INFO - 'PAGER': '/bin/cat', 18:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:06 INFO - 'PWD': '/builds/slave/test', 18:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:06 INFO - 'SHELL': '/bin/bash', 18:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:06 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:06 INFO - 'USER': 'cltbld', 18:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:06 INFO - 'XPC_FLAGS': '0x0', 18:23:06 INFO - 'XPC_SERVICE_NAME': '0', 18:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:06 INFO - Downloading/unpacking psutil>=3.1.1 18:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:09 INFO - Installing collected packages: psutil 18:23:09 INFO - Running setup.py install for psutil 18:23:09 INFO - building 'psutil._psutil_osx' extension 18:23:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:23:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:23:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:23:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:23:10 INFO - building 'psutil._psutil_posix' extension 18:23:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:23:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:23:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:23:10 INFO - ^ 18:23:10 INFO - 1 warning generated. 18:23:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:10 INFO - Successfully installed psutil 18:23:10 INFO - Cleaning up... 18:23:10 INFO - Return code: 0 18:23:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:10 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:10 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 18:23:10 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 18:23:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:10 INFO - 'HOME': '/Users/cltbld', 18:23:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:10 INFO - 'LOGNAME': 'cltbld', 18:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:10 INFO - 'MOZ_NO_REMOTE': '1', 18:23:10 INFO - 'NO_EM_RESTART': '1', 18:23:10 INFO - 'PAGER': '/bin/cat', 18:23:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:10 INFO - 'PWD': '/builds/slave/test', 18:23:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:10 INFO - 'SHELL': '/bin/bash', 18:23:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:10 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:10 INFO - 'USER': 'cltbld', 18:23:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:10 INFO - 'XPC_FLAGS': '0x0', 18:23:10 INFO - 'XPC_SERVICE_NAME': '0', 18:23:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:23:13 INFO - Installing collected packages: mozsystemmonitor 18:23:13 INFO - Running setup.py install for mozsystemmonitor 18:23:13 INFO - Successfully installed mozsystemmonitor 18:23:13 INFO - Cleaning up... 18:23:13 INFO - Return code: 0 18:23:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:13 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:13 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 18:23:13 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 18:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:13 INFO - 'HOME': '/Users/cltbld', 18:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:13 INFO - 'LOGNAME': 'cltbld', 18:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:13 INFO - 'MOZ_NO_REMOTE': '1', 18:23:13 INFO - 'NO_EM_RESTART': '1', 18:23:13 INFO - 'PAGER': '/bin/cat', 18:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:13 INFO - 'PWD': '/builds/slave/test', 18:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:13 INFO - 'SHELL': '/bin/bash', 18:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:13 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:13 INFO - 'USER': 'cltbld', 18:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:13 INFO - 'XPC_FLAGS': '0x0', 18:23:13 INFO - 'XPC_SERVICE_NAME': '0', 18:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:13 INFO - Downloading/unpacking jsonschema==2.5.1 18:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:23:16 INFO - warning: no files found matching '*.txt' 18:23:16 INFO - no previously-included directories found matching 'build' 18:23:16 INFO - no previously-included directories found matching 'dist' 18:23:16 INFO - no previously-included directories found matching '.git*' 18:23:16 INFO - Installing collected packages: jsonschema, functools32 18:23:16 INFO - Running setup.py install for functools32 18:23:16 INFO - warning: no files found matching '*.txt' 18:23:16 INFO - no previously-included directories found matching 'build' 18:23:16 INFO - no previously-included directories found matching 'dist' 18:23:16 INFO - no previously-included directories found matching '.git*' 18:23:16 INFO - Successfully installed jsonschema functools32 18:23:16 INFO - Cleaning up... 18:23:16 INFO - Return code: 0 18:23:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:16 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:16 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 18:23:16 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 18:23:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:16 INFO - 'HOME': '/Users/cltbld', 18:23:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:16 INFO - 'LOGNAME': 'cltbld', 18:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:16 INFO - 'MOZ_NO_REMOTE': '1', 18:23:16 INFO - 'NO_EM_RESTART': '1', 18:23:16 INFO - 'PAGER': '/bin/cat', 18:23:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:16 INFO - 'PWD': '/builds/slave/test', 18:23:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:16 INFO - 'SHELL': '/bin/bash', 18:23:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:16 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:16 INFO - 'USER': 'cltbld', 18:23:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:16 INFO - 'XPC_FLAGS': '0x0', 18:23:16 INFO - 'XPC_SERVICE_NAME': '0', 18:23:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:20 INFO - Downloading docopt-0.6.1.tar.gz 18:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:20 INFO - Running setup.py install for blobuploader 18:23:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:21 INFO - Running setup.py install for requests 18:23:21 INFO - Running setup.py install for docopt 18:23:21 INFO - Successfully installed blobuploader requests docopt 18:23:21 INFO - Cleaning up... 18:23:21 INFO - Return code: 0 18:23:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:21 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:21 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 18:23:21 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 18:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:21 INFO - 'HOME': '/Users/cltbld', 18:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:21 INFO - 'LOGNAME': 'cltbld', 18:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:21 INFO - 'MOZ_NO_REMOTE': '1', 18:23:21 INFO - 'NO_EM_RESTART': '1', 18:23:21 INFO - 'PAGER': '/bin/cat', 18:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:21 INFO - 'PWD': '/builds/slave/test', 18:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:21 INFO - 'SHELL': '/bin/bash', 18:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:21 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:21 INFO - 'USER': 'cltbld', 18:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:21 INFO - 'XPC_FLAGS': '0x0', 18:23:21 INFO - 'XPC_SERVICE_NAME': '0', 18:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-NWqQow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8dUQFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tUk5a0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-rZcgVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-5RoJrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-NvODak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-k4U_iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-YmoL1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ffc7jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-2gjkRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Q1rgXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-QKjzxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ExrEVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-YzZzu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tEdPvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-S0fnt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-kAdxB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:23:23 INFO - Running setup.py install for manifestparser 18:23:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:23:23 INFO - Running setup.py install for mozcrash 18:23:24 INFO - Running setup.py install for mozdebug 18:23:24 INFO - Running setup.py install for mozdevice 18:23:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Running setup.py install for mozfile 18:23:24 INFO - Running setup.py install for mozhttpd 18:23:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Running setup.py install for mozinfo 18:23:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Running setup.py install for mozInstall 18:23:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:23:24 INFO - Running setup.py install for mozleak 18:23:25 INFO - Running setup.py install for mozlog 18:23:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:23:25 INFO - Running setup.py install for moznetwork 18:23:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:23:25 INFO - Running setup.py install for mozprocess 18:23:25 INFO - Running setup.py install for mozprofile 18:23:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:23:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:23:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:23:25 INFO - Running setup.py install for mozrunner 18:23:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:23:25 INFO - Running setup.py install for mozscreenshot 18:23:26 INFO - Running setup.py install for moztest 18:23:26 INFO - Running setup.py install for mozversion 18:23:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:23:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:23:26 INFO - Cleaning up... 18:23:26 INFO - Return code: 0 18:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:26 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:26 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 18:23:26 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 18:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:26 INFO - 'HOME': '/Users/cltbld', 18:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:26 INFO - 'LOGNAME': 'cltbld', 18:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:26 INFO - 'MOZ_NO_REMOTE': '1', 18:23:26 INFO - 'NO_EM_RESTART': '1', 18:23:26 INFO - 'PAGER': '/bin/cat', 18:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:26 INFO - 'PWD': '/builds/slave/test', 18:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:26 INFO - 'SHELL': '/bin/bash', 18:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:26 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:26 INFO - 'USER': 'cltbld', 18:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:26 INFO - 'XPC_FLAGS': '0x0', 18:23:26 INFO - 'XPC_SERVICE_NAME': '0', 18:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-OaBiAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-zh1wim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:26 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)) 18:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-JG6WJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-YUZF4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:27 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)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-pKTFCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-w70d6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CQ42un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-pS0lAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-zMcRpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-TWnBGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:27 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)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-j1sIZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-2mBwBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-bJfFiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:28 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)) 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-BBRYPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tXmtJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-lcTaoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-KfnlNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:23:28 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)) 18:23:28 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)) 18:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:23:28 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)) 18:23:28 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)) 18:23:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:30 INFO - Downloading blessings-1.6.tar.gz 18:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:23:31 INFO - Installing collected packages: blessings 18:23:31 INFO - Running setup.py install for blessings 18:23:31 INFO - Successfully installed blessings 18:23:31 INFO - Cleaning up... 18:23:31 INFO - Return code: 0 18:23:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:31 INFO - Reading from file tmpfile_stdout 18:23:31 INFO - Current package versions: 18:23:31 INFO - blessings == 1.6 18:23:31 INFO - blobuploader == 1.2.4 18:23:31 INFO - docopt == 0.6.1 18:23:31 INFO - functools32 == 3.2.3-2 18:23:31 INFO - jsonschema == 2.5.1 18:23:31 INFO - manifestparser == 1.1 18:23:31 INFO - mozInstall == 1.12 18:23:31 INFO - mozcrash == 0.17 18:23:31 INFO - mozdebug == 0.1 18:23:31 INFO - mozdevice == 0.48 18:23:31 INFO - mozfile == 1.2 18:23:31 INFO - mozhttpd == 0.7 18:23:31 INFO - mozinfo == 0.9 18:23:31 INFO - mozleak == 0.1 18:23:31 INFO - mozlog == 3.2 18:23:31 INFO - moznetwork == 0.27 18:23:31 INFO - mozprocess == 0.23 18:23:31 INFO - mozprofile == 0.28 18:23:31 INFO - mozrunner == 6.12 18:23:31 INFO - mozscreenshot == 0.1 18:23:31 INFO - mozsystemmonitor == 0.3 18:23:31 INFO - moztest == 0.7 18:23:31 INFO - mozversion == 1.4 18:23:31 INFO - psutil == 3.1.1 18:23:31 INFO - requests == 1.2.3 18:23:31 INFO - wsgiref == 0.1.2 18:23:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:31 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:31 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 18:23:31 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 18:23:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:31 INFO - 'HOME': '/Users/cltbld', 18:23:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:31 INFO - 'LOGNAME': 'cltbld', 18:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:31 INFO - 'MOZ_NO_REMOTE': '1', 18:23:31 INFO - 'NO_EM_RESTART': '1', 18:23:31 INFO - 'PAGER': '/bin/cat', 18:23:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:31 INFO - 'PWD': '/builds/slave/test', 18:23:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:31 INFO - 'SHELL': '/bin/bash', 18:23:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:31 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:31 INFO - 'USER': 'cltbld', 18:23:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:31 INFO - 'XPC_FLAGS': '0x0', 18:23:31 INFO - 'XPC_SERVICE_NAME': '0', 18:23:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 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)) 18:23:31 INFO - Cleaning up... 18:23:31 INFO - Return code: 0 18:23:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:31 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ad79550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, '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.Zujyr2FiIB/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.BPduKRhoyO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 18:23:31 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 18:23:31 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 18:23:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:23:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:31 INFO - 'HOME': '/Users/cltbld', 18:23:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:31 INFO - 'LOGNAME': 'cltbld', 18:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:31 INFO - 'MOZ_NO_REMOTE': '1', 18:23:31 INFO - 'NO_EM_RESTART': '1', 18:23:31 INFO - 'PAGER': '/bin/cat', 18:23:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:31 INFO - 'PWD': '/builds/slave/test', 18:23:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:31 INFO - 'SHELL': '/bin/bash', 18:23:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:23:31 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:23:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:31 INFO - 'USER': 'cltbld', 18:23:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:31 INFO - 'XPC_FLAGS': '0x0', 18:23:31 INFO - 'XPC_SERVICE_NAME': '0', 18:23:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:23:32 INFO - Cleaning up... 18:23:32 INFO - Return code: 0 18:23:32 INFO - Running post-action listener: _resource_record_post_action 18:23:32 INFO - Running post-action listener: _start_resource_monitoring 18:23:32 INFO - Starting resource monitoring. 18:23:32 INFO - ##### 18:23:32 INFO - ##### Finished create-virtualenv step (success) 18:23:32 INFO - ##### 18:23:32 INFO - ##### 18:23:32 INFO - ##### Running install step. 18:23:32 INFO - ##### 18:23:32 INFO - Running pre-action listener: _resource_record_pre_action 18:23:32 INFO - Running main action method: install 18:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:32 INFO - Reading from file tmpfile_stdout 18:23:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:23:32 INFO - Reading from file tmpfile_stdout 18:23:32 INFO - Output received: 18:23:32 INFO - Usage: mozinstall [options] installer 18:23:32 INFO - Options: 18:23:32 INFO - -h, --help show this help message and exit 18:23:32 INFO - -d DEST, --destination=DEST 18:23:32 INFO - Directory to install application into. [default: 18:23:32 INFO - "/builds/slave/test"] 18:23:32 INFO - --app=APP Application being installed. [default: firefox] 18:23:32 INFO - mkdir: /builds/slave/test/build/application 18:23:32 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'] 18:23:32 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 18:24:06 INFO - Reading from file tmpfile_stdout 18:24:06 INFO - Output received: 18:24:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:24:06 INFO - Running post-action listener: _resource_record_post_action 18:24:06 INFO - ##### 18:24:06 INFO - ##### Finished install step (success) 18:24:06 INFO - ##### 18:24:06 INFO - ##### 18:24:06 INFO - ##### Running run-tests step. 18:24:06 INFO - ##### 18:24:06 INFO - Running pre-action listener: _resource_record_pre_action 18:24:06 INFO - Running main action method: run_tests 18:24:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:24:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:24:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:24:06 INFO - 2016-07-12 18:24:06.356 screenresolution[1653:7434] starting screenresolution argv=screenresolution get 18:24:06 INFO - 2016-07-12 18:24:06.359 screenresolution[1653:7434] Display 0: 1600x1200x32@60 18:24:06 INFO - 2016-07-12 18:24:06.365 screenresolution[1654:7436] starting screenresolution argv=screenresolution list 18:24:06 INFO - Available Modes on Display 0 18:24:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:24:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:24:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:24:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:24:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:24:06 INFO - Intel Iris: 18:24:06 INFO - Chipset Model: Intel Iris 18:24:06 INFO - Type: GPU 18:24:06 INFO - Bus: Built-In 18:24:06 INFO - VRAM (Dynamic, Max): 1536 MB 18:24:06 INFO - Vendor: Intel (0x8086) 18:24:06 INFO - Device ID: 0x0a2e 18:24:06 INFO - Revision ID: 0x0009 18:24:06 INFO - Displays: 18:24:06 INFO - Display: 18:24:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:24:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:24:06 INFO - Display Serial Number: 1600x1200 60 18:24:06 INFO - Main Display: Yes 18:24:06 INFO - Mirror: Off 18:24:06 INFO - Online: Yes 18:24:06 INFO - Rotation: Supported 18:24:06 INFO - Return code: 0 18:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:24:06 INFO - Python 2.7.3 18:24:06 INFO - Return code: 0 18:24:06 INFO - grabbing minidump binary from tooltool 18:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:06 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 0x10311fd30>, '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 0x102e84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103117b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:24:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:24:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:24:06 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 18:24:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:24:06 INFO - Return code: 0 18:24:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:24:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:24:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:24:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:24:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:24:06 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 18:24:06 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --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 18:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zujyr2FiIB/Render', 18:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:06 INFO - 'HOME': '/Users/cltbld', 18:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:06 INFO - 'LOGNAME': 'cltbld', 18:24:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:24:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:06 INFO - 'MOZ_NO_REMOTE': '1', 18:24:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:24:06 INFO - 'NO_EM_RESTART': '1', 18:24:06 INFO - 'PAGER': '/bin/cat', 18:24:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:06 INFO - 'PWD': '/builds/slave/test', 18:24:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:06 INFO - 'SHELL': '/bin/bash', 18:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BPduKRhoyO/Listeners', 18:24:06 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:06 INFO - 'USER': 'cltbld', 18:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:06 INFO - 'XPC_FLAGS': '0x0', 18:24:06 INFO - 'XPC_SERVICE_NAME': '0', 18:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:06 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 18:24:06 INFO - mozversion application_buildid: 20160712162527 18:24:06 INFO - mozversion application_changeset: 04821a70c739a00d12e12df651c0989441e22728 18:24:06 INFO - mozversion application_display_name: Nightly 18:24:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:24:06 INFO - mozversion application_name: Firefox 18:24:06 INFO - mozversion application_remotingname: firefox 18:24:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:24:06 INFO - mozversion application_vendor: Mozilla 18:24:06 INFO - mozversion application_version: 50.0a1 18:24:06 INFO - mozversion platform_buildid: 20160712162527 18:24:06 INFO - mozversion platform_changeset: 04821a70c739a00d12e12df651c0989441e22728 18:24:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:24:06 INFO - mozversion platform_version: 50.0a1 18:24:06 INFO - using testdate: 1468373046 18:24:06 INFO - actual date: 1468373046 18:24:06 INFO - starting webserver on 'localhost:49271' 18:24:06 INFO - SUITE-START | Running 2 tests 18:24:06 INFO - TEST-START | dromaeo_css 18:24:06 INFO - operating with platform_type : mac_ 18:24:06 INFO - Initialising browser for dromaeo_css test... 18:24:06 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpBTZENG/profile http://localhost:49271/getInfo.html) 18:24:09 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 18:24:09 INFO - PROCESS | 1664 | colorDepth:24 18:24:09 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 18:24:09 INFO - PROCESS | 1664 | __metrics 18:24:09 INFO - PROCESS | 1664 | 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" 18:24:09 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:24:09 INFO - TEST-INFO | 1664: exit 0 18:24:09 INFO - Browser initialized. 18:24:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:24:09 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpBTZENG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:21 INFO - PROCESS | 1666 | RSS: Main: 243818496 18:24:21 INFO - PROCESS | 1666 | 18:25:13 INFO - PROCESS | 1666 | 1468373113899 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:27:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 18:27:25 INFO - PROCESS | 1666 | RSS: Main: 372719616 18:27:25 INFO - PROCESS | 1666 | 18:30:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 18:30:29 INFO - PROCESS | 1666 | RSS: Main: 381571072 18:30:29 INFO - PROCESS | 1666 | 18:33:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 18:33:32 INFO - PROCESS | 1666 | RSS: Main: 372371456 18:33:32 INFO - PROCESS | 1666 | 18:36:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 18:36:35 INFO - PROCESS | 1666 | RSS: Main: 371736576 18:36:35 INFO - PROCESS | 1666 | 18:39:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 18:39:39 INFO - PROCESS | 1666 | RSS: Main: 335884288 18:39:39 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 18:42:42 INFO - PROCESS | 1666 | RSS: Main: 381739008 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | __start_tp_report 18:42:42 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 18:42:42 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 18:42:42 INFO - PROCESS | 1666 | |i|pagename|runs| 18:42:42 INFO - PROCESS | 1666 | |0;dojo.html;3282.5404443377925;3346.431106711859;3349.715274201692;3353.3628610563974;3425.862965481381;5529.778808847651;5607.803726869561;5616.241807356006;5666.235058267138;5690.9146362804595;5617.747201375938;5631.211630371741;5706.486416222539;5739.454751798583;5739.655620662753;4462.085272519126;5069.391672999245;5110.948890511085;5119.539241468267;5228.058949389108;5169.48305169482;5214.191800270964;5216.556592689626;5223.895522089556;5225.686458812484;4267.466566679165;5076.289319495255;5094.184930411154;5108.846734597968;5177.844664660066;5085.008423357447;5111.718855462948;5129.461406552333;5129.666571672867;5157.58739300855;5082.822101226477;5137.12668846297;5153.072446959583;5181;5200.5059519345605;4613.21575332191;5508.03609368359;5682.715864206773;5701.2018317435595;5731.598788084794;6184.07238914162;6185.41238582334;6188.319284878705;6215.937840621581;6219.2847822500535;6277.905831412532;6300.87398252037;6306.9684651576445;6313.084602732624;6313.71588278524;4870.634702397334;5632.71836408182;5706.743196556165;5781.82654520365;5785.913211301834;6237.189165408558;6238.157848690459;6241.407066328691;6247.09417134522;6247.875042499125;5930.466258036798;6122.693865306717;6129.678576603484;6138.938610613836;6142.6314421134875;6113.871604717183;6152.230971128609;6207.6585787782105;6214.627122372672;6285.214348206474;6151.292601350902;6177.4749146322165;6203.751849925952;6207.689615519296;6215.34738852423;6085.786997455068;6182.69086545671;6202.906956395657;6263.843403914848;6275;4821.590164836029;4825.662203645781;4843.588294994965;4861.683990540603;4862.9756851216225;4370.322599996942;4378.584034516716;4386.912261754747;4403.779811009436;4416.028473735773;5546.389897111315;5687.886242275132;5717.428257174332;5723.284589426322;5753.424657534213;6145.539084568586;6162.168107305546;6194.194754681863;6235.812925612239;6311.211098612674;5702.6293290935955;5725;5733.3406658234835;5740.339860916049;5767.884642307215;5219.138842091088;5378.865528361822;5388.703621300866;5396.892062158735;5410.648307859977;6203.689815509207;6236.095766113797;6249.25008998923;6253.1245625613365;6327.430531252209;6236.438720515175;6259.092431597484;6288.842778930563;6294.402031806971;6303.842403939938;6242.531810114168;6255.96872015637;6274.341194174546;6288.339724328879;6307.7476900925285;6065.393460654076;6077.726502307495;6121.87979361315;6124;6172.814815555541;4737.265723812815;6043.456088952015;6233.438990490878;6244;6265.122882796321;5857.47282744555;6074.179985701874;6082.422169893853;6088.8782224356155;6110.877782444415;5914.172015917689;5983.491403230774;6026.969865150646;6072.14989901423;6101.084837274444;5904.350521442552;5954.553408494467;5957.49361304294;5963.642181469126;5994.970025149846;5819.6508209507565;6080.279543954153;6132.080177995836;6132.777018057034;6143.757528502154;5738.196652468741;5822.679752613478;5832.154337621106;5875.3243377012195;5915.171875937286 18:42:42 INFO - PROCESS | 1666 | |1;ext.html;506.9949300506994;512.5694416689981;542.5605259739611;545.1849485019893;551.6607286518787;30375.69624303759;30964.38071238574;41147.588524114784;42256.57743422573;42470;41918.37122443158;44646.2141514339;44926;44965.55034449654;45243;9549.904500955006;9731.270154738422;9738.756531086745;9770.267229957746;9791.16775074116;8743.081976392483;9583.808323833518;11878.406079696024;11897.167198296123;12169.087318451107;11918.642440726791;12022;12027.939860300687;12028.398580070962;12031.157818952634;11893;11981.760364792699;11984;11985.700357491045;11997.980171685418;11858.466369013415;11867.347295898722;11937.94031029848;11947.283163010161;11953.22304050234;41713;42038;42065.78967105145;42085.94785130366;42112.57887421117;3549.2014296783277;3562.5012498250007;3573.3032058748554;3635.345637785224;3700.9814950925343;31782.682173178204;31944.20139496508;32372.514412283836;32970;33132;3238.5789847319697;3263.216827961272;3303.884364047247;3307.338532293551;3347.1130150510135;547351;548324.999999996;548604;548749;549439.5280236012;60863.435242357;62014.689926550076;62061.689691551255;62230.37769622336;62494;65582.67208663926;65612.67193664097;65719;65805.34194658088;65901;16511.422100226435;16998.89507182029;17020.744688829676;17021.40425085116;17039.48881533556;11930.284182949052;12056.517739290506;13057.21656700601;13132.409041593151;13135.802962955564;16732;16962.91518542424;17011.404600838912;17339.47981560555;17532.737008944878;6239.407256310643;6976.162860456778;7026.086608740933;7105.680244389015;7124.92875071253;832.854250506159;893.5710858787818;980.0836218136066;993.0119531066634;1055.1875056206677;30584.54123188154;31040;31064.378712425623;31534.842325788224;31960.520592191137;1028.6708253359002;1050.1861057680205;1087.9184061195442;1104.812181929074;1147.8163493840946;16309.266083026292;16678.749818752727;16737.414190503274;16746.330146794236;17207.96752194872;714048;714616;715453;719373;720014;59879;61511.6924415375;61549.76900461966;61625.075623865676;61768.07347889785;1235.2218102595486;1297.0401902592014;1383.5434306678771;1412.5338638249352;1427.421894132878;29847.104586862428;30194.84902575473;31978.84010579932;32041.839790800896;32867.50698739569;54056.459435405144;54473.45526544842;54997;55119.72440137774;55180.724096379265;664563;676165;676788;677157;678634;37311.81344093262;37812.81093594514;37821;39093;43281.727080560704;41671;48109.75945120392;48733.5126648729;49713.751431242614;50128.997420052125;40405.19189616133;40407.59592404156;40714.18571628492;41435.96410089651;41691.79154104331;38439.807800960814;39579.80210098931;39668;40569.348758610686;40723;38653.806730966164;38778;39348.40977385284;39597.01007474836;39631.61289354859;32523.51214731828;32937.67062329442;33943.98168054962;34947.30105397929;35223.47164792479;21583.597066190647;25353;25930.35174120662;25967.961281548527;26358 18:42:42 INFO - PROCESS | 1666 | |2;jquery.html;350.60907088596224;373.7253118957566;377.5620280474648;380.2547007864585;402.5069290119604;15623.06261624302;16568.08875511848;21448.463788405297;21728.674069888926;21757.67363489547;20871.373858784224;21026;21675.891620541875;21793.564128717415;22976.540469190608;5237.607179461536;5896.410358964102;6141.539384546155;6145.5390845686525;6150.200473938382;6035.818925432244;6083.330833608299;6109;6136.018237082068;6138.202033735608;5815;5921.200637913891;5924.496417804492;5928.525717942576;5938.673372964486;5772.942270577282;5920.526357891358;5967;5976.940230597704;5984.760609575612;5220.791168353261;5250.18622113573;5254.00173966945;5261.947380526222;5263.236830659571;22387.55224895493;27119;27287.590686139723;27306.45387092247;27559.86220068887;2292.3008482412856;2440.45089854783;2502;2535.1380530619676;2862;15452.768208476882;16271.860969732123;16316;16367.91816040912;16661.91669041647;1872.129459801199;1890.5462688954551;1894.5453091258137;1935.2452543508043;1939.9612007759765;130681.34659326737;130924.99999999905;133379;133462;133900.33049834784;10962.287451315638;11078.889211107948;11318.830217546743;11654.825177622342;11734.88265117355;13927.58217253484;14056.22690751998;14067.929660351838;14078.2960851957;14127.223002734743;8770.91229087701;8815.118488151262;8828.205461508494;8856.822863542693;8930.19628233462;8915.643374264957;8926.152015558642;8939.73180804577;9062.546872656341;9093.40892841963;5636.577256705764;6855.691493882788;6902.344277293649;6913.827154321182;6946.826329341807;1582.4619629325855;1857.4056301983235;1877.239717914247;1882.1059996501551;1893.7916829148783;899.8110396816611;920.9915142918494;924.0436148586181;944.6363150187227;999.8000399920045;22696;23381.064757409513;23400.297991059953;23424.882875585514;23492.7650723494;955.2167222877313;979.4778445502859;981.8625392445064;1016.6289304403987;1044.4934206909643;11610.187286890006;11984.981276591412;12205.633830985085;12239.510419583296;12362.629121126382;244197;244346;246836;286754;642320;125661;127628;130353.34823326013;130365;131392;1002.2182697495965;1018.5365658625308;1033.9069483746348;1046.419237323293;1048.2819268800895;14656.633584160481;19875.900620496806;20035;20062.49843753918;20220.292289769786;52861.7356913213;55081;55178;55307.72346138243;57522.42477575338;62476;80479.59760201162;81625;88776.66834997351;93562.53218733863;7932.484388514728;8178.836423271382;8355.874661879956;8552;8572.52851093196;11301;13267.933660332023;13468;13612.727745445234;13751.312434378042;9611.375260608038;11514.712132196762;11651.88348116508;11811.291322520676;11869.169158159191;11398.430078495876;11486.597969071043;11526.769464610828;11745.941270293593;11793.29240245588;11711.472983715583;11747.353895535827;11768.411579421167;11868.287902725864;11927.343996080299;8104.513729176032;8259.793505162419;8345.499270043816;8398.790030249293;8506.61720222579;9962.701118966443;10712.303700259457;11697.122715796178;11846.407679616157;11869.931706146488 18:42:42 INFO - PROCESS | 1666 | |3;mootools.html;1353.9390727417265;1461.0722191408456;1502.8271748748898;1755.3856150347372;1919.9136038878241;7695.230476952302;8555.743327700171;8795.076516965722;8812.250958668521;8901.777455563613;8525.062243153263;8650.48097114172;8735.606897689604;8737.344699147558;8749.21257086862;2296.4603318220247;2318;2323.5585238804656;2326.999390262187;2327.56939966106;1927.4699457649187;2284.680144779732;2323.7908588227056;2329.8835058247105;2341.929742107731;2277.4761804784825;2300.2869110575693;2306.411864974429;2330.2193765088714;2348.506813569144;2284.4060544258446;2297.632378819381;2305.6656784766283;2306.5271619318;2317.0615900560215;2293.495431005176;2294.6328587426096;2295.01314434793;2299.9195028173935;2301.746807851135;8660.307175426015;8680.30557555394;8701.12925720973;8774.517401542913;8794.164554367326;5175.171972484384;5369.275147855029;5369.328833895763;5379.892402151935;5384.91922621161;3163.9400800731783;3487.616362200156;3542.3446662367546;3599.262151258986;3617.801020943847;1063.8191507443753;1072.254782925867;1072.3673032910542;1073.6510634043889;1084.614961688597;11547.76904461906;11689.941550292195;11693.532258709642;11697.94151029248;11714.414279286002;4320.805563749639;4324.13517296542;4526.479454862667;4528.637708983273;4532.365468834366;9121.77195570116;9126.680566180152;9132.954335228282;9162.770930726785;9182.77043073915;5171.456997015334;5172.870678233075;5175.094358487249;5176.948230517722;5181.766820493087;3903.8633647822758;4043.211573743092;4244.38456423823;4364.388985542027;4844.563989240985;3715.64701353371;3771.6228377162615;3792.2984247914223;3810.466534685146;3834.328992426314;1137.5051852444212;1142.9371384573762;1152.072581571826;1160.2400427719856;1161.5411912294765;821.6713314674179;858.7767180532982;873.6811063961735;881.070470653454;992.4144754594823;5825.1941898011755;5886.705664716833;5984.162217289583;5999.400059993965;6085.513158947274;948.2793077261331;967.8548217767391;979.8138353712772;1008.3798463944768;1010.8180527505119;3906.570277269498;4029.6171863672903;4066.1461093170765;4146.688998325138;4152.958470415258;9126.634934602675;10265.435401053013;10603.045725884707;10727.731806704895;10754.978277063667;8839.823203536022;8993.820123597492;10684.465776711133;10710.03609675133;10823.83764243537;8045;8178.46839955401;8342.499450033018;8355.707550235713;8360.372972027122;5927;5962.940370596239;6022.217111775616;6030.095485677008;6080.513558915364;10098.697039088838;10117.747056323651;10166.491675416348;10167.542460589439;10178.949105254427;9806.166475849634;10076.647317343857;10339.896601033894;10376.792464150825;10381.325213861075;7110.217876033529;7168.2831716827895;7249.963750181215;7269.636518173965;7271.781846544613;7717.884231736416;8022.719204827803;8038.55787931646;8302.958485207535;8395.370347223861;7277.126744790659;7357.521761085726;7378.852422951403;7485.139208991036;7488.363489103487;6930.203026652;7084.362407383154;7099.680514376969;7152.570845749272;7233.746818861315;6952.756653517103;7018.5788852669;7070.7525236616475;7091.361777440055;7105.893411598933;4888.682235654671;4898.730569818552;4906.190478570996;4983.825566105169;4987.177115775857;4981.252812078217;5024.196128619404;5032.949670503248;5046.8485945420225;5064.34163558735 18:42:42 INFO - PROCESS | 1666 | |4;prototype.html;306.9739072178865;307.5816889030919;320.3129287677931;326.37336314276587;328.02739876266867;4566.611837993766;5040.177500599667;5238.371395432553;5289.677580604849;5348.73256337183;4764.78558464869;4904.092742842577;4941.812530917565;5140.172904902308;5175.948240517594;3937.645611894929;3962.286788378091;3968.9206215875665;3986.4618276532588;3998.2403343364667;3869.1101046759263;3991.6806655467494;4015.558288588253;4031.8588849390276;4043.009462681647;3960.4059391091278;3982.9203415931665;3984.9203015939665;3991.2616166009234;4015.277250094982;3969.0672691917375;3979.5622481527153;3986.5016872890887;3988.541317748467;3990.760554366718;2898.68114507404;3489.5114683944266;3511.85864594008;3520.366334059868;3526.717862571014;4938.185199442088;5046.495350464961;5083.440821509631;5102.693838369672;5107;4542.818287268506;4543.954560454386;4558.247889098295;4572.582499425189;4574.794134263966;4504.707194032378;5415.458454154593;5432.565394768409;5432.91850622241;5467.293689623622;3491.1970246843116;3812.3519001769764;3816.751911125768;3819.140693344003;3824.0822202671156;5708.857278568027;5709.343425506078;5710.2576665033275;5761;5774.902768473977;3807.8766763804742;3819.1979684266616;3820.1977584706965;3833.6166383361997;3841.9242612068665;3761.8307176177136;3801.1827457096856;3894.3184942634925;3922.2939870823525;3935.0359162005493;4464.901496296736;4477.261251893401;4491.573300536509;4507.72359958219;4532.88667783308;4597.3793537872625;5481;5530.198121272473;5530.34543419161;5535.69911070898;1109.6683979224963;1129.306040938592;1228.7726770547476;1272.7717752369008;1286.4725462560493;869.1569177897429;883.081595141059;896.4128495835238;900.7522931193975;910.3127139010005;4085.3871919212356;4644.930326045112;4783.95216047842;5048.419431765321;5073.720945347967;4776.498467660915;4876.195807551228;5566.805161819398;5599.832005039855;5641.605087643826;4553.704009239389;4963.156263435225;4988;5015.22264049073;5023.2214006829;2111.9049642765804;2291.3126062181277;2395.5448464791634;2417.6373543968543;2437.695288088989;4799.232122860326;4800.95199048012;4810.6632535722865;4869.318295438641;4888.52914430751;4113.506379234511;4188.560201178893;4337.110892267077;4499.550044995474;4802.6638135330195;3448.1380054770643;4582.73974656972;4610.815567377402;4843.782029808667;4872.707637541759;4223.21870453967;4317.897996902892;4680.812767489262;4796.352492413619;4809.470958194665;4124.566920473427;4597.356370108255;4617.2916021072415;4637.25803871379;4651.465081515669;4824.793801549613;5182.429932707475;5833.062682689253;5878.265216847894;5902.468777810018;3973.9071755267532;3980.2238563479846;3990.3615421532418;3992.261431635157;3992.9600703992587;5366.356037275552;5644.887102258014;5658.660480371026;5663.292088488939;5667.518260947701;4849.854504364875;5065.189569668835;5292.834751677833;5529.225908372911;5599.748011339581;5519.537322609592;5526.535468100876;5534.3673616284095;5547.805826796042;5553;4516.16450956574;4952.405711314521;5182.870428239174;5294.338207724035;5404.135338345845;4738.407699037621;5465.349305586867;5480.835574932758;5495.395506494203;5532.197831314517;4506.391637129077;4798.8884890648005;5372.113601255905;5387.138057910872;5517.420670829505 18:42:42 INFO - PROCESS | 1666 | |5;yui.html;778.0430071012651;786.7285786403693;821.7534739578126;832.2052439919873;855.7946092937694;15100.848991510082;16562.58593535162;16606.667866642674;17536.473905782816;18349.357772477964;17131.57171070721;17183.312667493316;17283.30866765328;17336.479905602853;17585.56036099095;713.4399496395331;741.1958025542266;898.9685361012366;913.3880300198882;916.3219217778862;728.1844334345514;731.9011933389004;733.8495608400292;736.7016358374867;880.0143838900441;964.1419136968104;965.3001573858932;965.5751469353462;966.912977831995;971.3346357744967;940.463935556733;951.9190868776162;956.3210120814231;959.1128206409079;959.9616015359447;552.1662289942216;695.2734392559737;716.9103862017248;718.4755128755985;718.9101362329709;15614;15645.921770391189;15652.92173539125;15665.765013524806;15668.059916404938;13399.598012059654;13698.452061917511;13827.930860345734;13875.722485550232;14060.816681146829;11027.386322807308;12638.873611263862;12916.354182290848;12976.351182440934;13493.292053663543;4624;4652.651051171176;4692.401446582368;4811.518848115161;4829.468758436569;109901.35147972786;112893;114059;114805;116412;10930.289531180606;11062.446877656246;11118.221724479208;11225.66319045154;11496.885031149748;21750.782492175193;21793;21793.67309490359;21797.455063623536;21828.672569911465;7969.641366138538;8004.559749213733;8035.397345199133;8062.798430039179;8243.05204901444;4482.8655140345845;4486.394336764495;4506.639468842484;4522.570355816192;4679.555442232982;3571.8749843755345;3691.4093745000673;3692.5753538343433;3694.8706795262574;3698.3712768829364;673.2325149329768;680.5304340005381;680.938715515606;692.1382878316529;693.6947742993067;620.6214209332304;627.5002743443174;636.5448704176443;649.9415052645285;653.5686446944993;8809.823803523894;8833.955830220808;8915.242204412569;8989.595468203946;9005.369624126379;606.6087373643975;637.5537124013209;639.389383139101;649.1496140056541;662.0995446193269;4270.850520231839;4278.914421711548;4323.329883868006;4347.108842687241;4439.1467381856755;135005;135267;137792.31103844618;150201.24899375433;156610;105562.47218763857;131974;132705;133023;134337;110592;114934;115720.8427915727;116392.41803791096;118549;8749.950005999066;9078.273738100805;9313.953430232805;9769.56036978352;9784.070513301225;47351.52648473609;63990.360096400305;64865;66117.66941165263;66451.33871653247;84776.57611711902;85348;89283.55358223167;93709.5314523423;94993;12829.42267597979;13155.802662960255;13277.601671949857;13293.468261269441;13800.861991379958;14260.073095248776;14467.78298325547;14585.781213282022;14691.85308146905;15129.697406052037;13414.798778018532;13759.17444953306;13829.377678004716;14258.215798131203;14314.785278220626;13429.529966451128;13640.590782276548;13653.177110409102;13702.86297137016;13714;13057.236385279162;13223.404946777226;13276.53532126371;13372.465101395836;13489.865101349253;9331.580078896603;10017.14854237398;11002.174836887105;11044.564206653084;11216.607418740305;10870.347779133277;11201.775964480828;11317.434128293717;11408.828867566826;11499.885001150216 18:42:42 INFO - PROCESS | 1666 | __end_tp_report 18:42:42 INFO - PROCESS | 1666 | __start_cc_report 18:42:42 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1377 18:42:42 INFO - PROCESS | 1666 | __end_cc_report 18:42:42 INFO - PROCESS | 1666 | __startTimestamp1468374162378__endTimestamp 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | ------- Summary: start ------- 18:42:42 INFO - PROCESS | 1666 | Number of tests: 6 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5681.02 Median:5904.35 stddev:669.13 (11.3%) stddev-sans-first:644.18 18:42:42 INFO - PROCESS | 1666 | Values: 3282.5 3346.4 3349.7 3353.4 3425.9 5529.8 5607.8 5616.2 5666.2 5690.9 5617.7 5631.2 5706.5 5739.5 5739.7 4462.1 5069.4 5110.9 5119.5 5228.1 5169.5 5214.2 5216.6 5223.9 5225.7 4267.5 5076.3 5094.2 5108.8 5177.8 5085.0 5111.7 5129.5 5129.7 5157.6 5082.8 5137.1 5153.1 5181.0 5200.5 4613.2 5508.0 5682.7 5701.2 5731.6 6184.1 6185.4 6188.3 6215.9 6219.3 6277.9 6300.9 6307.0 6313.1 6313.7 4870.6 5632.7 5706.7 5781.8 5785.9 6237.2 6238.2 6241.4 6247.1 6247.9 5930.5 6122.7 6129.7 6138.9 6142.6 6113.9 6152.2 6207.7 6214.6 6285.2 6151.3 6177.5 6203.8 6207.7 6215.3 6085.8 6182.7 6202.9 6263.8 6275.0 4821.6 4825.7 4843.6 4861.7 4863.0 4370.3 4378.6 4386.9 4403.8 4416.0 5546.4 5687.9 5717.4 5723.3 5753.4 6145.5 6162.2 6194.2 6235.8 6311.2 5702.6 5725.0 5733.3 5740.3 5767.9 5219.1 5378.9 5388.7 5396.9 5410.6 6203.7 6236.1 6249.3 6253.1 6327.4 6236.4 6259.1 6288.8 6294.4 6303.8 6242.5 6256.0 6274.3 6288.3 6307.7 6065.4 6077.7 6121.9 6124.0 6172.8 4737.3 6043.5 6233.4 6244.0 6265.1 5857.5 6074.2 6082.4 6088.9 6110.9 5914.2 5983.5 6027.0 6072.1 6101.1 5904.4 5954.6 5957.5 5963.6 5995.0 5819.7 6080.3 6132.1 6132.8 6143.8 5738.2 5822.7 5832.2 5875.3 5915.2 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:77933.62 Median:38715.90 stddev:174192.01 (449.9%) stddev-sans-first:174583.66 18:42:42 INFO - PROCESS | 1666 | Values: 507.0 512.6 542.6 545.2 551.7 30375.7 30964.4 41147.6 42256.6 42470.0 41918.4 44646.2 44926.0 44965.6 45243.0 9549.9 9731.3 9738.8 9770.3 9791.2 8743.1 9583.8 11878.4 11897.2 12169.1 11918.6 12022.0 12027.9 12028.4 12031.2 11893.0 11981.8 11984.0 11985.7 11998.0 11858.5 11867.3 11937.9 11947.3 11953.2 41713.0 42038.0 42065.8 42085.9 42112.6 3549.2 3562.5 3573.3 3635.3 3701.0 31782.7 31944.2 32372.5 32970.0 33132.0 3238.6 3263.2 3303.9 3307.3 3347.1 547351.0 548325.0 548604.0 548749.0 549439.5 60863.4 62014.7 62061.7 62230.4 62494.0 65582.7 65612.7 65719.0 65805.3 65901.0 16511.4 16998.9 17020.7 17021.4 17039.5 11930.3 12056.5 13057.2 13132.4 13135.8 16732.0 16962.9 17011.4 17339.5 17532.7 6239.4 6976.2 7026.1 7105.7 7124.9 832.9 893.6 980.1 993.0 1055.2 30584.5 31040.0 31064.4 31534.8 31960.5 1028.7 1050.2 1087.9 1104.8 1147.8 16309.3 16678.7 16737.4 16746.3 17208.0 714048.0 714616.0 715453.0 719373.0 720014.0 59879.0 61511.7 61549.8 61625.1 61768.1 1235.2 1297.0 1383.5 1412.5 1427.4 29847.1 30194.8 31978.8 32041.8 32867.5 54056.5 54473.5 54997.0 55119.7 55180.7 664563.0 676165.0 676788.0 677157.0 678634.0 37311.8 37812.8 37821.0 39093.0 43281.7 41671.0 48109.8 48733.5 49713.8 50129.0 40405.2 40407.6 40714.2 41436.0 41691.8 38439.8 39579.8 39668.0 40569.3 40723.0 38653.8 38778.0 39348.4 39597.0 39631.6 32523.5 32937.7 33944.0 34947.3 35223.5 21583.6 25353.0 25930.4 25968.0 26358.0 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:28699.34 Median:23458.82 stddev:65541.31 (279.4%) stddev-sans-first:65690.61 18:42:42 INFO - PROCESS | 1666 | Values: 350.6 373.7 377.6 380.3 402.5 15623.1 16568.1 21448.5 21728.7 21757.7 20871.4 21026.0 21675.9 21793.6 22976.5 5237.6 5896.4 6141.5 6145.5 6150.2 6035.8 6083.3 6109.0 6136.0 6138.2 5815.0 5921.2 5924.5 5928.5 5938.7 5772.9 5920.5 5967.0 5976.9 5984.8 5220.8 5250.2 5254.0 5261.9 5263.2 22387.6 27119.0 27287.6 27306.5 27559.9 2292.3 2440.5 2502.0 2535.1 2862.0 15452.8 16271.9 16316.0 16367.9 16661.9 1872.1 1890.5 1894.5 1935.2 1940.0 130681.3 130925.0 133379.0 133462.0 133900.3 10962.3 11078.9 11318.8 11654.8 11734.9 13927.6 14056.2 14067.9 14078.3 14127.2 8770.9 8815.1 8828.2 8856.8 8930.2 8915.6 8926.2 8939.7 9062.5 9093.4 5636.6 6855.7 6902.3 6913.8 6946.8 1582.5 1857.4 1877.2 1882.1 1893.8 899.8 921.0 924.0 944.6 999.8 22696.0 23381.1 23400.3 23424.9 23492.8 955.2 979.5 981.9 1016.6 1044.5 11610.2 11985.0 12205.6 12239.5 12362.6 244197.0 244346.0 246836.0 286754.0 642320.0 125661.0 127628.0 130353.3 130365.0 131392.0 1002.2 1018.5 1033.9 1046.4 1048.3 14656.6 19875.9 20035.0 20062.5 20220.3 52861.7 55081.0 55178.0 55307.7 57522.4 62476.0 80479.6 81625.0 88776.7 93562.5 7932.5 8178.8 8355.9 8552.0 8572.5 11301.0 13267.9 13468.0 13612.7 13751.3 9611.4 11514.7 11651.9 11811.3 11869.2 11398.4 11486.6 11526.8 11745.9 11793.3 11711.5 11747.4 11768.4 11868.3 11927.3 8104.5 8259.8 8345.5 8398.8 8506.6 9962.7 10712.3 11697.1 11846.4 11869.9 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5616.09 Median:4943.72 stddev:3148.48 (63.7%) stddev-sans-first:3141.01 18:42:42 INFO - PROCESS | 1666 | Values: 1353.9 1461.1 1502.8 1755.4 1919.9 7695.2 8555.7 8795.1 8812.3 8901.8 8525.1 8650.5 8735.6 8737.3 8749.2 2296.5 2318.0 2323.6 2327.0 2327.6 1927.5 2284.7 2323.8 2329.9 2341.9 2277.5 2300.3 2306.4 2330.2 2348.5 2284.4 2297.6 2305.7 2306.5 2317.1 2293.5 2294.6 2295.0 2299.9 2301.7 8660.3 8680.3 8701.1 8774.5 8794.2 5175.2 5369.3 5369.3 5379.9 5384.9 3163.9 3487.6 3542.3 3599.3 3617.8 1063.8 1072.3 1072.4 1073.7 1084.6 11547.8 11689.9 11693.5 11697.9 11714.4 4320.8 4324.1 4526.5 4528.6 4532.4 9121.8 9126.7 9133.0 9162.8 9182.8 5171.5 5172.9 5175.1 5176.9 5181.8 3903.9 4043.2 4244.4 4364.4 4844.6 3715.6 3771.6 3792.3 3810.5 3834.3 1137.5 1142.9 1152.1 1160.2 1161.5 821.7 858.8 873.7 881.1 992.4 5825.2 5886.7 5984.2 5999.4 6085.5 948.3 967.9 979.8 1008.4 1010.8 3906.6 4029.6 4066.1 4146.7 4153.0 9126.6 10265.4 10603.0 10727.7 10755.0 8839.8 8993.8 10684.5 10710.0 10823.8 8045.0 8178.5 8342.5 8355.7 8360.4 5927.0 5962.9 6022.2 6030.1 6080.5 10098.7 10117.7 10166.5 10167.5 10178.9 9806.2 10076.6 10339.9 10376.8 10381.3 7110.2 7168.3 7250.0 7269.6 7271.8 7717.9 8022.7 8038.6 8303.0 8395.4 7277.1 7357.5 7378.9 7485.1 7488.4 6930.2 7084.4 7099.7 7152.6 7233.7 6952.8 7018.6 7070.8 7091.4 7105.9 4888.7 4898.7 4906.2 4983.8 4987.2 4981.3 5024.2 5032.9 5046.8 5064.3 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4310.32 Median:4648.20 stddev:1301.37 (28.0%) stddev-sans-first:1269.86 18:42:42 INFO - PROCESS | 1666 | Values: 307.0 307.6 320.3 326.4 328.0 4566.6 5040.2 5238.4 5289.7 5348.7 4764.8 4904.1 4941.8 5140.2 5175.9 3937.6 3962.3 3968.9 3986.5 3998.2 3869.1 3991.7 4015.6 4031.9 4043.0 3960.4 3982.9 3984.9 3991.3 4015.3 3969.1 3979.6 3986.5 3988.5 3990.8 2898.7 3489.5 3511.9 3520.4 3526.7 4938.2 5046.5 5083.4 5102.7 5107.0 4542.8 4544.0 4558.2 4572.6 4574.8 4504.7 5415.5 5432.6 5432.9 5467.3 3491.2 3812.4 3816.8 3819.1 3824.1 5708.9 5709.3 5710.3 5761.0 5774.9 3807.9 3819.2 3820.2 3833.6 3841.9 3761.8 3801.2 3894.3 3922.3 3935.0 4464.9 4477.3 4491.6 4507.7 4532.9 4597.4 5481.0 5530.2 5530.3 5535.7 1109.7 1129.3 1228.8 1272.8 1286.5 869.2 883.1 896.4 900.8 910.3 4085.4 4644.9 4784.0 5048.4 5073.7 4776.5 4876.2 5566.8 5599.8 5641.6 4553.7 4963.2 4988.0 5015.2 5023.2 2111.9 2291.3 2395.5 2417.6 2437.7 4799.2 4801.0 4810.7 4869.3 4888.5 4113.5 4188.6 4337.1 4499.6 4802.7 3448.1 4582.7 4610.8 4843.8 4872.7 4223.2 4317.9 4680.8 4796.4 4809.5 4124.6 4597.4 4617.3 4637.3 4651.5 4824.8 5182.4 5833.1 5878.3 5902.5 3973.9 3980.2 3990.4 3992.3 3993.0 5366.4 5644.9 5658.7 5663.3 5667.5 4849.9 5065.2 5292.8 5529.2 5599.7 5519.5 5526.5 5534.4 5547.8 5553.0 4516.2 4952.4 5182.9 5294.3 5404.1 4738.4 5465.3 5480.8 5495.4 5532.2 4506.4 4798.9 5372.1 5387.1 5517.4 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:25025.18 Median:3691.99 stddev:39461.04 (1068.8%) stddev-sans-first:39529.74 18:42:42 INFO - PROCESS | 1666 | Values: 778.0 786.7 821.8 832.2 855.8 15100.8 16562.6 16606.7 17536.5 18349.4 17131.6 17183.3 17283.3 17336.5 17585.6 713.4 741.2 899.0 913.4 916.3 728.2 731.9 733.8 736.7 880.0 964.1 965.3 965.6 966.9 971.3 940.5 951.9 956.3 959.1 960.0 552.2 695.3 716.9 718.5 718.9 15614.0 15645.9 15652.9 15665.8 15668.1 13399.6 13698.5 13827.9 13875.7 14060.8 11027.4 12638.9 12916.4 12976.4 13493.3 4624.0 4652.7 4692.4 4811.5 4829.5 109901.4 112893.0 114059.0 114805.0 116412.0 10930.3 11062.4 11118.2 11225.7 11496.9 21750.8 21793.0 21793.7 21797.5 21828.7 7969.6 8004.6 8035.4 8062.8 8243.1 4482.9 4486.4 4506.6 4522.6 4679.6 3571.9 3691.4 3692.6 3694.9 3698.4 673.2 680.5 680.9 692.1 693.7 620.6 627.5 636.5 649.9 653.6 8809.8 8834.0 8915.2 8989.6 9005.4 606.6 637.6 639.4 649.1 662.1 4270.9 4278.9 4323.3 4347.1 4439.1 135005.0 135267.0 137792.3 150201.2 156610.0 105562.5 131974.0 132705.0 133023.0 134337.0 110592.0 114934.0 115720.8 116392.4 118549.0 8750.0 9078.3 9314.0 9769.6 9784.1 47351.5 63990.4 64865.0 66117.7 66451.3 84776.6 85348.0 89283.6 93709.5 94993.0 12829.4 13155.8 13277.6 13293.5 13800.9 14260.1 14467.8 14585.8 14691.9 15129.7 13414.8 13759.2 13829.4 14258.2 14314.8 13429.5 13640.6 13653.2 13702.9 13714.0 13057.2 13223.4 13276.5 13372.5 13489.9 9331.6 10017.1 11002.2 11044.6 11216.6 10870.3 11201.8 11317.4 11408.8 11499.9 18:42:42 INFO - PROCESS | 1666 | -------- Summary: end -------- 18:42:42 INFO - PROCESS | 1666 | 18:42:42 INFO - TEST-INFO | 1666: exit 0 18:42:42 INFO - TEST-OK | dromaeo_css | took 1116030ms 18:42:42 INFO - TEST-START | kraken 18:42:42 INFO - operating with platform_type : mac_ 18:42:42 INFO - Initialising browser for kraken test... 18:42:42 INFO - TEST-INFO | started process 1787 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp_Bv5p6/profile http://localhost:49271/getInfo.html) 18:42:45 INFO - PROCESS | 1787 | __metrics Screen width/height:1600/1200 18:42:45 INFO - PROCESS | 1787 | colorDepth:24 18:42:45 INFO - PROCESS | 1787 | Browser inner width/height: 1024/689 18:42:45 INFO - PROCESS | 1787 | __metrics 18:42:45 INFO - PROCESS | 1787 | 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" 18:42:45 INFO - PROCESS | 1787 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:42:45 INFO - TEST-INFO | 1787: exit 0 18:42:45 INFO - Browser initialized. 18:42:45 INFO - Running cycle 1/1 for kraken test... 18:42:45 INFO - TEST-INFO | started process 1789 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp_Bv5p6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:58 INFO - PROCESS | 1789 | RSS: Main: 243826688 18:42:58 INFO - PROCESS | 1789 | 18:43:00 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:01 INFO - PROCESS | 1789 | RSS: Main: 294719488 18:43:01 INFO - PROCESS | 1789 | 18:43:04 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 18:43:05 INFO - PROCESS | 1789 | RSS: Main: 304959488 18:43:05 INFO - PROCESS | 1789 | 18:43:08 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 18:43:09 INFO - PROCESS | 1789 | RSS: Main: 387776512 18:43:09 INFO - PROCESS | 1789 | 18:43:11 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 18:43:12 INFO - PROCESS | 1789 | RSS: Main: 289316864 18:43:12 INFO - PROCESS | 1789 | 18:43:14 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:43:14 INFO - PROCESS | 1789 | RSS: Main: 292909056 18:43:14 INFO - PROCESS | 1789 | 18:43:17 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 18:43:18 INFO - PROCESS | 1789 | RSS: Main: 329908224 18:43:18 INFO - PROCESS | 1789 | 18:43:21 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 18:43:21 INFO - PROCESS | 1789 | RSS: Main: 331038720 18:43:21 INFO - PROCESS | 1789 | 18:43:24 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 18:43:25 INFO - PROCESS | 1789 | RSS: Main: 331911168 18:43:25 INFO - PROCESS | 1789 | 18:43:26 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:43:27 INFO - PROCESS | 1789 | RSS: Main: 312221696 18:43:27 INFO - PROCESS | 1789 | 18:43:29 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:43:29 INFO - PROCESS | 1789 | RSS: Main: 318234624 18:43:29 INFO - PROCESS | 1789 | 18:43:31 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:43:32 INFO - PROCESS | 1789 | RSS: Main: 320483328 18:43:32 INFO - PROCESS | 1789 | 18:43:35 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:43:36 INFO - PROCESS | 1789 | RSS: Main: 326045696 18:43:36 INFO - PROCESS | 1789 | 18:43:39 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:43:39 INFO - PROCESS | 1789 | RSS: Main: 328761344 18:43:39 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 18:43:41 INFO - PROCESS | 1789 | RSS: Main: 372207616 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | __start_tp_report 18:43:41 INFO - PROCESS | 1789 | _x_x_mozilla_page_load 18:43:41 INFO - PROCESS | 1789 | _x_x_mozilla_page_load_details 18:43:41 INFO - PROCESS | 1789 | |i|pagename|runs| 18:43:41 INFO - PROCESS | 1789 | |0;ai-astar;100;111;112;110;112;111;111;110;112;118 18:43:41 INFO - PROCESS | 1789 | |1;audio-beat-detection;141;107;107;159;108;106;126;106;141;107 18:43:41 INFO - PROCESS | 1789 | |2;audio-dft;182;185;186;180;185;183;185;182;182;184 18:43:41 INFO - PROCESS | 1789 | |3;audio-fft;78;76;48;111;81;82;88;77;83;57 18:43:41 INFO - PROCESS | 1789 | |4;audio-oscillator;83;92;93;71;72;68;97;70;68;103 18:43:41 INFO - PROCESS | 1789 | |5;imaging-gaussian-blur;93;131;86;84;87;84;87;84;87;84 18:43:41 INFO - PROCESS | 1789 | |6;imaging-darkroom;92;92;109;151;92;93;92;93;92;92 18:43:41 INFO - PROCESS | 1789 | |7;imaging-desaturate;85;89;85;87;82;85;86;87;85;83 18:43:41 INFO - PROCESS | 1789 | |8;json-parse-financial;55;52;52;54;53;53;56;53;54;52 18:43:41 INFO - PROCESS | 1789 | |9;json-stringify-tinderbox;70;71;112;74;71;71;70;72;72;72 18:43:41 INFO - PROCESS | 1789 | |10;stanford-crypto-aes;84;81;83;82;84;82;83;85;87;79 18:43:41 INFO - PROCESS | 1789 | |11;stanford-crypto-ccm;136;146;145;145;125;123;135;134;248;136 18:43:41 INFO - PROCESS | 1789 | |12;stanford-crypto-pbkdf2;164;162;163;162;163;161;162;161;161;162 18:43:41 INFO - PROCESS | 1789 | |13;stanford-crypto-sha256-iterative;67;66;68;78;82;84;83;83;66;66 18:43:41 INFO - PROCESS | 1789 | __end_tp_report 18:43:41 INFO - PROCESS | 1789 | __start_cc_report 18:43:41 INFO - PROCESS | 1789 | _x_x_mozilla_cycle_collect,2060 18:43:41 INFO - PROCESS | 1789 | __end_cc_report 18:43:41 INFO - PROCESS | 1789 | __startTimestamp1468374221779__endTimestamp 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | ------- Summary: start ------- 18:43:41 INFO - PROCESS | 1789 | Number of tests: 14 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:4.40 (3.9%) stddev-sans-first:2.42 18:43:41 INFO - PROCESS | 1789 | Values: 100.0 111.0 112.0 110.0 112.0 111.0 111.0 110.0 112.0 118.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:117.00 stddev:19.65 (16.8%) stddev-sans-first:19.44 18:43:41 INFO - PROCESS | 1789 | Values: 141.0 107.0 107.0 159.0 108.0 106.0 126.0 106.0 141.0 107.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:1.90 (1.0%) stddev-sans-first:1.94 18:43:41 INFO - PROCESS | 1789 | Values: 182.0 185.0 186.0 180.0 185.0 183.0 185.0 182.0 182.0 184.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#3] audio-fft Cycles:10 Average:78.10 Median:79.50 stddev:16.95 (21.3%) stddev-sans-first:17.98 18:43:41 INFO - PROCESS | 1789 | Values: 78.0 76.0 48.0 111.0 81.0 82.0 88.0 77.0 83.0 57.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:77.50 stddev:13.52 (17.4%) stddev-sans-first:14.33 18:43:41 INFO - PROCESS | 1789 | Values: 83.0 92.0 93.0 71.0 72.0 68.0 97.0 70.0 68.0 103.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:86.50 stddev:14.42 (16.7%) stddev-sans-first:15.27 18:43:41 INFO - PROCESS | 1789 | Values: 93.0 131.0 86.0 84.0 87.0 84.0 87.0 84.0 87.0 84.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:92.00 stddev:18.75 (20.4%) stddev-sans-first:19.67 18:43:41 INFO - PROCESS | 1789 | Values: 92.0 92.0 109.0 151.0 92.0 93.0 92.0 93.0 92.0 92.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:2.01 (2.4%) stddev-sans-first:2.13 18:43:41 INFO - PROCESS | 1789 | Values: 85.0 89.0 85.0 87.0 82.0 85.0 86.0 87.0 85.0 83.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.35 (2.5%) stddev-sans-first:1.30 18:43:41 INFO - PROCESS | 1789 | Values: 55.0 52.0 52.0 54.0 53.0 53.0 56.0 53.0 54.0 52.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#9] json-stringify-tinderbox Cycles:10 Average:75.50 Median:71.50 stddev:12.88 (18.0%) stddev-sans-first:13.50 18:43:41 INFO - PROCESS | 1789 | Values: 70.0 71.0 112.0 74.0 71.0 71.0 70.0 72.0 72.0 72.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:2.21 (2.6%) stddev-sans-first:2.32 18:43:41 INFO - PROCESS | 1789 | Values: 84.0 81.0 83.0 82.0 84.0 82.0 83.0 85.0 87.0 79.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:140.50 stddev:36.25 (25.8%) stddev-sans-first:38.21 18:43:41 INFO - PROCESS | 1789 | Values: 136.0 146.0 145.0 145.0 125.0 123.0 135.0 134.0 248.0 136.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:0.78 18:43:41 INFO - PROCESS | 1789 | Values: 164.0 162.0 163.0 162.0 163.0 161.0 162.0 161.0 161.0 162.0 18:43:41 INFO - PROCESS | 1789 | 18:43:41 INFO - PROCESS | 1789 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:80.00 stddev:8.29 (10.4%) stddev-sans-first:8.36 18:43:41 INFO - PROCESS | 1789 | Values: 67.0 66.0 68.0 78.0 82.0 84.0 83.0 83.0 66.0 66.0 18:43:41 INFO - PROCESS | 1789 | -------- Summary: end -------- 18:43:41 INFO - PROCESS | 1789 | 18:43:42 INFO - TEST-INFO | 1789: exit 0 18:43:42 INFO - TEST-OK | kraken | took 59661ms 18:43:42 INFO - SUITE-END | took 1175s 18:43:42 INFO - Completed test suite (00:19:35) 18:43:42 INFO - javascript benchmark 18:43:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.5404443377925, 3346.431106711859, 3349.715274201692, 3353.3628610563974, 3425.862965481381, 5529.778808847651, 5607.803726869561, 5616.241807356006, 5666.235058267138, 5690.9146362804595, 5617.747201375938, 5631.211630371741, 5706.486416222539, 5739.454751798583, 5739.655620662753, 4462.085272519126, 5069.391672999245, 5110.948890511085, 5119.539241468267, 5228.058949389108, 5169.48305169482, 5214.191800270964, 5216.556592689626, 5223.895522089556, 5225.686458812484, 4267.466566679165, 5076.289319495255, 5094.184930411154, 5108.846734597968, 5177.844664660066, 5085.008423357447, 5111.718855462948, 5129.461406552333, 5129.666571672867, 5157.58739300855, 5082.822101226477, 5137.12668846297, 5153.072446959583, 5181.0, 5200.5059519345605, 4613.21575332191, 5508.03609368359, 5682.715864206773, 5701.2018317435595, 5731.598788084794, 6184.07238914162, 6185.41238582334, 6188.319284878705, 6215.937840621581, 6219.2847822500535, 6277.905831412532, 6300.87398252037, 6306.9684651576445, 6313.084602732624, 6313.71588278524, 4870.634702397334, 5632.71836408182, 5706.743196556165, 5781.82654520365, 5785.913211301834, 6237.189165408558, 6238.157848690459, 6241.407066328691, 6247.09417134522, 6247.875042499125, 5930.466258036798, 6122.693865306717, 6129.678576603484, 6138.938610613836, 6142.6314421134875, 6113.871604717183, 6152.230971128609, 6207.6585787782105, 6214.627122372672, 6285.214348206474, 6151.292601350902, 6177.4749146322165, 6203.751849925952, 6207.689615519296, 6215.34738852423, 6085.786997455068, 6182.69086545671, 6202.906956395657, 6263.843403914848, 6275.0, 4821.590164836029, 4825.662203645781, 4843.588294994965, 4861.683990540603, 4862.9756851216225, 4370.322599996942, 4378.584034516716, 4386.912261754747, 4403.779811009436, 4416.028473735773, 5546.389897111315, 5687.886242275132, 5717.428257174332, 5723.284589426322, 5753.424657534213, 6145.539084568586, 6162.168107305546, 6194.194754681863, 6235.812925612239, 6311.211098612674, 5702.6293290935955, 5725.0, 5733.3406658234835, 5740.339860916049, 5767.884642307215, 5219.138842091088, 5378.865528361822, 5388.703621300866, 5396.892062158735, 5410.648307859977, 6203.689815509207, 6236.095766113797, 6249.25008998923, 6253.1245625613365, 6327.430531252209, 6236.438720515175, 6259.092431597484, 6288.842778930563, 6294.402031806971, 6303.842403939938, 6242.531810114168, 6255.96872015637, 6274.341194174546, 6288.339724328879, 6307.7476900925285, 6065.393460654076, 6077.726502307495, 6121.87979361315, 6124.0, 6172.814815555541, 4737.265723812815, 6043.456088952015, 6233.438990490878, 6244.0, 6265.122882796321, 5857.47282744555, 6074.179985701874, 6082.422169893853, 6088.8782224356155, 6110.877782444415, 5914.172015917689, 5983.491403230774, 6026.969865150646, 6072.14989901423, 6101.084837274444, 5904.350521442552, 5954.553408494467, 5957.49361304294, 5963.642181469126, 5994.970025149846, 5819.6508209507565, 6080.279543954153, 6132.080177995836, 6132.777018057034, 6143.757528502154, 5738.196652468741, 5822.679752613478, 5832.154337621106, 5875.3243377012195, 5915.171875937286], "value": 5637.860318331775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.9949300506994, 512.5694416689981, 542.5605259739611, 545.1849485019893, 551.6607286518787, 30375.69624303759, 30964.38071238574, 41147.588524114784, 42256.57743422573, 42470.0, 41918.37122443158, 44646.2141514339, 44926.0, 44965.55034449654, 45243.0, 9549.904500955006, 9731.270154738422, 9738.756531086745, 9770.267229957746, 9791.16775074116, 8743.081976392483, 9583.808323833518, 11878.406079696024, 11897.167198296123, 12169.087318451107, 11918.642440726791, 12022.0, 12027.939860300687, 12028.398580070962, 12031.157818952634, 11893.0, 11981.760364792699, 11984.0, 11985.700357491045, 11997.980171685418, 11858.466369013415, 11867.347295898722, 11937.94031029848, 11947.283163010161, 11953.22304050234, 41713.0, 42038.0, 42065.78967105145, 42085.94785130366, 42112.57887421117, 3549.2014296783277, 3562.5012498250007, 3573.3032058748554, 3635.345637785224, 3700.9814950925343, 31782.682173178204, 31944.20139496508, 32372.514412283836, 32970.0, 33132.0, 3238.5789847319697, 3263.216827961272, 3303.884364047247, 3307.338532293551, 3347.1130150510135, 547351.0, 548324.999999996, 548604.0, 548749.0, 549439.5280236012, 60863.435242357, 62014.689926550076, 62061.689691551255, 62230.37769622336, 62494.0, 65582.67208663926, 65612.67193664097, 65719.0, 65805.34194658088, 65901.0, 16511.422100226435, 16998.89507182029, 17020.744688829676, 17021.40425085116, 17039.48881533556, 11930.284182949052, 12056.517739290506, 13057.21656700601, 13132.409041593151, 13135.802962955564, 16732.0, 16962.91518542424, 17011.404600838912, 17339.47981560555, 17532.737008944878, 6239.407256310643, 6976.162860456778, 7026.086608740933, 7105.680244389015, 7124.92875071253, 832.854250506159, 893.5710858787818, 980.0836218136066, 993.0119531066634, 1055.1875056206677, 30584.54123188154, 31040.0, 31064.378712425623, 31534.842325788224, 31960.520592191137, 1028.6708253359002, 1050.1861057680205, 1087.9184061195442, 1104.812181929074, 1147.8163493840946, 16309.266083026292, 16678.749818752727, 16737.414190503274, 16746.330146794236, 17207.96752194872, 714048.0, 714616.0, 715453.0, 719373.0, 720014.0, 59879.0, 61511.6924415375, 61549.76900461966, 61625.075623865676, 61768.07347889785, 1235.2218102595486, 1297.0401902592014, 1383.5434306678771, 1412.5338638249352, 1427.421894132878, 29847.104586862428, 30194.84902575473, 31978.84010579932, 32041.839790800896, 32867.50698739569, 54056.459435405144, 54473.45526544842, 54997.0, 55119.72440137774, 55180.724096379265, 664563.0, 676165.0, 676788.0, 677157.0, 678634.0, 37311.81344093262, 37812.81093594514, 37821.0, 39093.0, 43281.727080560704, 41671.0, 48109.75945120392, 48733.5126648729, 49713.751431242614, 50128.997420052125, 40405.19189616133, 40407.59592404156, 40714.18571628492, 41435.96410089651, 41691.79154104331, 38439.807800960814, 39579.80210098931, 39668.0, 40569.348758610686, 40723.0, 38653.806730966164, 38778.0, 39348.40977385284, 39597.01007474836, 39631.61289354859, 32523.51214731828, 32937.67062329442, 33943.98168054962, 34947.30105397929, 35223.47164792479, 21583.597066190647, 25353.0, 25930.35174120662, 25967.961281548527, 26358.0], "value": 21186.363266619584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.60907088596224, 373.7253118957566, 377.5620280474648, 380.2547007864585, 402.5069290119604, 15623.06261624302, 16568.08875511848, 21448.463788405297, 21728.674069888926, 21757.67363489547, 20871.373858784224, 21026.0, 21675.891620541875, 21793.564128717415, 22976.540469190608, 5237.607179461536, 5896.410358964102, 6141.539384546155, 6145.5390845686525, 6150.200473938382, 6035.818925432244, 6083.330833608299, 6109.0, 6136.018237082068, 6138.202033735608, 5815.0, 5921.200637913891, 5924.496417804492, 5928.525717942576, 5938.673372964486, 5772.942270577282, 5920.526357891358, 5967.0, 5976.940230597704, 5984.760609575612, 5220.791168353261, 5250.18622113573, 5254.00173966945, 5261.947380526222, 5263.236830659571, 22387.55224895493, 27119.0, 27287.590686139723, 27306.45387092247, 27559.86220068887, 2292.3008482412856, 2440.45089854783, 2502.0, 2535.1380530619676, 2862.0, 15452.768208476882, 16271.860969732123, 16316.0, 16367.91816040912, 16661.91669041647, 1872.129459801199, 1890.5462688954551, 1894.5453091258137, 1935.2452543508043, 1939.9612007759765, 130681.34659326737, 130924.99999999905, 133379.0, 133462.0, 133900.33049834784, 10962.287451315638, 11078.889211107948, 11318.830217546743, 11654.825177622342, 11734.88265117355, 13927.58217253484, 14056.22690751998, 14067.929660351838, 14078.2960851957, 14127.223002734743, 8770.91229087701, 8815.118488151262, 8828.205461508494, 8856.822863542693, 8930.19628233462, 8915.643374264957, 8926.152015558642, 8939.73180804577, 9062.546872656341, 9093.40892841963, 5636.577256705764, 6855.691493882788, 6902.344277293649, 6913.827154321182, 6946.826329341807, 1582.4619629325855, 1857.4056301983235, 1877.239717914247, 1882.1059996501551, 1893.7916829148783, 899.8110396816611, 920.9915142918494, 924.0436148586181, 944.6363150187227, 999.8000399920045, 22696.0, 23381.064757409513, 23400.297991059953, 23424.882875585514, 23492.7650723494, 955.2167222877313, 979.4778445502859, 981.8625392445064, 1016.6289304403987, 1044.4934206909643, 11610.187286890006, 11984.981276591412, 12205.633830985085, 12239.510419583296, 12362.629121126382, 244197.0, 244346.0, 246836.0, 286754.0, 642320.0, 125661.0, 127628.0, 130353.34823326013, 130365.0, 131392.0, 1002.2182697495965, 1018.5365658625308, 1033.9069483746348, 1046.419237323293, 1048.2819268800895, 14656.633584160481, 19875.900620496806, 20035.0, 20062.49843753918, 20220.292289769786, 52861.7356913213, 55081.0, 55178.0, 55307.72346138243, 57522.42477575338, 62476.0, 80479.59760201162, 81625.0, 88776.66834997351, 93562.53218733863, 7932.484388514728, 8178.836423271382, 8355.874661879956, 8552.0, 8572.52851093196, 11301.0, 13267.933660332023, 13468.0, 13612.727745445234, 13751.312434378042, 9611.375260608038, 11514.712132196762, 11651.88348116508, 11811.291322520676, 11869.169158159191, 11398.430078495876, 11486.597969071043, 11526.769464610828, 11745.941270293593, 11793.29240245588, 11711.472983715583, 11747.353895535827, 11768.411579421167, 11868.287902725864, 11927.343996080299, 8104.513729176032, 8259.793505162419, 8345.499270043816, 8398.790030249293, 8506.61720222579, 9962.701118966443, 10712.303700259457, 11697.122715796178, 11846.407679616157, 11869.931706146488], "value": 9895.951583759726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.9390727417265, 1461.0722191408456, 1502.8271748748898, 1755.3856150347372, 1919.9136038878241, 7695.230476952302, 8555.743327700171, 8795.076516965722, 8812.250958668521, 8901.777455563613, 8525.062243153263, 8650.48097114172, 8735.606897689604, 8737.344699147558, 8749.21257086862, 2296.4603318220247, 2318.0, 2323.5585238804656, 2326.999390262187, 2327.56939966106, 1927.4699457649187, 2284.680144779732, 2323.7908588227056, 2329.8835058247105, 2341.929742107731, 2277.4761804784825, 2300.2869110575693, 2306.411864974429, 2330.2193765088714, 2348.506813569144, 2284.4060544258446, 2297.632378819381, 2305.6656784766283, 2306.5271619318, 2317.0615900560215, 2293.495431005176, 2294.6328587426096, 2295.01314434793, 2299.9195028173935, 2301.746807851135, 8660.307175426015, 8680.30557555394, 8701.12925720973, 8774.517401542913, 8794.164554367326, 5175.171972484384, 5369.275147855029, 5369.328833895763, 5379.892402151935, 5384.91922621161, 3163.9400800731783, 3487.616362200156, 3542.3446662367546, 3599.262151258986, 3617.801020943847, 1063.8191507443753, 1072.254782925867, 1072.3673032910542, 1073.6510634043889, 1084.614961688597, 11547.76904461906, 11689.941550292195, 11693.532258709642, 11697.94151029248, 11714.414279286002, 4320.805563749639, 4324.13517296542, 4526.479454862667, 4528.637708983273, 4532.365468834366, 9121.77195570116, 9126.680566180152, 9132.954335228282, 9162.770930726785, 9182.77043073915, 5171.456997015334, 5172.870678233075, 5175.094358487249, 5176.948230517722, 5181.766820493087, 3903.8633647822758, 4043.211573743092, 4244.38456423823, 4364.388985542027, 4844.563989240985, 3715.64701353371, 3771.6228377162615, 3792.2984247914223, 3810.466534685146, 3834.328992426314, 1137.5051852444212, 1142.9371384573762, 1152.072581571826, 1160.2400427719856, 1161.5411912294765, 821.6713314674179, 858.7767180532982, 873.6811063961735, 881.070470653454, 992.4144754594823, 5825.1941898011755, 5886.705664716833, 5984.162217289583, 5999.400059993965, 6085.513158947274, 948.2793077261331, 967.8548217767391, 979.8138353712772, 1008.3798463944768, 1010.8180527505119, 3906.570277269498, 4029.6171863672903, 4066.1461093170765, 4146.688998325138, 4152.958470415258, 9126.634934602675, 10265.435401053013, 10603.045725884707, 10727.731806704895, 10754.978277063667, 8839.823203536022, 8993.820123597492, 10684.465776711133, 10710.03609675133, 10823.83764243537, 8045.0, 8178.46839955401, 8342.499450033018, 8355.707550235713, 8360.372972027122, 5927.0, 5962.940370596239, 6022.217111775616, 6030.095485677008, 6080.513558915364, 10098.697039088838, 10117.747056323651, 10166.491675416348, 10167.542460589439, 10178.949105254427, 9806.166475849634, 10076.647317343857, 10339.896601033894, 10376.792464150825, 10381.325213861075, 7110.217876033529, 7168.2831716827895, 7249.963750181215, 7269.636518173965, 7271.781846544613, 7717.884231736416, 8022.719204827803, 8038.55787931646, 8302.958485207535, 8395.370347223861, 7277.126744790659, 7357.521761085726, 7378.852422951403, 7485.139208991036, 7488.363489103487, 6930.203026652, 7084.362407383154, 7099.680514376969, 7152.570845749272, 7233.746818861315, 6952.756653517103, 7018.5788852669, 7070.7525236616475, 7091.361777440055, 7105.893411598933, 4888.682235654671, 4898.730569818552, 4906.190478570996, 4983.825566105169, 4987.177115775857, 4981.252812078217, 5024.196128619404, 5032.949670503248, 5046.8485945420225, 5064.34163558735], "value": 4511.556662051354, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.9739072178865, 307.5816889030919, 320.3129287677931, 326.37336314276587, 328.02739876266867, 4566.611837993766, 5040.177500599667, 5238.371395432553, 5289.677580604849, 5348.73256337183, 4764.78558464869, 4904.092742842577, 4941.812530917565, 5140.172904902308, 5175.948240517594, 3937.645611894929, 3962.286788378091, 3968.9206215875665, 3986.4618276532588, 3998.2403343364667, 3869.1101046759263, 3991.6806655467494, 4015.558288588253, 4031.8588849390276, 4043.009462681647, 3960.4059391091278, 3982.9203415931665, 3984.9203015939665, 3991.2616166009234, 4015.277250094982, 3969.0672691917375, 3979.5622481527153, 3986.5016872890887, 3988.541317748467, 3990.760554366718, 2898.68114507404, 3489.5114683944266, 3511.85864594008, 3520.366334059868, 3526.717862571014, 4938.185199442088, 5046.495350464961, 5083.440821509631, 5102.693838369672, 5107.0, 4542.818287268506, 4543.954560454386, 4558.247889098295, 4572.582499425189, 4574.794134263966, 4504.707194032378, 5415.458454154593, 5432.565394768409, 5432.91850622241, 5467.293689623622, 3491.1970246843116, 3812.3519001769764, 3816.751911125768, 3819.140693344003, 3824.0822202671156, 5708.857278568027, 5709.343425506078, 5710.2576665033275, 5761.0, 5774.902768473977, 3807.8766763804742, 3819.1979684266616, 3820.1977584706965, 3833.6166383361997, 3841.9242612068665, 3761.8307176177136, 3801.1827457096856, 3894.3184942634925, 3922.2939870823525, 3935.0359162005493, 4464.901496296736, 4477.261251893401, 4491.573300536509, 4507.72359958219, 4532.88667783308, 4597.3793537872625, 5481.0, 5530.198121272473, 5530.34543419161, 5535.69911070898, 1109.6683979224963, 1129.306040938592, 1228.7726770547476, 1272.7717752369008, 1286.4725462560493, 869.1569177897429, 883.081595141059, 896.4128495835238, 900.7522931193975, 910.3127139010005, 4085.3871919212356, 4644.930326045112, 4783.95216047842, 5048.419431765321, 5073.720945347967, 4776.498467660915, 4876.195807551228, 5566.805161819398, 5599.832005039855, 5641.605087643826, 4553.704009239389, 4963.156263435225, 4988.0, 5015.22264049073, 5023.2214006829, 2111.9049642765804, 2291.3126062181277, 2395.5448464791634, 2417.6373543968543, 2437.695288088989, 4799.232122860326, 4800.95199048012, 4810.6632535722865, 4869.318295438641, 4888.52914430751, 4113.506379234511, 4188.560201178893, 4337.110892267077, 4499.550044995474, 4802.6638135330195, 3448.1380054770643, 4582.73974656972, 4610.815567377402, 4843.782029808667, 4872.707637541759, 4223.21870453967, 4317.897996902892, 4680.812767489262, 4796.352492413619, 4809.470958194665, 4124.566920473427, 4597.356370108255, 4617.2916021072415, 4637.25803871379, 4651.465081515669, 4824.793801549613, 5182.429932707475, 5833.062682689253, 5878.265216847894, 5902.468777810018, 3973.9071755267532, 3980.2238563479846, 3990.3615421532418, 3992.261431635157, 3992.9600703992587, 5366.356037275552, 5644.887102258014, 5658.660480371026, 5663.292088488939, 5667.518260947701, 4849.854504364875, 5065.189569668835, 5292.834751677833, 5529.225908372911, 5599.748011339581, 5519.537322609592, 5526.535468100876, 5534.3673616284095, 5547.805826796042, 5553.0, 4516.16450956574, 4952.405711314521, 5182.870428239174, 5294.338207724035, 5404.135338345845, 4738.407699037621, 5465.349305586867, 5480.835574932758, 5495.395506494203, 5532.197831314517, 4506.391637129077, 4798.8884890648005, 5372.113601255905, 5387.138057910872, 5517.420670829505], "value": 3900.9730811277677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.0430071012651, 786.7285786403693, 821.7534739578126, 832.2052439919873, 855.7946092937694, 15100.848991510082, 16562.58593535162, 16606.667866642674, 17536.473905782816, 18349.357772477964, 17131.57171070721, 17183.312667493316, 17283.30866765328, 17336.479905602853, 17585.56036099095, 713.4399496395331, 741.1958025542266, 898.9685361012366, 913.3880300198882, 916.3219217778862, 728.1844334345514, 731.9011933389004, 733.8495608400292, 736.7016358374867, 880.0143838900441, 964.1419136968104, 965.3001573858932, 965.5751469353462, 966.912977831995, 971.3346357744967, 940.463935556733, 951.9190868776162, 956.3210120814231, 959.1128206409079, 959.9616015359447, 552.1662289942216, 695.2734392559737, 716.9103862017248, 718.4755128755985, 718.9101362329709, 15614.0, 15645.921770391189, 15652.92173539125, 15665.765013524806, 15668.059916404938, 13399.598012059654, 13698.452061917511, 13827.930860345734, 13875.722485550232, 14060.816681146829, 11027.386322807308, 12638.873611263862, 12916.354182290848, 12976.351182440934, 13493.292053663543, 4624.0, 4652.651051171176, 4692.401446582368, 4811.518848115161, 4829.468758436569, 109901.35147972786, 112893.0, 114059.0, 114805.0, 116412.0, 10930.289531180606, 11062.446877656246, 11118.221724479208, 11225.66319045154, 11496.885031149748, 21750.782492175193, 21793.0, 21793.67309490359, 21797.455063623536, 21828.672569911465, 7969.641366138538, 8004.559749213733, 8035.397345199133, 8062.798430039179, 8243.05204901444, 4482.8655140345845, 4486.394336764495, 4506.639468842484, 4522.570355816192, 4679.555442232982, 3571.8749843755345, 3691.4093745000673, 3692.5753538343433, 3694.8706795262574, 3698.3712768829364, 673.2325149329768, 680.5304340005381, 680.938715515606, 692.1382878316529, 693.6947742993067, 620.6214209332304, 627.5002743443174, 636.5448704176443, 649.9415052645285, 653.5686446944993, 8809.823803523894, 8833.955830220808, 8915.242204412569, 8989.595468203946, 9005.369624126379, 606.6087373643975, 637.5537124013209, 639.389383139101, 649.1496140056541, 662.0995446193269, 4270.850520231839, 4278.914421711548, 4323.329883868006, 4347.108842687241, 4439.1467381856755, 135005.0, 135267.0, 137792.31103844618, 150201.24899375433, 156610.0, 105562.47218763857, 131974.0, 132705.0, 133023.0, 134337.0, 110592.0, 114934.0, 115720.8427915727, 116392.41803791096, 118549.0, 8749.950005999066, 9078.273738100805, 9313.953430232805, 9769.56036978352, 9784.070513301225, 47351.52648473609, 63990.360096400305, 64865.0, 66117.66941165263, 66451.33871653247, 84776.57611711902, 85348.0, 89283.55358223167, 93709.5314523423, 94993.0, 12829.42267597979, 13155.802662960255, 13277.601671949857, 13293.468261269441, 13800.861991379958, 14260.073095248776, 14467.78298325547, 14585.781213282022, 14691.85308146905, 15129.697406052037, 13414.798778018532, 13759.17444953306, 13829.377678004716, 14258.215798131203, 14314.785278220626, 13429.529966451128, 13640.590782276548, 13653.177110409102, 13702.86297137016, 13714.0, 13057.236385279162, 13223.404946777226, 13276.53532126371, 13372.465101395836, 13489.865101349253, 9331.580078896603, 10017.14854237398, 11002.174836887105, 11044.564206653084, 11216.607418740305, 10870.347779133277, 11201.775964480828, 11317.434128293717, 11408.828867566826, 11499.885001150216], "value": 7989.084849137988, "unit": "score"}], "name": "dromaeo_css", "value": 7415.027597033303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 112.0, 110.0, 112.0, 111.0, 111.0, 110.0, 112.0, 118.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 107.0, 159.0, 108.0, 106.0, 126.0, 106.0, 141.0, 107.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 186.0, 180.0, 185.0, 183.0, 185.0, 182.0, 182.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 48.0, 111.0, 81.0, 82.0, 88.0, 77.0, 83.0, 57.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 92.0, 93.0, 71.0, 72.0, 68.0, 97.0, 70.0, 68.0, 103.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 131.0, 86.0, 84.0, 87.0, 84.0, 87.0, 84.0, 87.0, 84.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 109.0, 151.0, 92.0, 93.0, 92.0, 93.0, 92.0, 92.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 85.0, 87.0, 82.0, 85.0, 86.0, 87.0, 85.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 54.0, 53.0, 53.0, 56.0, 53.0, 54.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 112.0, 74.0, 71.0, 71.0, 70.0, 72.0, 72.0, 72.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 82.0, 84.0, 82.0, 83.0, 85.0, 87.0, 79.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 146.0, 145.0, 145.0, 125.0, 123.0, 135.0, 134.0, 248.0, 136.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 162.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 78.0, 82.0, 84.0, 83.0, 83.0, 66.0, 66.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1446.1999999999998, "alertThreshold": 2.0}]} 18:43:43 INFO - Return code: 0 18:43:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:43:43 INFO - # TBPL SUCCESS # 18:43:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:43:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:43:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:43:43 INFO - 2016-07-12 18:43:43.095 screenresolution[1798:9770] starting screenresolution argv=screenresolution get 18:43:43 INFO - 2016-07-12 18:43:43.097 screenresolution[1798:9770] Display 0: 1600x1200x32@60 18:43:43 INFO - 2016-07-12 18:43:43.103 screenresolution[1799:9773] starting screenresolution argv=screenresolution list 18:43:43 INFO - Available Modes on Display 0 18:43:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:43:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:43:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:43:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:43:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:43:43 INFO - Intel Iris: 18:43:43 INFO - Chipset Model: Intel Iris 18:43:43 INFO - Type: GPU 18:43:43 INFO - Bus: Built-In 18:43:43 INFO - VRAM (Dynamic, Max): 1536 MB 18:43:43 INFO - Vendor: Intel (0x8086) 18:43:43 INFO - Device ID: 0x0a2e 18:43:43 INFO - Revision ID: 0x0009 18:43:43 INFO - Displays: 18:43:43 INFO - Display: 18:43:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:43:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:43:43 INFO - Display Serial Number: 1600x1200 60 18:43:43 INFO - Main Display: Yes 18:43:43 INFO - Mirror: Off 18:43:43 INFO - Online: Yes 18:43:43 INFO - Rotation: Supported 18:43:43 INFO - Return code: 0 18:43:43 INFO - Running post-action listener: _resource_record_post_action 18:43:43 INFO - ##### 18:43:43 INFO - ##### Finished run-tests step (success) 18:43:43 INFO - ##### 18:43:43 INFO - Running post-run listener: _resource_record_post_run 18:43:43 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37074432; Write bytes: 708169216; Read time: 240; Write time: 1992 18:43:43 INFO - TinderboxPrint: CPU usage
53.5% 18:43:43 INFO - TinderboxPrint: I/O read bytes / time
37,074,432 / 240 18:43:43 INFO - TinderboxPrint: I/O write bytes / time
708,169,216 / 1,992 18:43:43 INFO - TinderboxPrint: CPU idle
2,251.2 (46.5%) 18:43:43 INFO - TinderboxPrint: CPU system
965.0 (19.9%) 18:43:43 INFO - TinderboxPrint: CPU user
1,625.3 (33.6%) 18:43:43 INFO - TinderboxPrint: Swap in / out
443,817,984 / 0 18:43:43 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404941312; Write bytes: 400074240; Read time: 29827; Write time: 818 18:43:43 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34416128; Write bytes: 296327168; Read time: 214; Write time: 1139 18:43:43 INFO - Running post-run listener: _upload_blobber_files 18:43:43 INFO - Blob upload gear active. 18:43:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:43:43 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 18:43:43 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'] 18:43:43 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 18:43:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:45 INFO - (blobuploader) - INFO - Done attempting. 18:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:43:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:46 INFO - (blobuploader) - INFO - Done attempting. 18:43:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:43:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:48 INFO - (blobuploader) - INFO - Done attempting. 18:43:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:43:48 INFO - Return code: 0 18:43:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:43:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:43:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638897d23dfbd465429d285fabefef1f58540878107fda41278ab77ae3d7dba5cd764818f8edb09e860fedc65b9437c7b445afe7012f1a7c461a62a34e1a750f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a3f9913ab8c23d9fb88632e44541609667724f31427f017b48fb8121616eb2ec28b0a9d4b555a0abc8abfde69f0115e1381af60f947213526edab09a09594da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f534065b97fe4d639e54115e2c72c56477abb8952d8d3e112aabe66199aa2309d192c9a8ee2aaafd0098e1d176afd7e0266761eaef5689daa51279835f51ac40"} 18:43:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:43:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:43:48 INFO - Contents: 18:43:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638897d23dfbd465429d285fabefef1f58540878107fda41278ab77ae3d7dba5cd764818f8edb09e860fedc65b9437c7b445afe7012f1a7c461a62a34e1a750f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a3f9913ab8c23d9fb88632e44541609667724f31427f017b48fb8121616eb2ec28b0a9d4b555a0abc8abfde69f0115e1381af60f947213526edab09a09594da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f534065b97fe4d639e54115e2c72c56477abb8952d8d3e112aabe66199aa2309d192c9a8ee2aaafd0098e1d176afd7e0266761eaef5689daa51279835f51ac40"} 18:43:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:43:48 INFO - Copying logs to upload dir... 18:43:48 INFO - mkdir: /builds/slave/test/build/upload/logs 18:43:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.141841 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-12 18:43:48.615021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 18:43:48.618418) ========= 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.Zujyr2FiIB/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.BPduKRhoyO/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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/638897d23dfbd465429d285fabefef1f58540878107fda41278ab77ae3d7dba5cd764818f8edb09e860fedc65b9437c7b445afe7012f1a7c461a62a34e1a750f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a3f9913ab8c23d9fb88632e44541609667724f31427f017b48fb8121616eb2ec28b0a9d4b555a0abc8abfde69f0115e1381af60f947213526edab09a09594da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f534065b97fe4d639e54115e2c72c56477abb8952d8d3e112aabe66199aa2309d192c9a8ee2aaafd0098e1d176afd7e0266761eaef5689daa51279835f51ac40"} build_url:https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011040 build_url: 'https://queue.taskcluster.net/v1/task/JMgk4ZzPR52vFo2Vx6RA-A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638897d23dfbd465429d285fabefef1f58540878107fda41278ab77ae3d7dba5cd764818f8edb09e860fedc65b9437c7b445afe7012f1a7c461a62a34e1a750f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a3f9913ab8c23d9fb88632e44541609667724f31427f017b48fb8121616eb2ec28b0a9d4b555a0abc8abfde69f0115e1381af60f947213526edab09a09594da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f534065b97fe4d639e54115e2c72c56477abb8952d8d3e112aabe66199aa2309d192c9a8ee2aaafd0098e1d176afd7e0266761eaef5689daa51279835f51ac40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 18:43:48.653526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:43:48.653946) ========= 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.Zujyr2FiIB/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.BPduKRhoyO/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:43:48.702883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 18:43:48.703220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 18:43:48.703551) ========= ========= Total master_lag: 0.19 =========