builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1467191295.86 results: success (0) buildid: 20160628235640 builduid: b58804bbd46846fd973c81682ae2a931 revision: 3ce3be36f582a04605c1966e65766298331fb9b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:15.861492) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:15.861900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:15.862177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:15.885564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:15.885892) ========= 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.d2OVgrn7sj/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.pNF5usZ15w/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-06-29 02:08:15-- 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% 68.1M=0s 2016-06-29 02:08:16 (68.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123879 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:16.083559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:16.083941) ========= 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.d2OVgrn7sj/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.pNF5usZ15w/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.020669 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:16.126913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-29 02:08:16.127258) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce3be36f582a04605c1966e65766298331fb9b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce3be36f582a04605c1966e65766298331fb9b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d2OVgrn7sj/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.pNF5usZ15w/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-06-29 02:08:16,198 truncating revision to first 12 chars 2016-06-29 02:08:16,198 Setting DEBUG logging. 2016-06-29 02:08:16,198 attempt 1/10 2016-06-29 02:08:16,199 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ce3be36f582?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 02:08:18,399 unpacking tar archive at: fx-team-3ce3be36f582/testing/mozharness/ program finished with exit code 0 elapsedTime=2.471054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-29 02:08:18.621849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:18.622351) ========= script_repo_revision: 3ce3be36f582a04605c1966e65766298331fb9b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:18.622990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:18.623458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:08:18.642455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-29 02:08:18.642939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d2OVgrn7sj/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.pNF5usZ15w/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:08:18 INFO - MultiFileLogger online at 20160629 02:08:18 in /builds/slave/test 02:08:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:08:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:18 INFO - {'append_to_log': False, 02:08:18 INFO - 'base_work_dir': '/builds/slave/test', 02:08:18 INFO - 'blob_upload_branch': 'Fx-Team', 02:08:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:18 INFO - 'branch': 'Fx-Team', 02:08:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:18 INFO - 'config_files': ('talos/mac_config.py',), 02:08:18 INFO - 'default_actions': ('clobber', 02:08:18 INFO - 'read-buildbot-config', 02:08:18 INFO - 'download-and-extract', 02:08:18 INFO - 'populate-webroot', 02:08:18 INFO - 'create-virtualenv', 02:08:18 INFO - 'install', 02:08:18 INFO - 'run-tests'), 02:08:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:18 INFO - 'download_minidump_stackwalk': True, 02:08:18 INFO - 'download_symbols': 'ondemand', 02:08:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:18 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:18 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:18 INFO - 'installer_path': 'installer.exe', 02:08:18 INFO - 'log_level': 'info', 02:08:18 INFO - 'log_name': 'talos', 02:08:18 INFO - 'log_to_console': True, 02:08:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:08:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:08:18 INFO - 'opt_config_files': (), 02:08:18 INFO - 'pip_index': False, 02:08:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:18 INFO - 'cmd': ('bash', 02:08:18 INFO - '-c', 02:08:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:18 INFO - 'enabled': True, 02:08:18 INFO - 'halt_on_failure': False, 02:08:18 INFO - 'name': 'check_screen_resolution'},), 02:08:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:18 INFO - 'cmd': ('bash', 02:08:18 INFO - '-c', 02:08:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:18 INFO - 'enabled': True, 02:08:18 INFO - 'halt_on_failure': False, 02:08:18 INFO - 'name': 'check_screen_resolution'},), 02:08:18 INFO - 'run_cmd_checks_enabled': True, 02:08:18 INFO - 'sps_profile': False, 02:08:18 INFO - 'sps_profile_interval': 0, 02:08:18 INFO - 'suite': 'dromaeojs', 02:08:18 INFO - 'system_bits': '32', 02:08:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:18 INFO - 'title': 't-yosemite-r7-0038', 02:08:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:18 INFO - 'use_talos_json': True, 02:08:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:18 INFO - 'work_dir': 'build'} 02:08:18 INFO - ##### 02:08:18 INFO - ##### Running clobber step. 02:08:18 INFO - ##### 02:08:18 INFO - Running pre-action listener: _resource_record_pre_action 02:08:18 INFO - Running main action method: clobber 02:08:18 INFO - rmtree: /builds/slave/test/build 02:08:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:20 INFO - Running post-action listener: _resource_record_post_action 02:08:20 INFO - ##### 02:08:20 INFO - ##### Finished clobber step (success) 02:08:20 INFO - ##### 02:08:20 INFO - ##### 02:08:20 INFO - ##### Running read-buildbot-config step. 02:08:20 INFO - ##### 02:08:20 INFO - Running pre-action listener: _resource_record_pre_action 02:08:20 INFO - Running main action method: read_buildbot_config 02:08:20 INFO - Using buildbot properties: 02:08:20 INFO - { 02:08:20 INFO - "project": "", 02:08:20 INFO - "product": "firefox", 02:08:20 INFO - "script_repo_revision": "production", 02:08:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:08:20 INFO - "repository": "", 02:08:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:08:20 INFO - "buildid": "20160628235640", 02:08:20 INFO - "pgo_build": "False", 02:08:20 INFO - "basedir": "/builds/slave/test", 02:08:20 INFO - "buildnumber": 81, 02:08:20 INFO - "slavename": "t-yosemite-r7-0038", 02:08:20 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:08:20 INFO - "platform": "yosemite_r7", 02:08:20 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:08:20 INFO - "branch": "fx-team", 02:08:20 INFO - "repo_path": "integration/fx-team", 02:08:20 INFO - "revision": "3ce3be36f582a04605c1966e65766298331fb9b6", 02:08:20 INFO - "stage_platform": "macosx64", 02:08:20 INFO - "builduid": "b58804bbd46846fd973c81682ae2a931", 02:08:20 INFO - "slavebuilddir": "test" 02:08:20 INFO - } 02:08:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 02:08:20 INFO - Running post-action listener: _resource_record_post_action 02:08:20 INFO - ##### 02:08:20 INFO - ##### Finished read-buildbot-config step (success) 02:08:20 INFO - ##### 02:08:20 INFO - ##### 02:08:20 INFO - ##### Running download-and-extract step. 02:08:20 INFO - ##### 02:08:20 INFO - Running pre-action listener: _resource_record_pre_action 02:08:20 INFO - Running main action method: download_and_extract 02:08:20 INFO - mkdir: /builds/slave/test/build/tests 02:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:20 INFO - https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:23 INFO - Downloaded 1199 bytes. 02:08:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 02:08:23 INFO - Using the following test package requirements: 02:08:23 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:08:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 02:08:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 02:08:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'jsshell-mac.zip'], 02:08:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 02:08:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:08:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 02:08:23 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 02:08:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 02:08:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:08:23 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 02:08:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:08:23 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')]} 02:08:23 INFO - https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:24 INFO - Downloaded 18786942 bytes. 02:08:24 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'] 02:08:24 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 02:08:27 INFO - Return code: 0 02:08:27 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 02:08:27 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')]} 02:08:27 INFO - https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:28 INFO - Downloaded 18786942 bytes. 02:08:28 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'] 02:08:28 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 02:08:32 INFO - Return code: 0 02:08:32 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')]} 02:08:32 INFO - https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:33 INFO - Downloaded 14405245 bytes. 02:08:33 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'] 02:08:33 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 02:08:33 INFO - Return code: 0 02:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:33 INFO - https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 02:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrkJrrsxS96Ou2skqfp8qg/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 02:08:36 INFO - Downloaded 112385705 bytes. 02:08:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:08:36 INFO - mkdir: /builds/slave/test/properties 02:08:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:36 INFO - Contents: 02:08:36 INFO - build_url:https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:08:37 INFO - Running post-action listener: _resource_record_post_action 02:08:37 INFO - Running post-action listener: set_extra_try_arguments 02:08:37 INFO - ##### 02:08:37 INFO - ##### Finished download-and-extract step (success) 02:08:37 INFO - ##### 02:08:37 INFO - ##### 02:08:37 INFO - ##### Running populate-webroot step. 02:08:37 INFO - ##### 02:08:37 INFO - Running pre-action listener: _resource_record_pre_action 02:08:37 INFO - Running main action method: populate_webroot 02:08:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:37 INFO - '--tppagecycles', 02:08:37 INFO - '7'], 02:08:37 INFO - 'tests': ['tsvgm']}}, 02:08:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:08:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:08:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:08:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['damp', 'tps']}, 02:08:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'tests': ['damp', 'tps']}, 02:08:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['dromaeo_dom']}, 02:08:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['basic_compositor_video']}, 02:08:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:08:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['a11yr', 02:08:37 INFO - 'ts_paint', 02:08:37 INFO - 'tpaint', 02:08:37 INFO - 'sessionrestore', 02:08:37 INFO - 'sessionrestore_no_auto_restore', 02:08:37 INFO - 'tabpaint']}, 02:08:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:08:37 INFO - 'ts_paint', 02:08:37 INFO - 'tpaint', 02:08:37 INFO - 'sessionrestore', 02:08:37 INFO - 'sessionrestore_no_auto_restore', 02:08:37 INFO - 'tabpaint']}, 02:08:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:08:37 INFO - 'ts_paint', 02:08:37 INFO - 'tpaint', 02:08:37 INFO - 'sessionrestore', 02:08:37 INFO - 'sessionrestore_no_auto_restore', 02:08:37 INFO - 'tabpaint']}, 02:08:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:08:37 INFO - 'ts_paint', 02:08:37 INFO - 'tpaint', 02:08:37 INFO - 'sessionrestore', 02:08:37 INFO - 'sessionrestore_no_auto_restore', 02:08:37 INFO - 'tabpaint']}, 02:08:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['a11yr', 02:08:37 INFO - 'ts_paint', 02:08:37 INFO - 'tpaint', 02:08:37 INFO - 'sessionrestore', 02:08:37 INFO - 'sessionrestore_no_auto_restore', 02:08:37 INFO - 'tabpaint']}, 02:08:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['a11yr', 02:08:37 INFO - 'ts_paint', 02:08:37 INFO - 'tpaint', 02:08:37 INFO - 'sessionrestore', 02:08:37 INFO - 'sessionrestore_no_auto_restore', 02:08:37 INFO - 'tabpaint']}, 02:08:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['tsvgx', 02:08:37 INFO - 'tsvgr_opacity', 02:08:37 INFO - 'tart', 02:08:37 INFO - 'tscrollx', 02:08:37 INFO - 'cart']}, 02:08:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:08:37 INFO - 'tsvgr_opacity', 02:08:37 INFO - 'tart', 02:08:37 INFO - 'tscrollx', 02:08:37 INFO - 'cart']}, 02:08:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'talos_options': ['--disable-e10s'], 02:08:37 INFO - 'tests': ['tp5o']}, 02:08:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'tests': ['tp5o']}, 02:08:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'talos_options': ['--disable-e10s', 02:08:37 INFO - '--xperf_path', 02:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:37 INFO - 'tests': ['tp5n']}, 02:08:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:37 INFO - 'talos_options': ['--xperf_path', 02:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:37 INFO - 'tests': ['tp5n']}}, 02:08:37 INFO - 'talos.zip': {'path': '', 02:08:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:37 INFO - Running post-action listener: _resource_record_post_action 02:08:37 INFO - ##### 02:08:37 INFO - ##### Finished populate-webroot step (success) 02:08:37 INFO - ##### 02:08:37 INFO - ##### 02:08:37 INFO - ##### Running create-virtualenv step. 02:08:37 INFO - ##### 02:08:37 INFO - Running pre-action listener: _resource_record_pre_action 02:08:37 INFO - Running main action method: create_virtualenv 02:08:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:37 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 02:08:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:37 INFO - Using real prefix '/tools/python27' 02:08:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:41 INFO - Installing pip.................done. 02:08:41 INFO - Return code: 0 02:08:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08:41 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')]} 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:41 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')]} 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:41 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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:08:41 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 02:08:41 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 02:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:41 INFO - 'HOME': '/Users/cltbld', 02:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:41 INFO - 'LOGNAME': 'cltbld', 02:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:41 INFO - 'MOZ_NO_REMOTE': '1', 02:08:41 INFO - 'NO_EM_RESTART': '1', 02:08:41 INFO - 'PAGER': '/bin/cat', 02:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:41 INFO - 'PWD': '/builds/slave/test', 02:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:41 INFO - 'SHELL': '/bin/bash', 02:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:08:41 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:41 INFO - 'USER': 'cltbld', 02:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:41 INFO - 'XPC_FLAGS': '0x0', 02:08:41 INFO - 'XPC_SERVICE_NAME': '0', 02:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:41 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 02:08:41 INFO - Cleaning up... 02:08:41 INFO - Return code: 0 02:08:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:08:41 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')]} 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:41 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')]} 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:41 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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:08:41 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 02:08:41 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 02:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:41 INFO - 'HOME': '/Users/cltbld', 02:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:41 INFO - 'LOGNAME': 'cltbld', 02:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:41 INFO - 'MOZ_NO_REMOTE': '1', 02:08:41 INFO - 'NO_EM_RESTART': '1', 02:08:41 INFO - 'PAGER': '/bin/cat', 02:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:41 INFO - 'PWD': '/builds/slave/test', 02:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:41 INFO - 'SHELL': '/bin/bash', 02:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:08:41 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:41 INFO - 'USER': 'cltbld', 02:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:41 INFO - 'XPC_FLAGS': '0x0', 02:08:41 INFO - 'XPC_SERVICE_NAME': '0', 02:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:41 INFO - Downloading/unpacking psutil>=3.1.1 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:44 INFO - Installing collected packages: psutil 02:08:44 INFO - Running setup.py install for psutil 02:08:44 INFO - building 'psutil._psutil_osx' extension 02:08:44 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 02:08:45 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 02:08:45 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 02:08:45 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 02:08:45 INFO - building 'psutil._psutil_posix' extension 02:08:45 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 02:08:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:08:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:08:45 INFO - ^ 02:08:45 INFO - 1 warning generated. 02:08:45 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 02:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:45 INFO - Successfully installed psutil 02:08:45 INFO - Cleaning up... 02:08:45 INFO - Return code: 0 02:08:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:45 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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:08:45 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 02:08:45 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 02:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:45 INFO - 'HOME': '/Users/cltbld', 02:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:45 INFO - 'LOGNAME': 'cltbld', 02:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:45 INFO - 'MOZ_NO_REMOTE': '1', 02:08:45 INFO - 'NO_EM_RESTART': '1', 02:08:45 INFO - 'PAGER': '/bin/cat', 02:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:45 INFO - 'PWD': '/builds/slave/test', 02:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:45 INFO - 'SHELL': '/bin/bash', 02:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:08:45 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:45 INFO - 'USER': 'cltbld', 02:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:45 INFO - 'XPC_FLAGS': '0x0', 02:08:45 INFO - 'XPC_SERVICE_NAME': '0', 02:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:08:45 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 02:08:45 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 02:08:45 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 02:08:45 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 02:08:45 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 02:08:45 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 02:08:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:08:48 INFO - Installing collected packages: mozsystemmonitor 02:08:48 INFO - Running setup.py install for mozsystemmonitor 02:08:48 INFO - Successfully installed mozsystemmonitor 02:08:48 INFO - Cleaning up... 02:08:48 INFO - Return code: 0 02:08:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:48 INFO - 'HOME': '/Users/cltbld', 02:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:48 INFO - 'LOGNAME': 'cltbld', 02:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:48 INFO - 'MOZ_NO_REMOTE': '1', 02:08:48 INFO - 'NO_EM_RESTART': '1', 02:08:48 INFO - 'PAGER': '/bin/cat', 02:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:48 INFO - 'PWD': '/builds/slave/test', 02:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:48 INFO - 'SHELL': '/bin/bash', 02:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:08:48 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:48 INFO - 'USER': 'cltbld', 02:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:48 INFO - 'XPC_FLAGS': '0x0', 02:08:48 INFO - 'XPC_SERVICE_NAME': '0', 02:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:48 INFO - Downloading/unpacking jsonschema==2.5.1 02:08:48 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 02:08:48 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 02:08:48 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 02:08:48 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 02:08:48 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 02:08:48 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 02:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:51 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:51 INFO - warning: no files found matching '*.txt' 02:08:51 INFO - no previously-included directories found matching 'build' 02:08:51 INFO - no previously-included directories found matching 'dist' 02:08:51 INFO - no previously-included directories found matching '.git*' 02:08:51 INFO - Installing collected packages: jsonschema, functools32 02:08:51 INFO - Running setup.py install for functools32 02:08:51 INFO - warning: no files found matching '*.txt' 02:08:51 INFO - no previously-included directories found matching 'build' 02:08:51 INFO - no previously-included directories found matching 'dist' 02:08:51 INFO - no previously-included directories found matching '.git*' 02:08:51 INFO - Successfully installed jsonschema functools32 02:08:51 INFO - Cleaning up... 02:08:51 INFO - Return code: 0 02:08:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:08:51 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')]} 02:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:51 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')]} 02:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:51 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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:08:51 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 02:08:51 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 02:08:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:08:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:51 INFO - 'HOME': '/Users/cltbld', 02:08:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:51 INFO - 'LOGNAME': 'cltbld', 02:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:51 INFO - 'MOZ_NO_REMOTE': '1', 02:08:51 INFO - 'NO_EM_RESTART': '1', 02:08:51 INFO - 'PAGER': '/bin/cat', 02:08:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:51 INFO - 'PWD': '/builds/slave/test', 02:08:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:51 INFO - 'SHELL': '/bin/bash', 02:08:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:08:51 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:08:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:51 INFO - 'USER': 'cltbld', 02:08:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:51 INFO - 'XPC_FLAGS': '0x0', 02:08:51 INFO - 'XPC_SERVICE_NAME': '0', 02:08:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:52 INFO - Downloading/unpacking blobuploader==1.2.4 02:08:52 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 02:08:52 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 02:08:52 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 02:08:52 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 02:08:52 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 02:08:52 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 02:08:54 INFO - Downloading blobuploader-1.2.4.tar.gz 02:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:08:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:08:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:08:55 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 02:08:55 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 02:08:55 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 02:08:55 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 02:08:55 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 02:08:55 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 02:08:55 INFO - Downloading docopt-0.6.1.tar.gz 02:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:08:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:08:55 INFO - Running setup.py install for blobuploader 02:08:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:08:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:08:56 INFO - Running setup.py install for requests 02:08:56 INFO - Running setup.py install for docopt 02:08:56 INFO - Successfully installed blobuploader requests docopt 02:08:56 INFO - Cleaning up... 02:08:56 INFO - Return code: 0 02:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:56 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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:08:56 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 02:08:56 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 02:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:56 INFO - 'HOME': '/Users/cltbld', 02:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:56 INFO - 'LOGNAME': 'cltbld', 02:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:56 INFO - 'MOZ_NO_REMOTE': '1', 02:08:56 INFO - 'NO_EM_RESTART': '1', 02:08:56 INFO - 'PAGER': '/bin/cat', 02:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:56 INFO - 'PWD': '/builds/slave/test', 02:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:56 INFO - 'SHELL': '/bin/bash', 02:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:08:56 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:56 INFO - 'USER': 'cltbld', 02:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:56 INFO - 'XPC_FLAGS': '0x0', 02:08:56 INFO - 'XPC_SERVICE_NAME': '0', 02:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-V9dI4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LmnEq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Jn2pTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4fMqA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SCstTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-gxNo0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-uJmRHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7QFEJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-luAvEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-JG7ESU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kp34W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kS2BJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SRH2ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-M_xxUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ZxtDUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-eSvvsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XP3mdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:08:58 INFO - Running setup.py install for manifestparser 02:08:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:08:58 INFO - Running setup.py install for mozcrash 02:08:59 INFO - Running setup.py install for mozdebug 02:08:59 INFO - Running setup.py install for mozdevice 02:08:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Running setup.py install for mozfile 02:08:59 INFO - Running setup.py install for mozhttpd 02:08:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Running setup.py install for mozinfo 02:08:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Running setup.py install for mozInstall 02:08:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:08:59 INFO - Running setup.py install for mozleak 02:09:00 INFO - Running setup.py install for mozlog 02:09:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:00 INFO - Running setup.py install for moznetwork 02:09:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:00 INFO - Running setup.py install for mozprocess 02:09:00 INFO - Running setup.py install for mozprofile 02:09:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:00 INFO - Running setup.py install for mozrunner 02:09:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:00 INFO - Running setup.py install for mozscreenshot 02:09:01 INFO - Running setup.py install for moztest 02:09:01 INFO - Running setup.py install for mozversion 02:09:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:01 INFO - Cleaning up... 02:09:01 INFO - Return code: 0 02:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:09:01 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 02:09:01 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 02:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:01 INFO - 'HOME': '/Users/cltbld', 02:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:01 INFO - 'LOGNAME': 'cltbld', 02:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:01 INFO - 'MOZ_NO_REMOTE': '1', 02:09:01 INFO - 'NO_EM_RESTART': '1', 02:09:01 INFO - 'PAGER': '/bin/cat', 02:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:01 INFO - 'PWD': '/builds/slave/test', 02:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:01 INFO - 'SHELL': '/bin/bash', 02:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:09:01 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:01 INFO - 'USER': 'cltbld', 02:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:01 INFO - 'XPC_FLAGS': '0x0', 02:09:01 INFO - 'XPC_SERVICE_NAME': '0', 02:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ZtuZM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:01 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)) 02:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-JoztN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:01 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)) 02:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-YT8yNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:01 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)) 02:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-eaKl_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-MMwngl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kXX8sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SqyHnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-rr7FYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-3f3QPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-unIlcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-lgoRWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-UULaeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-9maUVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:02 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)) 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-_OwNNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Kk9_l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:03 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)) 02:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-_cIrcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:03 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)) 02:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kiGakt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:03 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)) 02:09:03 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)) 02:09:03 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)) 02:09:03 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)) 02:09:03 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)) 02:09:03 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)) 02:09:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:05 INFO - Downloading blessings-1.6.tar.gz 02:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:06 INFO - Installing collected packages: blessings 02:09:06 INFO - Running setup.py install for blessings 02:09:06 INFO - Successfully installed blessings 02:09:06 INFO - Cleaning up... 02:09:06 INFO - Return code: 0 02:09:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:09:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:06 INFO - Reading from file tmpfile_stdout 02:09:06 INFO - Current package versions: 02:09:06 INFO - blessings == 1.6 02:09:06 INFO - blobuploader == 1.2.4 02:09:06 INFO - docopt == 0.6.1 02:09:06 INFO - functools32 == 3.2.3-2 02:09:06 INFO - jsonschema == 2.5.1 02:09:06 INFO - manifestparser == 1.1 02:09:06 INFO - mozInstall == 1.12 02:09:06 INFO - mozcrash == 0.17 02:09:06 INFO - mozdebug == 0.1 02:09:06 INFO - mozdevice == 0.48 02:09:06 INFO - mozfile == 1.2 02:09:06 INFO - mozhttpd == 0.7 02:09:06 INFO - mozinfo == 0.9 02:09:06 INFO - mozleak == 0.1 02:09:06 INFO - mozlog == 3.2 02:09:06 INFO - moznetwork == 0.27 02:09:06 INFO - mozprocess == 0.22 02:09:06 INFO - mozprofile == 0.28 02:09:06 INFO - mozrunner == 6.11 02:09:06 INFO - mozscreenshot == 0.1 02:09:06 INFO - mozsystemmonitor == 0.3 02:09:06 INFO - moztest == 0.7 02:09:06 INFO - mozversion == 1.4 02:09:06 INFO - psutil == 3.1.1 02:09:06 INFO - requests == 1.2.3 02:09:06 INFO - wsgiref == 0.1.2 02:09:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09: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')]} 02:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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')]} 02:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:06 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 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:09:06 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 02:09:06 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 02:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:06 INFO - 'HOME': '/Users/cltbld', 02:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:06 INFO - 'LOGNAME': 'cltbld', 02:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:06 INFO - 'MOZ_NO_REMOTE': '1', 02:09:06 INFO - 'NO_EM_RESTART': '1', 02:09:06 INFO - 'PAGER': '/bin/cat', 02:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:06 INFO - 'PWD': '/builds/slave/test', 02:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:06 INFO - 'SHELL': '/bin/bash', 02:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:09:06 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:06 INFO - 'USER': 'cltbld', 02:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:06 INFO - 'XPC_FLAGS': '0x0', 02:09:06 INFO - 'XPC_SERVICE_NAME': '0', 02:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 INFO - Cleaning up... 02:09:06 INFO - Return code: 0 02:09:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:09: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')]} 02:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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')]} 02:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106424a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85cbcc36a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, '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.d2OVgrn7sj/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.pNF5usZ15w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 02:09: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', 'jsonschema'] in /builds/slave/test/build 02:09: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 jsonschema 02:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:06 INFO - 'HOME': '/Users/cltbld', 02:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:06 INFO - 'LOGNAME': 'cltbld', 02:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:06 INFO - 'MOZ_NO_REMOTE': '1', 02:09:06 INFO - 'NO_EM_RESTART': '1', 02:09:06 INFO - 'PAGER': '/bin/cat', 02:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:06 INFO - 'PWD': '/builds/slave/test', 02:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:06 INFO - 'SHELL': '/bin/bash', 02:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:09:06 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:06 INFO - 'USER': 'cltbld', 02:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:06 INFO - 'XPC_FLAGS': '0x0', 02:09:06 INFO - 'XPC_SERVICE_NAME': '0', 02:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:09:07 INFO - Cleaning up... 02:09:07 INFO - Return code: 0 02:09:07 INFO - Running post-action listener: _resource_record_post_action 02:09:07 INFO - Running post-action listener: _start_resource_monitoring 02:09:07 INFO - Starting resource monitoring. 02:09:07 INFO - ##### 02:09:07 INFO - ##### Finished create-virtualenv step (success) 02:09:07 INFO - ##### 02:09:07 INFO - ##### 02:09:07 INFO - ##### Running install step. 02:09:07 INFO - ##### 02:09:07 INFO - Running pre-action listener: _resource_record_pre_action 02:09:07 INFO - Running main action method: install 02:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:07 INFO - Reading from file tmpfile_stdout 02:09:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:09:07 INFO - Reading from file tmpfile_stdout 02:09:07 INFO - Output received: 02:09:07 INFO - Usage: mozinstall [options] installer 02:09:07 INFO - Options: 02:09:07 INFO - -h, --help show this help message and exit 02:09:07 INFO - -d DEST, --destination=DEST 02:09:07 INFO - Directory to install application into. [default: 02:09:07 INFO - "/builds/slave/test"] 02:09:07 INFO - --app=APP Application being installed. [default: firefox] 02:09:07 INFO - mkdir: /builds/slave/test/build/application 02:09:07 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'] 02:09:07 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 02:09:41 INFO - Reading from file tmpfile_stdout 02:09:41 INFO - Output received: 02:09:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:09:41 INFO - Running post-action listener: _resource_record_post_action 02:09:41 INFO - ##### 02:09:41 INFO - ##### Finished install step (success) 02:09:41 INFO - ##### 02:09:41 INFO - ##### 02:09:41 INFO - ##### Running run-tests step. 02:09:41 INFO - ##### 02:09:41 INFO - Running pre-action listener: _resource_record_pre_action 02:09:41 INFO - Running main action method: run_tests 02:09:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:09:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:09:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:09:41 INFO - 2016-06-29 02:09:41.583 screenresolution[1905:14470] starting screenresolution argv=screenresolution get 02:09:41 INFO - 2016-06-29 02:09:41.586 screenresolution[1905:14470] Display 0: 1600x1200x32@60 02:09:41 INFO - 2016-06-29 02:09:41.592 screenresolution[1906:14472] starting screenresolution argv=screenresolution list 02:09:41 INFO - Available Modes on Display 0 02:09:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:09:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:09:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:09:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:09:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:09:41 INFO - Intel Iris: 02:09:41 INFO - Chipset Model: Intel Iris 02:09:41 INFO - Type: GPU 02:09:41 INFO - Bus: Built-In 02:09:41 INFO - VRAM (Dynamic, Max): 1536 MB 02:09:41 INFO - Vendor: Intel (0x8086) 02:09:41 INFO - Device ID: 0x0a2e 02:09:41 INFO - Revision ID: 0x0009 02:09:41 INFO - Displays: 02:09:41 INFO - Display: 02:09:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:09:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:09:41 INFO - Display Serial Number: 1600x1200 60 02:09:41 INFO - Main Display: Yes 02:09:41 INFO - Mirror: Off 02:09:41 INFO - Online: Yes 02:09:41 INFO - Rotation: Supported 02:09:41 INFO - Return code: 0 02:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:09:41 INFO - Python 2.7.3 02:09:41 INFO - Return code: 0 02:09:41 INFO - grabbing minidump binary from tooltool 02:09:41 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')]} 02:09:41 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 0x106388d30>, '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 0x1060eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106380b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:09:41 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 02:09:41 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 02:09:41 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 02:09:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:41 INFO - Return code: 0 02:09:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:09:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:09:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:09:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:09:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 02:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 02:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d2OVgrn7sj/Render', 02:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:41 INFO - 'HOME': '/Users/cltbld', 02:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:41 INFO - 'LOGNAME': 'cltbld', 02:09:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:09:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:41 INFO - 'MOZ_NO_REMOTE': '1', 02:09:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:09:41 INFO - 'NO_EM_RESTART': '1', 02:09:41 INFO - 'PAGER': '/bin/cat', 02:09:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:41 INFO - 'PWD': '/builds/slave/test', 02:09:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:41 INFO - 'SHELL': '/bin/bash', 02:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pNF5usZ15w/Listeners', 02:09:41 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 02:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:41 INFO - 'USER': 'cltbld', 02:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:41 INFO - 'XPC_FLAGS': '0x0', 02:09:41 INFO - 'XPC_SERVICE_NAME': '0', 02:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 02:09:42 INFO - mozversion application_buildid: 20160628235640 02:09:42 INFO - mozversion application_changeset: 3ce3be36f582a04605c1966e65766298331fb9b6 02:09:42 INFO - mozversion application_display_name: Nightly 02:09:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:09:42 INFO - mozversion application_name: Firefox 02:09:42 INFO - mozversion application_remotingname: firefox 02:09:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:09:42 INFO - mozversion application_vendor: Mozilla 02:09:42 INFO - mozversion application_version: 50.0a1 02:09:42 INFO - mozversion platform_buildid: 20160628235640 02:09:42 INFO - mozversion platform_changeset: 3ce3be36f582a04605c1966e65766298331fb9b6 02:09:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:09:42 INFO - mozversion platform_version: 50.0a1 02:09:42 INFO - using testdate: 1467191382 02:09:42 INFO - actual date: 1467191382 02:09:42 INFO - starting webserver on 'localhost:53750' 02:09:42 INFO - SUITE-START | Running 2 tests 02:09:42 INFO - TEST-START | dromaeo_css 02:09:42 INFO - operating with platform_type : mac_ 02:09:42 INFO - Initialising browser for dromaeo_css test... 02:09:42 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpIxT8OG/profile http://localhost:53750/getInfo.html) 02:09:44 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 02:09:44 INFO - PROCESS | 1916 | colorDepth:24 02:09:44 INFO - PROCESS | 1916 | Browser inner width/height: 1024/689 02:09:44 INFO - PROCESS | 1916 | __metrics 02:09:44 INFO - PROCESS | 1916 | 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" 02:09:44 INFO - PROCESS | 1916 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:09:45 INFO - TEST-INFO | 1916: exit 0 02:09:45 INFO - Browser initialized. 02:09:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:09:45 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpIxT8OG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:57 INFO - PROCESS | 1918 | RSS: Main: 243261440 02:09:57 INFO - PROCESS | 1918 | 02:10:48 INFO - PROCESS | 1918 | 1467191448077 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] 02:12:58 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53750/tests/dromaeo/cssquery-ext.html) 02:13:00 INFO - PROCESS | 1918 | RSS: Main: 392798208 02:13:00 INFO - PROCESS | 1918 | 02:16:03 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53750/tests/dromaeo/cssquery-ext.html (next: http://localhost:53750/tests/dromaeo/cssquery-jquery.html) 02:16:04 INFO - PROCESS | 1918 | RSS: Main: 380518400 02:16:04 INFO - PROCESS | 1918 | 02:19:06 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53750/tests/dromaeo/cssquery-mootools.html) 02:19:07 INFO - PROCESS | 1918 | RSS: Main: 373436416 02:19:07 INFO - PROCESS | 1918 | 02:22:09 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53750/tests/dromaeo/cssquery-prototype.html) 02:22:10 INFO - PROCESS | 1918 | RSS: Main: 374382592 02:22:10 INFO - PROCESS | 1918 | 02:25:13 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53750/tests/dromaeo/cssquery-yui.html) 02:25:14 INFO - PROCESS | 1918 | RSS: Main: 339345408 02:25:14 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53750/tests/dromaeo/cssquery-yui.html (next: http://localhost:53750/tests/dromaeo/cssquery-dojo.html) 02:28:17 INFO - PROCESS | 1918 | RSS: Main: 384331776 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | __start_tp_report 02:28:17 INFO - PROCESS | 1918 | _x_x_mozilla_page_load 02:28:17 INFO - PROCESS | 1918 | _x_x_mozilla_page_load_details 02:28:17 INFO - PROCESS | 1918 | |i|pagename|runs| 02:28:17 INFO - PROCESS | 1918 | |0;dojo.html;3343.5319055332243;3347.677667321408;3373.139849338418;3377.054424761066;3378.256783507629;5558.77764889405;5606.411326810688;5611.3546942101675;5664.830055098349;5702.914456283154;5556.277683901088;5636.859078523039;5657.688827114517;5682.318121825377;5699.572532060091;4264.466941632296;5115.641905066647;5117.976404719053;5211.791528338862;5320.521153096221;5307.867303317429;5316.6544174628525;5317.255584218193;5322.654027488201;5372.489613486712;5108.66793658411;5174.301469301671;5179.456157103526;5196.766145523442;5254.054270231376;5197;5197.922031169535;5205.453427390145;5214.5306922376785;5219.71291578963;5137.6660517066275;5147.613928955343;5161.045206636747;5181.171012637998;5189.299444574972;5638.041532939369;5681.204631351614;5689.146628005791;5712.571557133231;5723.799667011676;6166.445019948226;6170.7531698732;6186.9381306186815;6194.008958566653;6201.782937597208;6098.32918378978;6147.354527774564;6210.534209934228;6251.749930002795;6265.185525881652;5766.423357664242;5794.536437085023;5819.73811178498;5838.095095260242;5841.153032810219;6269.185005949289;6269.561130720897;6286.528510361742;6299.905501417483;6303.590266632654;5561.221428999943;5862.736176872051;5913.46778789911;6083.877426005908;6130.264368275835;6177.351378105324;6235.033569796688;6236.251649801962;6236.345183755731;6253.218347706536;6131.938680613226;6167.660778657217;6173.290071641819;6174.567780255339;6179.567430279927;5973.880522389528;6044.063170208625;6143.56995010345;6189.071639254058;6214.533909956771;4900.803967841246;4931.13705101613;4941.752912354368;4982.77577509013;4987.700737955734;4406.405135306757;4417.889552761142;4421.115776844644;4421.248387774086;4451.7996690148375;5575.553955683536;5636.2391077204875;5659.943400566024;5724;5754.395788442237;6139.185504090456;6190.978488549339;6205.937940620626;6243.96878015607;6244.063390491463;5699.059655156852;5707.258056452634;5714.171445140514;5715.885682286331;5739.426057394227;5282.418933917266;5326.680399175984;5335.226392173113;5384.353877534721;5414.566834653218;6246.812595622138;6262.029385445263;6285.622862628165;6290.685465726787;6339.144215530844;6209;6227;6245.594036387621;6259.280182779039;6270.49836013127;6184.567080304516;6217.751289948533;6270.905936411049;6292.937070629235;6310.05349197624;6164.845878853064;6170.81487555374;6173.41352571505;6180.412860778219;6180.443760061616;6197.380261973766;6232.626042437469;6239.719212635351;6241.251049874044;6245;5869.6771677558145;5915.171875937458;5921.437463440966;5931.762729490944;6075.362086980804;5971.641701497924;5979.222701048836;5993.490553302844;5996.5502587307;6002.969985150221;5822.70886455684;5833.854153646193;5877.382874798084;5886.705664716661;5976.521878249817;5081.517255860687;6026.975414179512;6080.5389863111195;6097.2683278006925;6111.358307377662;5742.310922689304;5943.732532036155;5950.077737950624;5951.28584569837;5963.761449541969 02:28:17 INFO - PROCESS | 1918 | |1;ext.html;511.8362124120281;516.354556803995;528.0231571592557;531.1899353485934;599.8530360061784;24715;30194;31333.68666313339;31630.525542116888;42523.9369015774;35009.649903500955;42819;43184.56815431845;43201.783991080076;43217.13565728691;9216.032316606743;9390.5774240159;9390.67132650354;9390.85913711295;9399.060093990614;8645.265152462016;8823.867641985375;8824.691135810248;8939.195472407482;9528.094830991045;11603.477843497021;11808.291502509834;11839.704007399798;12060.939695301511;12066.396680166;11875.465604047795;11885.28688278706;11889.762204755943;11892.108091893057;11893.702657433547;8707.390482666216;8896.555172241427;8909.688160914402;11540.134489913205;11617.593384231595;32074;40220.597794021975;40321.59678403237;40371.394429083586;42215.36676949848;3037.3773376457775;3136.827474488902;3448.758586898918;3599.8200089995394;3838.9251009717323;32141.1964700882;32470.512942305886;32529.83735081333;32569.348613027607;33164.50253246203;3223.951640725391;3334.316465124668;3392.7625066245373;3394.100563350714;3432.9485057723905;505698;507619;507774;508269;508786.456067721;48899.75550122298;59871.40128598746;59954;60072;60178.69910650419;63111.684441578414;63124.684376577825;63207.68396158082;63381.36618633847;63479.6826015867;16114.919425402797;16805.41181058657;16830.663386732198;16845.915770421314;16854.241559129867;12830.55093071738;12986.155899866479;13005.804912926315;13012.804807927889;13021.414036368385;14860.108393496208;15143.697126057417;16155.596110097107;16477.91761041187;16569.922955007885;6637.535372523974;6827.48793840464;7121.71513139479;7456.4780465367985;7486.737964171228;827.4249396669258;1042.5048102151418;1047.8428235764695;1057.6351158850184;1080.8919108089285;30539.8473007638;30551.847240763655;30719.078427647208;30750.15130018971;31305.530417043763;1041.3439533094102;1063.6711566181098;1109.2401704832055;1141.7259857634108;1195.910306726999;15955.60110997211;16047.197640117947;16115.988851827862;16189.514314570582;16352.892950339397;662405;666946;667464;668053;668746;59576;59832;59940;60027;60155;1285.2995117660898;1391.8538553451742;1418.9290535473392;1429.2496439369415;1453.1136007035911;31263.84368078145;31513;31634.367312653158;32285.51571726473;32604.836975815917;50463.49536504588;50700.49299506958;50989.98020039652;51116.74441627768;51171.232431514305;480388;481082;482151;482395;484493;40173.598264018154;41441.58558414377;41641.79179104085;41730.49617022988;41746.791266043474;48126.75936620295;48809.75595122002;48829.755851220514;49642.00715985732;50045.49954500408;39203.607963919996;39860.601393985686;39927;40814.79592602018;40878.38682419826;38964.22071558496;39094.4135837957;39505.407418888164;39813.60186398099;40544.75641948696;36848;36981;37070.07324816793;38614.80692596632;38805.80597096997;33331.666683333824;33992.320153596294;35016.64983350134;35043.12392190113;35258;23517.29448116559;23621.70080645581;25978.830952607557;26497;26500.7349926506 02:28:17 INFO - PROCESS | 1918 | |2;jquery.html;383.9884803455896;387.3395860058599;392.53876694883525;403.4633936863971;407.69830325559076;20054.298099566517;21527.56944861106;21900.561988760215;21931.561368772636;21973.121075156974;20406.69389959152;21091.2618058368;21312.786872131273;22083.66874496884;22089.116435342607;4176.394422808691;6054.122152287916;6125.632462052291;6126.724297406605;6131.509479241672;4182.519010313822;4409.4488188976375;4427.225235583776;4434.600885920267;5962.672053037081;4309.332053531708;6580.276169621362;6583.539152259344;6603.339666033382;6613.735450581971;6377.107204991305;6589.5387322887655;6617.04052912325;6641.568298060634;6654.534182607219;3754.099016236111;5685.971570142165;5703.3441154267375;5710.971445142789;5736.024875771129;18856.81143188578;26104.477910441685;26463.338416539547;27440.313992150357;27450.705915290095;2251.819854411643;2790.6511686039244;3155.542446345267;3156.9684303156905;3274;14943.551693449213;16181.757273640906;16278.674426511403;16448.779414779092;16768.748468772978;1858.7769467663832;1868.560888191274;1884.8021654326933;1914.6936490161506;2036.0430597619095;119442.8055719449;119534;121426.39286803598;121444.39277803643;121973;10616.840747388795;10822.729431764268;11061.446927653586;11117.55529778816;11243.121123212479;13728.244946528037;13734.519291824738;13739.793903091462;13768.586942391745;13801.654958626115;6802.182634893454;8584.31325493959;8821.867671984925;8880.467171969702;8901;8895.066018068139;8902.599383027778;8934.910650893538;9057.230135438562;9103.681371151977;5164.586833053347;5679.858003549862;6445.709943052574;6591.604503729792;6624.701888415033;1520.7262692715196;1843.216632930999;1845.584743432717;1846.1599972012702;1847.639710256514;927.6614035876856;957.2916042128775;982.7444864335324;1018.6383833739064;1033.7467320506523;18377.90811045936;21994;22558;22654.66018009731;22801.543969120525;930.5905401623264;1022.6625213679467;1043.8173319669027;1112.3103675721104;1120.971975700614;10558.788824223473;11032.896710328903;11568.942155289169;12093.395330233629;12106.576269830513;595212;595259;603027;619236;620072;116233;117489.41255293669;120772;122061;122889.15666265013;986.1913231150531;990.6681261777242;1007.1388962437157;1007.7883644434604;1044.3681572648438;19392.61214775725;19513.317033903746;19606.215751369786;19661.115249813505;19731.605367892847;43952;48156;51779.741101294254;54684.632884178216;55205.723971379884;71782.28217717756;73574.63212683902;74284.62857685678;75996.62001689956;77956;7891.131975482577;8041.035075790943;8190.099089100075;8362.665493380196;8480.660773568989;13723.588292351245;13797.310134493437;13810.171389716648;13995.580132596038;14000.719985600435;11609.013233875216;11671.88328116708;11673;11919.284842909454;12005.339706316236;9769.85345219808;10932;11824.575961927612;12034.939825300817;12062.276263424223;8965.641374344954;11211.55153793839;11753.941230293794;11893.940530297294;12078.33569153705;7015.508914375945;8174.100848906734;8260.091389947222;8312.833743324978;8552.161285323686;11307.830382544433;11707.414629268333;11727.589534366598;11992.160548761853;11993.82009269879 02:28:17 INFO - PROCESS | 1918 | |3;mootools.html;1356.6472717093566;1521.8782497400205;1556.0197075842218;1730.6971280026;1904.6666833304178;7813.492123012007;8452.957735211323;8723.607437665305;8732.51971141587;8813.427127236726;8555.443896146746;8625.266852317545;8721.996970348411;8738.300935925126;8752.78118047049;2305.527366889792;2346.718393792739;2346.9530609387803;2347.4014126397747;2347.507023525062;2302.9654555181687;2332.8600283983014;2338.7661233876647;2339.122828939148;2342.7305859826083;2294.437862723635;2310.9537809243807;2317.629179331307;2321.6749655048307;2323.268170526287;2272.4001171442605;2293.575688497633;2300.217925905192;2304.331743794298;2317.7913987741017;2299.022915261024;2303.896324665394;2305.7578954209735;2306.1121468234683;2307.492351682627;8619.396642235046;8631;8828.911710882872;8829.470231786048;8830.161134692195;5161.767720452589;5321.122014867542;5326.946730532683;5331.1470164773455;5338.866528336784;3545.503629491873;3597.3165098631175;3624.3294990426857;3671.04552816267;3674.2284120334493;1070.9357438553711;1072.785442911421;1073.5920350266927;1079.266099052644;1094.7099018760034;11742.11934104937;11810.586629468013;11828.053755699524;11841.82237266433;11854.229475084092;3786.3373909565717;4361.890952726144;4405.427294451701;4516.570925762047;4529.8641040768825;9102.044285350075;9118.635254589875;9131.726048218565;9145.268378529701;9166.954165229132;5123.257127716534;5187.559057480156;5192.7403629818355;5193.636445448782;5199.480051994846;4310.892227694333;4398.318260669537;4490.057088011489;4674.555917187861;4875.390576177978;3700.5374328208973;3709.629037096323;3781.621837816251;3821.464994900716;3834.4631751554803;1127.5658871334595;1135.8069128248217;1144.5193018932068;1144.5593446522983;1147.977040459203;887.4896934262824;924.58393722825;938.8028514012134;943.7923656795494;1002.3584905660383;5347.0909945309395;5756.827295181151;5945.7621695132575;6083.787067452707;6203.472704820141;418.7215501691341;441.911617676466;442.77418516556787;448.40362318116826;457.0607401789355;3997.5802540733384;4038.970062634068;4050.2709512287483;4080.2655522006326;4097.688739603358;10362.792744145076;10634;10659.520321585547;10765.623203187852;10782.568697252022;10736.141108711285;10745.570177192982;10746.731331716614;10811.135109191246;10852.67441976742;6983.3714965653335;8166.1833816619055;8259.628316725762;8262.215089566482;8279.965004374573;5951;6002.369751176238;6192.628442293477;6201.906971395342;6205.410486003822;9660.95169524148;10127.24045696561;10134.949325253327;10140.391576505433;10194.43930583825;9722.465264410524;10120.139788118093;10162.695119146438;10238.078572928473;10277.331973421704;6943.3750962411605;7226.638668066471;7362.926370736438;7438.033055702724;7688;8303.4602750821;8414.6213420395;8506.574671266535;8511.702090426805;8529.616167272612;7347.8530429392185;7494.625268736432;7586.431017673586;7607.315341619281;7611.809704757426;7241.565506069653;7338.6697598607125;7339.559626422431;7475.588842613708;7480.962595186989;6980.301969803182;7027.648617569203;7050.929490705027;7057.117860267466;7060.399866011447;4875.1712208923855;4990.4261009982865;5058.974705126451;5092.108880945746;5107.029664363759;4955.380577427822;5071.112555302881;5134.204198349262;5165.535101840853;5254.106801843619 02:28:17 INFO - PROCESS | 1918 | |4;prototype.html;304.9801762885412;306.76532452673706;313.8791565247379;314.1862575928345;315.9320746039601;5385.730713464331;5443.891122177559;5471.06991811392;5471.5349195318395;5508.669479831213;4868.853934381966;4957.4058807364645;4999.450060493343;5428.891422171554;5443.428440013801;3842.0235056716306;3879.72841901067;3880.641775378623;4105.3020986432375;4124.463819703435;3040.9356725146245;4031.113155105872;4035.829609413281;4095.8361665533344;4118.897027574305;4069.7761623110864;4070.9008567686706;4080.9387859182134;4093.3450647896343;4142.896427589304;3540.716742660594;3830.195658911632;3867.7099217558516;4139.523954745183;4146.606072423115;3565.358235517606;3573.5533058367705;3583.928321433583;3591.1560783215923;3593.083763640281;4507.57178068083;4754.478566858606;5305.84302340107;5337.226102215196;5357.571394288448;4579.6261121663365;4715.269133284346;4730.858074257778;4758.191107511731;4761.40482439695;4543.45478542577;4901.166801643729;5653.293338332708;5688.212775739899;5759.827205183851;3507.474248701823;3643.7995910224927;3925.6456522499693;3942.2207343822824;3958.9208215835524;5131.433024608139;5803.82588522345;5844.7205589820005;6003.489703375175;6067.514598832127;3476.3916314644835;3850.7497012694084;3955.129871428281;3968.2857085724845;3980;3429.451287793941;3881.514810648669;4042;4078.877633670995;4091.652209562161;4140.420341152241;4365.607095361369;4557.589816916494;4557.680962332605;4738.597219236334;4905.068037072945;5118.25785261135;5758.769649213985;5770.220505568859;5789.131630255411;1142.3774043146504;1172.2966220267772;1388.9791653125212;1399.734050530396;1403.277312184226;801.8556659801292;838.287455662694;852.4799872078028;852.9082774049227;866.3372520022189;5190.792368305226;5287.656302340336;5389.9191512127345;5440.809571664972;5451.563874889999;5292.914952434741;5335.052705762447;5389.865253368619;5427.9144171165135;5927.940720592739;5063.493650634907;5323.893522129613;5328.413874473805;5364.14173732201;5388.278919145806;2709.972900270972;2783.540715781873;2876.741093301613;3086.830224337683;3131.6242050954033;4818.927716084261;5455.345358556999;5823.56323275756;6155.952803362365;6245.750169993149;4920.114379411669;5119.564836988823;5120.678896792712;5910.290765108129;6084.630958034495;5187.766550505236;5220.321358223407;5516.841463292673;6178.66017369049;6186.597871138361;5360.70516121617;5721.685307308138;5843.860447212753;5935.762569497172;5972.970135149297;4817.879553011203;5832.970835145967;5906.940930590639;5907.261592300963;5924.585279030426;6130.877382452237;6173.351798061319;6211.2857021443115;6211.409916057967;6247.156633854372;3190.6330771960593;3371.3425881952785;3384;3399.7110245629397;3414.84633191502;4471.8658440246845;4809.639277054305;4967.254911763264;5055.7219352935945;5071.847844564669;4406.294992801137;4585.380973568525;4812.855614331575;4824.927626085681;4845.238214217862;4252.4897012358715;4557.339185817971;4863.902721945612;4898.975505122452;5180.663256888291;5378.074005975582;5399.434164092369;5664.461876121762;5699.544036477155;5715.914261286167;5625.353084395183;5644.717764111696;5704.80033198836;5798.898209340212;5844.327902291121;5021.5229553192385;5705.543556515386;5705.857353566194;5733.569982251264;5740.225069615549 02:28:17 INFO - PROCESS | 1918 | |5;yui.html;703.8873780195169;739.5193124469095;796.0208943000109;801.5110782422724;826.1325608111481;15192.696146077073;15764.132972686526;15794.60513487162;15810.4466343678;15818.446354377598;13220.40508177132;13270.800937985938;13285.800712989312;13306.06857519974;13312.267825269606;708.3624737736027;730.7588495796401;895.6954635423971;904.6562306323588;909.1317791509093;874.8075423406872;905.1536813079791;909.5088652127843;910.7996240827008;911.7766147293889;953.2993249961307;960.7790208252106;966.9178119859786;969.0116081596767;969.6945462179391;697.0415678442142;921.1341339141253;962.1196605106319;962.1917589225014;962.6486332488627;710.8258476673196;712.9287071292881;713.4470785141505;714.2714431280065;714.4784307455535;15380.92309538445;15398.307076181598;15428.151451670154;15456.149911754848;15480.5355839325;13611.387487563083;13915.999999999898;13917.86082139186;14009.509667161601;14081.85918140826;12753.171043882117;12829.67925801853;12940.547080852126;13042.282674452901;13344.933275333658;4450.10997800438;4477.216487114774;4480.932786008212;4481.551844815525;4676.438827340707;116669.82534188517;119570;119960;123469.9999999991;125023.37488312591;10928.398938058483;10965.945170274097;10988.780224395627;11027.117830573536;11181.664550063511;18504.352347667766;20646.483837903874;21438.82086485227;21631.67552486714;21694.674579881314;8081.555514446762;8149.511029338259;8165.836683266301;8318.70884519039;8329.250367466835;4530.977345113253;4547.7498737569085;4560.156371071363;4599.931001034987;4768.117898188846;3400.812955287483;3521.6302288259362;3522.823858807101;3525.012996361023;3529.1353618363664;619.801663467695;643.6685107169811;644.5906849150823;656.1666683312167;659.1233659233209;574.9051406517962;577.3995045153077;613.4908026338129;636.8121404185777;647.8250872264463;8916.242119419921;9050.456972581535;9148.261830252231;9195.494247816434;9339.252859771203;585.5696063393402;600.0009983377714;603.2820943077724;623.9750409983641;639.68015992004;3931.3709806430834;4395;4400.889977750582;4402.713823601455;4566.589006989387;159630.20184899002;161495.3850461504;165095.17452412902;166231;168227;70307;132990.33504832414;137052;137385;138760.4107301761;114615.85384146219;116841;118034;121356;121823.39088304502;8421.663133474838;8565.48607083577;8630.611622477129;8782.297416206817;8928.15182557656;67098;67511.98732018925;67890;69341;70493;90585;103354.79330528066;105124.94875051151;105769.47115264375;106996.46501767442;11552.360867714408;11798.528058877891;11849.644510664693;12007.519699211934;12177.878221217674;12418.81371779442;12545.749085018431;12651.177673451197;12951.611451656465;13031.47874085064;12026.338551379758;12231.633051008484;12269.079819013432;12425.813612795997;12508.562200322946;11761.176717629683;11904;12124.030077593596;12528;12543.3101179436;11844.1709080367;11863.76272474563;11868.940655297014;11970.76058478843;12500.37498125072;9912.348223375348;10145.028172367402;10163.186945044527;10321.071103600712;10493.685189444328;9922.454265015493;10180.440075795903;10204.38773673582;10211.081002709792;10251.538680759533 02:28:17 INFO - PROCESS | 1918 | __end_tp_report 02:28:17 INFO - PROCESS | 1918 | __start_cc_report 02:28:17 INFO - PROCESS | 1918 | _x_x_mozilla_cycle_collect,1575 02:28:17 INFO - PROCESS | 1918 | __end_cc_report 02:28:17 INFO - PROCESS | 1918 | __startTimestamp1467192497535__endTimestamp 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | ------- Summary: start ------- 02:28:17 INFO - PROCESS | 1918 | Number of tests: 6 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | [#0] dojo.html Cycles:165 Average:5703.24 Median:5877.38 stddev:631.94 (10.8%) stddev-sans-first:606.16 02:28:17 INFO - PROCESS | 1918 | Values: 3343.5 3347.7 3373.1 3377.1 3378.3 5558.8 5606.4 5611.4 5664.8 5702.9 5556.3 5636.9 5657.7 5682.3 5699.6 4264.5 5115.6 5118.0 5211.8 5320.5 5307.9 5316.7 5317.3 5322.7 5372.5 5108.7 5174.3 5179.5 5196.8 5254.1 5197.0 5197.9 5205.5 5214.5 5219.7 5137.7 5147.6 5161.0 5181.2 5189.3 5638.0 5681.2 5689.1 5712.6 5723.8 6166.4 6170.8 6186.9 6194.0 6201.8 6098.3 6147.4 6210.5 6251.7 6265.2 5766.4 5794.5 5819.7 5838.1 5841.2 6269.2 6269.6 6286.5 6299.9 6303.6 5561.2 5862.7 5913.5 6083.9 6130.3 6177.4 6235.0 6236.3 6236.3 6253.2 6131.9 6167.7 6173.3 6174.6 6179.6 5973.9 6044.1 6143.6 6189.1 6214.5 4900.8 4931.1 4941.8 4982.8 4987.7 4406.4 4417.9 4421.1 4421.2 4451.8 5575.6 5636.2 5659.9 5724.0 5754.4 6139.2 6191.0 6205.9 6244.0 6244.1 5699.1 5707.3 5714.2 5715.9 5739.4 5282.4 5326.7 5335.2 5384.4 5414.6 6246.8 6262.0 6285.6 6290.7 6339.1 6209.0 6227.0 6245.6 6259.3 6270.5 6184.6 6217.8 6270.9 6292.9 6310.1 6164.8 6170.8 6173.4 6180.4 6180.4 6197.4 6232.6 6239.7 6241.3 6245.0 5869.7 5915.2 5921.4 5931.8 6075.4 5971.6 5979.2 5993.5 5996.6 6003.0 5822.7 5833.9 5877.4 5886.7 5976.5 5081.5 6027.0 6080.5 6097.3 6111.4 5742.3 5943.7 5950.1 5951.3 5963.8 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | [#1] ext.html Cycles:180 Average:69312.91 Median:38710.31 stddev:148992.39 (384.9%) stddev-sans-first:149320.81 02:28:17 INFO - PROCESS | 1918 | Values: 511.8 516.4 528.0 531.2 599.9 24715.0 30194.0 31333.7 31630.5 42523.9 35009.6 42819.0 43184.6 43201.8 43217.1 9216.0 9390.6 9390.7 9390.9 9399.1 8645.3 8823.9 8824.7 8939.2 9528.1 11603.5 11808.3 11839.7 12060.9 12066.4 11875.5 11885.3 11889.8 11892.1 11893.7 8707.4 8896.6 8909.7 11540.1 11617.6 32074.0 40220.6 40321.6 40371.4 42215.4 3037.4 3136.8 3448.8 3599.8 3838.9 32141.2 32470.5 32529.8 32569.3 33164.5 3224.0 3334.3 3392.8 3394.1 3432.9 505698.0 507619.0 507774.0 508269.0 508786.5 48899.8 59871.4 59954.0 60072.0 60178.7 63111.7 63124.7 63207.7 63381.4 63479.7 16114.9 16805.4 16830.7 16845.9 16854.2 12830.6 12986.2 13005.8 13012.8 13021.4 14860.1 15143.7 16155.6 16477.9 16569.9 6637.5 6827.5 7121.7 7456.5 7486.7 827.4 1042.5 1047.8 1057.6 1080.9 30539.8 30551.8 30719.1 30750.2 31305.5 1041.3 1063.7 1109.2 1141.7 1195.9 15955.6 16047.2 16116.0 16189.5 16352.9 662405.0 666946.0 667464.0 668053.0 668746.0 59576.0 59832.0 59940.0 60027.0 60155.0 1285.3 1391.9 1418.9 1429.2 1453.1 31263.8 31513.0 31634.4 32285.5 32604.8 50463.5 50700.5 50990.0 51116.7 51171.2 480388.0 481082.0 482151.0 482395.0 484493.0 40173.6 41441.6 41641.8 41730.5 41746.8 48126.8 48809.8 48829.8 49642.0 50045.5 39203.6 39860.6 39927.0 40814.8 40878.4 38964.2 39094.4 39505.4 39813.6 40544.8 36848.0 36981.0 37070.1 38614.8 38805.8 33331.7 33992.3 35016.6 35043.1 35258.0 23517.3 23621.7 25978.8 26497.0 26500.7 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | [#2] jquery.html Cycles:180 Average:35347.87 Median:12404.91 stddev:100912.41 (813.5%) stddev-sans-first:101161.35 02:28:17 INFO - PROCESS | 1918 | Values: 384.0 387.3 392.5 403.5 407.7 20054.3 21527.6 21900.6 21931.6 21973.1 20406.7 21091.3 21312.8 22083.7 22089.1 4176.4 6054.1 6125.6 6126.7 6131.5 4182.5 4409.4 4427.2 4434.6 5962.7 4309.3 6580.3 6583.5 6603.3 6613.7 6377.1 6589.5 6617.0 6641.6 6654.5 3754.1 5686.0 5703.3 5711.0 5736.0 18856.8 26104.5 26463.3 27440.3 27450.7 2251.8 2790.7 3155.5 3157.0 3274.0 14943.6 16181.8 16278.7 16448.8 16768.7 1858.8 1868.6 1884.8 1914.7 2036.0 119442.8 119534.0 121426.4 121444.4 121973.0 10616.8 10822.7 11061.4 11117.6 11243.1 13728.2 13734.5 13739.8 13768.6 13801.7 6802.2 8584.3 8821.9 8880.5 8901.0 8895.1 8902.6 8934.9 9057.2 9103.7 5164.6 5679.9 6445.7 6591.6 6624.7 1520.7 1843.2 1845.6 1846.2 1847.6 927.7 957.3 982.7 1018.6 1033.7 18377.9 21994.0 22558.0 22654.7 22801.5 930.6 1022.7 1043.8 1112.3 1121.0 10558.8 11032.9 11568.9 12093.4 12106.6 595212.0 595259.0 603027.0 619236.0 620072.0 116233.0 117489.4 120772.0 122061.0 122889.2 986.2 990.7 1007.1 1007.8 1044.4 19392.6 19513.3 19606.2 19661.1 19731.6 43952.0 48156.0 51779.7 54684.6 55205.7 71782.3 73574.6 74284.6 75996.6 77956.0 7891.1 8041.0 8190.1 8362.7 8480.7 13723.6 13797.3 13810.2 13995.6 14000.7 11609.0 11671.9 11673.0 11919.3 12005.3 9769.9 10932.0 11824.6 12034.9 12062.3 8965.6 11211.6 11753.9 11893.9 12078.3 7015.5 8174.1 8260.1 8312.8 8552.2 11307.8 11707.4 11727.6 11992.2 11993.8 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | [#3] mootools.html Cycles:180 Average:5663.36 Median:2493.46 stddev:3214.02 (128.9%) stddev-sans-first:3206.74 02:28:17 INFO - PROCESS | 1918 | Values: 1356.6 1521.9 1556.0 1730.7 1904.7 7813.5 8453.0 8723.6 8732.5 8813.4 8555.4 8625.3 8722.0 8738.3 8752.8 2305.5 2346.7 2347.0 2347.4 2347.5 2303.0 2332.9 2338.8 2339.1 2342.7 2294.4 2311.0 2317.6 2321.7 2323.3 2272.4 2293.6 2300.2 2304.3 2317.8 2299.0 2303.9 2305.8 2306.1 2307.5 8619.4 8631.0 8828.9 8829.5 8830.2 5161.8 5321.1 5326.9 5331.1 5338.9 3545.5 3597.3 3624.3 3671.0 3674.2 1070.9 1072.8 1073.6 1079.3 1094.7 11742.1 11810.6 11828.1 11841.8 11854.2 3786.3 4361.9 4405.4 4516.6 4529.9 9102.0 9118.6 9131.7 9145.3 9167.0 5123.3 5187.6 5192.7 5193.6 5199.5 4310.9 4398.3 4490.1 4674.6 4875.4 3700.5 3709.6 3781.6 3821.5 3834.5 1127.6 1135.8 1144.5 1144.6 1148.0 887.5 924.6 938.8 943.8 1002.4 5347.1 5756.8 5945.8 6083.8 6203.5 418.7 441.9 442.8 448.4 457.1 3997.6 4039.0 4050.3 4080.3 4097.7 10362.8 10634.0 10659.5 10765.6 10782.6 10736.1 10745.6 10746.7 10811.1 10852.7 6983.4 8166.2 8259.6 8262.2 8280.0 5951.0 6002.4 6192.6 6201.9 6205.4 9661.0 10127.2 10134.9 10140.4 10194.4 9722.5 10120.1 10162.7 10238.1 10277.3 6943.4 7226.6 7362.9 7438.0 7688.0 8303.5 8414.6 8506.6 8511.7 8529.6 7347.9 7494.6 7586.4 7607.3 7611.8 7241.6 7338.7 7339.6 7475.6 7481.0 6980.3 7027.6 7050.9 7057.1 7060.4 4875.2 4990.4 5059.0 5092.1 5107.0 4955.4 5071.1 5134.2 5165.5 5254.1 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | [#4] prototype.html Cycles:180 Average:4522.32 Median:4962.33 stddev:1413.10 (28.5%) stddev-sans-first:1381.15 02:28:17 INFO - PROCESS | 1918 | Values: 305.0 306.8 313.9 314.2 315.9 5385.7 5443.9 5471.1 5471.5 5508.7 4868.9 4957.4 4999.5 5428.9 5443.4 3842.0 3879.7 3880.6 4105.3 4124.5 3040.9 4031.1 4035.8 4095.8 4118.9 4069.8 4070.9 4080.9 4093.3 4142.9 3540.7 3830.2 3867.7 4139.5 4146.6 3565.4 3573.6 3583.9 3591.2 3593.1 4507.6 4754.5 5305.8 5337.2 5357.6 4579.6 4715.3 4730.9 4758.2 4761.4 4543.5 4901.2 5653.3 5688.2 5759.8 3507.5 3643.8 3925.6 3942.2 3958.9 5131.4 5803.8 5844.7 6003.5 6067.5 3476.4 3850.7 3955.1 3968.3 3980.0 3429.5 3881.5 4042.0 4078.9 4091.7 4140.4 4365.6 4557.6 4557.7 4738.6 4905.1 5118.3 5758.8 5770.2 5789.1 1142.4 1172.3 1389.0 1399.7 1403.3 801.9 838.3 852.5 852.9 866.3 5190.8 5287.7 5389.9 5440.8 5451.6 5292.9 5335.1 5389.9 5427.9 5927.9 5063.5 5323.9 5328.4 5364.1 5388.3 2710.0 2783.5 2876.7 3086.8 3131.6 4818.9 5455.3 5823.6 6156.0 6245.8 4920.1 5119.6 5120.7 5910.3 6084.6 5187.8 5220.3 5516.8 6178.7 6186.6 5360.7 5721.7 5843.9 5935.8 5973.0 4817.9 5833.0 5906.9 5907.3 5924.6 6130.9 6173.4 6211.3 6211.4 6247.2 3190.6 3371.3 3384.0 3399.7 3414.8 4471.9 4809.6 4967.3 5055.7 5071.8 4406.3 4585.4 4812.9 4824.9 4845.2 4252.5 4557.3 4863.9 4899.0 5180.7 5378.1 5399.4 5664.5 5699.5 5715.9 5625.4 5644.7 5704.8 5798.9 5844.3 5021.5 5705.5 5705.9 5733.6 5740.2 02:28:17 INFO - PROCESS | 1918 | 02:28:17 INFO - PROCESS | 1918 | [#5] yui.html Cycles:180 Average:25893.18 Median:12547.74 stddev:42759.03 (340.8%) stddev-sans-first:42837.15 02:28:17 INFO - PROCESS | 1918 | Values: 703.9 739.5 796.0 801.5 826.1 15192.7 15764.1 15794.6 15810.4 15818.4 13220.4 13270.8 13285.8 13306.1 13312.3 708.4 730.8 895.7 904.7 909.1 874.8 905.2 909.5 910.8 911.8 953.3 960.8 966.9 969.0 969.7 697.0 921.1 962.1 962.2 962.6 710.8 712.9 713.4 714.3 714.5 15380.9 15398.3 15428.2 15456.1 15480.5 13611.4 13916.0 13917.9 14009.5 14081.9 12753.2 12829.7 12940.5 13042.3 13344.9 4450.1 4477.2 4480.9 4481.6 4676.4 116669.8 119570.0 119960.0 123470.0 125023.4 10928.4 10965.9 10988.8 11027.1 11181.7 18504.4 20646.5 21438.8 21631.7 21694.7 8081.6 8149.5 8165.8 8318.7 8329.3 4531.0 4547.7 4560.2 4599.9 4768.1 3400.8 3521.6 3522.8 3525.0 3529.1 619.8 643.7 644.6 656.2 659.1 574.9 577.4 613.5 636.8 647.8 8916.2 9050.5 9148.3 9195.5 9339.3 585.6 600.0 603.3 624.0 639.7 3931.4 4395.0 4400.9 4402.7 4566.6 159630.2 161495.4 165095.2 166231.0 168227.0 70307.0 132990.3 137052.0 137385.0 138760.4 114615.9 116841.0 118034.0 121356.0 121823.4 8421.7 8565.5 8630.6 8782.3 8928.2 67098.0 67512.0 67890.0 69341.0 70493.0 90585.0 103354.8 105124.9 105769.5 106996.5 11552.4 11798.5 11849.6 12007.5 12177.9 12418.8 12545.7 12651.2 12951.6 13031.5 12026.3 12231.6 12269.1 12425.8 12508.6 11761.2 11904.0 12124.0 12528.0 12543.3 11844.2 11863.8 11868.9 11970.8 12500.4 9912.3 10145.0 10163.2 10321.1 10493.7 9922.5 10180.4 10204.4 10211.1 10251.5 02:28:17 INFO - PROCESS | 1918 | -------- Summary: end -------- 02:28:17 INFO - PROCESS | 1918 | 02:28:18 INFO - TEST-INFO | 1918: exit 0 02:28:18 INFO - TEST-OK | dromaeo_css | took 1115974ms 02:28:18 INFO - TEST-START | kraken 02:28:18 INFO - operating with platform_type : mac_ 02:28:18 INFO - Initialising browser for kraken test... 02:28:18 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmppeOQBG/profile http://localhost:53750/getInfo.html) 02:28:20 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 02:28:20 INFO - PROCESS | 1922 | colorDepth:24 02:28:20 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 02:28:20 INFO - PROCESS | 1922 | __metrics 02:28:20 INFO - PROCESS | 1922 | 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" 02:28:20 INFO - PROCESS | 1922 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:28:21 INFO - TEST-INFO | 1922: exit 0 02:28:21 INFO - Browser initialized. 02:28:21 INFO - Running cycle 1/1 for kraken test... 02:28:21 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmppeOQBG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:33 INFO - PROCESS | 1923 | RSS: Main: 243519488 02:28:33 INFO - PROCESS | 1923 | 02:28:35 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53750/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:36 INFO - PROCESS | 1923 | RSS: Main: 294121472 02:28:36 INFO - PROCESS | 1923 | 02:28:39 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53750/tests/kraken/driver.html?testName=audio-dft) 02:28:39 INFO - PROCESS | 1923 | RSS: Main: 303595520 02:28:39 INFO - PROCESS | 1923 | 02:28:43 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53750/tests/kraken/driver.html?testName=audio-fft) 02:28:44 INFO - PROCESS | 1923 | RSS: Main: 388571136 02:28:44 INFO - PROCESS | 1923 | 02:28:46 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53750/tests/kraken/driver.html?testName=audio-oscillator) 02:28:46 INFO - PROCESS | 1923 | RSS: Main: 291278848 02:28:46 INFO - PROCESS | 1923 | 02:28:48 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:49 INFO - PROCESS | 1923 | RSS: Main: 295202816 02:28:49 INFO - PROCESS | 1923 | 02:28:52 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53750/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:52 INFO - PROCESS | 1923 | RSS: Main: 330571776 02:28:52 INFO - PROCESS | 1923 | 02:28:55 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53750/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:56 INFO - PROCESS | 1923 | RSS: Main: 334835712 02:28:56 INFO - PROCESS | 1923 | 02:28:59 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53750/tests/kraken/driver.html?testName=json-parse-financial) 02:28:59 INFO - PROCESS | 1923 | RSS: Main: 334790656 02:28:59 INFO - PROCESS | 1923 | 02:29:01 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:29:01 INFO - PROCESS | 1923 | RSS: Main: 313241600 02:29:01 INFO - PROCESS | 1923 | 02:29:03 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:29:04 INFO - PROCESS | 1923 | RSS: Main: 319340544 02:29:04 INFO - PROCESS | 1923 | 02:29:06 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:07 INFO - PROCESS | 1923 | RSS: Main: 321376256 02:29:07 INFO - PROCESS | 1923 | 02:29:10 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:10 INFO - PROCESS | 1923 | RSS: Main: 336887808 02:29:10 INFO - PROCESS | 1923 | 02:29:13 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:14 INFO - PROCESS | 1923 | RSS: Main: 333094912 02:29:14 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:53750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53750/tests/kraken/driver.html?testName=ai-astar) 02:29:16 INFO - PROCESS | 1923 | RSS: Main: 376639488 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | __start_tp_report 02:29:16 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 02:29:16 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 02:29:16 INFO - PROCESS | 1923 | |i|pagename|runs| 02:29:16 INFO - PROCESS | 1923 | |0;ai-astar;101;114;113;113;114;112;113;113;113;113 02:29:16 INFO - PROCESS | 1923 | |1;audio-beat-detection;156;118;118;167;121;117;137;117;152;119 02:29:16 INFO - PROCESS | 1923 | |2;audio-dft;184;185;185;187;182;183;181;183;184;184 02:29:16 INFO - PROCESS | 1923 | |3;audio-fft;77;73;58;108;59;57;61;60;125;56 02:29:16 INFO - PROCESS | 1923 | |4;audio-oscillator;83;88;94;71;73;67;95;70;66;102 02:29:16 INFO - PROCESS | 1923 | |5;imaging-gaussian-blur;118;130;87;84;87;84;88;85;87;84 02:29:16 INFO - PROCESS | 1923 | |6;imaging-darkroom;93;93;93;93;94;103;149;125;93;93 02:29:16 INFO - PROCESS | 1923 | |7;imaging-desaturate;86;85;85;86;84;84;83;86;84;86 02:29:16 INFO - PROCESS | 1923 | |8;json-parse-financial;54;54;54;54;53;53;55;54;53;55 02:29:16 INFO - PROCESS | 1923 | |9;json-stringify-tinderbox;65;65;73;77;75;73;68;69;70;71 02:29:16 INFO - PROCESS | 1923 | |10;stanford-crypto-aes;83;85;85;85;86;86;99;102;101;75 02:29:16 INFO - PROCESS | 1923 | |11;stanford-crypto-ccm;138;154;142;138;136;137;137;136;140;151 02:29:16 INFO - PROCESS | 1923 | |12;stanford-crypto-pbkdf2;174;173;172;173;173;173;172;171;172;169 02:29:16 INFO - PROCESS | 1923 | |13;stanford-crypto-sha256-iterative;86;86;87;84;66;68;67;66;66;66 02:29:16 INFO - PROCESS | 1923 | __end_tp_report 02:29:16 INFO - PROCESS | 1923 | __start_cc_report 02:29:16 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,2172 02:29:16 INFO - PROCESS | 1923 | __end_cc_report 02:29:16 INFO - PROCESS | 1923 | __startTimestamp1467192556584__endTimestamp 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | ------- Summary: start ------- 02:29:16 INFO - PROCESS | 1923 | Number of tests: 14 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.87 (3.4%) stddev-sans-first:0.60 02:29:16 INFO - PROCESS | 1923 | Values: 101.0 114.0 113.0 113.0 114.0 112.0 113.0 113.0 113.0 113.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:129.00 stddev:19.31 (15.0%) stddev-sans-first:18.47 02:29:16 INFO - PROCESS | 1923 | Values: 156.0 118.0 118.0 167.0 121.0 117.0 137.0 117.0 152.0 119.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.69 (0.9%) stddev-sans-first:1.79 02:29:16 INFO - PROCESS | 1923 | Values: 184.0 185.0 185.0 187.0 182.0 183.0 181.0 183.0 184.0 184.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#3] audio-fft Cycles:10 Average:73.40 Median:59.50 stddev:24.09 (40.5%) stddev-sans-first:25.51 02:29:16 INFO - PROCESS | 1923 | Values: 77.0 73.0 58.0 108.0 59.0 57.0 61.0 60.0 125.0 56.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:78.00 stddev:13.19 (16.9%) stddev-sans-first:13.96 02:29:16 INFO - PROCESS | 1923 | Values: 83.0 88.0 94.0 71.0 73.0 67.0 95.0 70.0 66.0 102.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:86.00 stddev:16.44 (19.1%) stddev-sans-first:14.83 02:29:16 INFO - PROCESS | 1923 | Values: 118.0 130.0 87.0 84.0 87.0 84.0 88.0 85.0 87.0 84.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:93.00 stddev:19.09 (20.5%) stddev-sans-first:19.91 02:29:16 INFO - PROCESS | 1923 | Values: 93.0 93.0 93.0 93.0 94.0 103.0 149.0 125.0 93.0 93.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 02:29:16 INFO - PROCESS | 1923 | Values: 86.0 85.0 85.0 86.0 84.0 84.0 83.0 86.0 84.0 86.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 02:29:16 INFO - PROCESS | 1923 | Values: 54.0 54.0 54.0 54.0 53.0 53.0 55.0 54.0 53.0 55.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:72.00 stddev:4.01 (5.6%) stddev-sans-first:3.70 02:29:16 INFO - PROCESS | 1923 | Values: 65.0 65.0 73.0 77.0 75.0 73.0 68.0 69.0 70.0 71.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.00 stddev:8.88 (10.5%) stddev-sans-first:9.18 02:29:16 INFO - PROCESS | 1923 | Values: 83.0 85.0 85.0 85.0 86.0 86.0 99.0 102.0 101.0 75.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:139.00 stddev:6.42 (4.6%) stddev-sans-first:6.72 02:29:16 INFO - PROCESS | 1923 | Values: 138.0 154.0 142.0 138.0 136.0 137.0 137.0 136.0 140.0 151.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:1.40 (0.8%) stddev-sans-first:1.32 02:29:16 INFO - PROCESS | 1923 | Values: 174.0 173.0 172.0 173.0 173.0 173.0 172.0 171.0 172.0 169.0 02:29:16 INFO - PROCESS | 1923 | 02:29:16 INFO - PROCESS | 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:76.00 stddev:9.99 (13.1%) stddev-sans-first:9.64 02:29:16 INFO - PROCESS | 1923 | Values: 86.0 86.0 87.0 84.0 66.0 68.0 67.0 66.0 66.0 66.0 02:29:16 INFO - PROCESS | 1923 | -------- Summary: end -------- 02:29:16 INFO - PROCESS | 1923 | 02:29:17 INFO - TEST-INFO | 1923: exit 0 02:29:17 INFO - TEST-OK | kraken | took 59261ms 02:29:17 INFO - SUITE-END | took 1175s 02:29:17 INFO - Completed test suite (00:19:35) 02:29:17 INFO - javascript benchmark 02:29:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.5319055332243, 3347.677667321408, 3373.139849338418, 3377.054424761066, 3378.256783507629, 5558.77764889405, 5606.411326810688, 5611.3546942101675, 5664.830055098349, 5702.914456283154, 5556.277683901088, 5636.859078523039, 5657.688827114517, 5682.318121825377, 5699.572532060091, 4264.466941632296, 5115.641905066647, 5117.976404719053, 5211.791528338862, 5320.521153096221, 5307.867303317429, 5316.6544174628525, 5317.255584218193, 5322.654027488201, 5372.489613486712, 5108.66793658411, 5174.301469301671, 5179.456157103526, 5196.766145523442, 5254.054270231376, 5197.0, 5197.922031169535, 5205.453427390145, 5214.5306922376785, 5219.71291578963, 5137.6660517066275, 5147.613928955343, 5161.045206636747, 5181.171012637998, 5189.299444574972, 5638.041532939369, 5681.204631351614, 5689.146628005791, 5712.571557133231, 5723.799667011676, 6166.445019948226, 6170.7531698732, 6186.9381306186815, 6194.008958566653, 6201.782937597208, 6098.32918378978, 6147.354527774564, 6210.534209934228, 6251.749930002795, 6265.185525881652, 5766.423357664242, 5794.536437085023, 5819.73811178498, 5838.095095260242, 5841.153032810219, 6269.185005949289, 6269.561130720897, 6286.528510361742, 6299.905501417483, 6303.590266632654, 5561.221428999943, 5862.736176872051, 5913.46778789911, 6083.877426005908, 6130.264368275835, 6177.351378105324, 6235.033569796688, 6236.251649801962, 6236.345183755731, 6253.218347706536, 6131.938680613226, 6167.660778657217, 6173.290071641819, 6174.567780255339, 6179.567430279927, 5973.880522389528, 6044.063170208625, 6143.56995010345, 6189.071639254058, 6214.533909956771, 4900.803967841246, 4931.13705101613, 4941.752912354368, 4982.77577509013, 4987.700737955734, 4406.405135306757, 4417.889552761142, 4421.115776844644, 4421.248387774086, 4451.7996690148375, 5575.553955683536, 5636.2391077204875, 5659.943400566024, 5724.0, 5754.395788442237, 6139.185504090456, 6190.978488549339, 6205.937940620626, 6243.96878015607, 6244.063390491463, 5699.059655156852, 5707.258056452634, 5714.171445140514, 5715.885682286331, 5739.426057394227, 5282.418933917266, 5326.680399175984, 5335.226392173113, 5384.353877534721, 5414.566834653218, 6246.812595622138, 6262.029385445263, 6285.622862628165, 6290.685465726787, 6339.144215530844, 6209.0, 6227.0, 6245.594036387621, 6259.280182779039, 6270.49836013127, 6184.567080304516, 6217.751289948533, 6270.905936411049, 6292.937070629235, 6310.05349197624, 6164.845878853064, 6170.81487555374, 6173.41352571505, 6180.412860778219, 6180.443760061616, 6197.380261973766, 6232.626042437469, 6239.719212635351, 6241.251049874044, 6245.0, 5869.6771677558145, 5915.171875937458, 5921.437463440966, 5931.762729490944, 6075.362086980804, 5971.641701497924, 5979.222701048836, 5993.490553302844, 5996.5502587307, 6002.969985150221, 5822.70886455684, 5833.854153646193, 5877.382874798084, 5886.705664716661, 5976.521878249817, 5081.517255860687, 6026.975414179512, 6080.5389863111195, 6097.2683278006925, 6111.358307377662, 5742.310922689304, 5943.732532036155, 5950.077737950624, 5951.28584569837, 5963.761449541969], "value": 5663.103072639799, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.8362124120281, 516.354556803995, 528.0231571592557, 531.1899353485934, 599.8530360061784, 24715.0, 30194.0, 31333.68666313339, 31630.525542116888, 42523.9369015774, 35009.649903500955, 42819.0, 43184.56815431845, 43201.783991080076, 43217.13565728691, 9216.032316606743, 9390.5774240159, 9390.67132650354, 9390.85913711295, 9399.060093990614, 8645.265152462016, 8823.867641985375, 8824.691135810248, 8939.195472407482, 9528.094830991045, 11603.477843497021, 11808.291502509834, 11839.704007399798, 12060.939695301511, 12066.396680166, 11875.465604047795, 11885.28688278706, 11889.762204755943, 11892.108091893057, 11893.702657433547, 8707.390482666216, 8896.555172241427, 8909.688160914402, 11540.134489913205, 11617.593384231595, 32074.0, 40220.597794021975, 40321.59678403237, 40371.394429083586, 42215.36676949848, 3037.3773376457775, 3136.827474488902, 3448.758586898918, 3599.8200089995394, 3838.9251009717323, 32141.1964700882, 32470.512942305886, 32529.83735081333, 32569.348613027607, 33164.50253246203, 3223.951640725391, 3334.316465124668, 3392.7625066245373, 3394.100563350714, 3432.9485057723905, 505698.0, 507619.0, 507774.0, 508269.0, 508786.456067721, 48899.75550122298, 59871.40128598746, 59954.0, 60072.0, 60178.69910650419, 63111.684441578414, 63124.684376577825, 63207.68396158082, 63381.36618633847, 63479.6826015867, 16114.919425402797, 16805.41181058657, 16830.663386732198, 16845.915770421314, 16854.241559129867, 12830.55093071738, 12986.155899866479, 13005.804912926315, 13012.804807927889, 13021.414036368385, 14860.108393496208, 15143.697126057417, 16155.596110097107, 16477.91761041187, 16569.922955007885, 6637.535372523974, 6827.48793840464, 7121.71513139479, 7456.4780465367985, 7486.737964171228, 827.4249396669258, 1042.5048102151418, 1047.8428235764695, 1057.6351158850184, 1080.8919108089285, 30539.8473007638, 30551.847240763655, 30719.078427647208, 30750.15130018971, 31305.530417043763, 1041.3439533094102, 1063.6711566181098, 1109.2401704832055, 1141.7259857634108, 1195.910306726999, 15955.60110997211, 16047.197640117947, 16115.988851827862, 16189.514314570582, 16352.892950339397, 662405.0, 666946.0, 667464.0, 668053.0, 668746.0, 59576.0, 59832.0, 59940.0, 60027.0, 60155.0, 1285.2995117660898, 1391.8538553451742, 1418.9290535473392, 1429.2496439369415, 1453.1136007035911, 31263.84368078145, 31513.0, 31634.367312653158, 32285.51571726473, 32604.836975815917, 50463.49536504588, 50700.49299506958, 50989.98020039652, 51116.74441627768, 51171.232431514305, 480388.0, 481082.0, 482151.0, 482395.0, 484493.0, 40173.598264018154, 41441.58558414377, 41641.79179104085, 41730.49617022988, 41746.791266043474, 48126.75936620295, 48809.75595122002, 48829.755851220514, 49642.00715985732, 50045.49954500408, 39203.607963919996, 39860.601393985686, 39927.0, 40814.79592602018, 40878.38682419826, 38964.22071558496, 39094.4135837957, 39505.407418888164, 39813.60186398099, 40544.75641948696, 36848.0, 36981.0, 37070.07324816793, 38614.80692596632, 38805.80597096997, 33331.666683333824, 33992.320153596294, 35016.64983350134, 35043.12392190113, 35258.0, 23517.29448116559, 23621.70080645581, 25978.830952607557, 26497.0, 26500.7349926506], "value": 20410.772024224367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9884803455896, 387.3395860058599, 392.53876694883525, 403.4633936863971, 407.69830325559076, 20054.298099566517, 21527.56944861106, 21900.561988760215, 21931.561368772636, 21973.121075156974, 20406.69389959152, 21091.2618058368, 21312.786872131273, 22083.66874496884, 22089.116435342607, 4176.394422808691, 6054.122152287916, 6125.632462052291, 6126.724297406605, 6131.509479241672, 4182.519010313822, 4409.4488188976375, 4427.225235583776, 4434.600885920267, 5962.672053037081, 4309.332053531708, 6580.276169621362, 6583.539152259344, 6603.339666033382, 6613.735450581971, 6377.107204991305, 6589.5387322887655, 6617.04052912325, 6641.568298060634, 6654.534182607219, 3754.099016236111, 5685.971570142165, 5703.3441154267375, 5710.971445142789, 5736.024875771129, 18856.81143188578, 26104.477910441685, 26463.338416539547, 27440.313992150357, 27450.705915290095, 2251.819854411643, 2790.6511686039244, 3155.542446345267, 3156.9684303156905, 3274.0, 14943.551693449213, 16181.757273640906, 16278.674426511403, 16448.779414779092, 16768.748468772978, 1858.7769467663832, 1868.560888191274, 1884.8021654326933, 1914.6936490161506, 2036.0430597619095, 119442.8055719449, 119534.0, 121426.39286803598, 121444.39277803643, 121973.0, 10616.840747388795, 10822.729431764268, 11061.446927653586, 11117.55529778816, 11243.121123212479, 13728.244946528037, 13734.519291824738, 13739.793903091462, 13768.586942391745, 13801.654958626115, 6802.182634893454, 8584.31325493959, 8821.867671984925, 8880.467171969702, 8901.0, 8895.066018068139, 8902.599383027778, 8934.910650893538, 9057.230135438562, 9103.681371151977, 5164.586833053347, 5679.858003549862, 6445.709943052574, 6591.604503729792, 6624.701888415033, 1520.7262692715196, 1843.216632930999, 1845.584743432717, 1846.1599972012702, 1847.639710256514, 927.6614035876856, 957.2916042128775, 982.7444864335324, 1018.6383833739064, 1033.7467320506523, 18377.90811045936, 21994.0, 22558.0, 22654.66018009731, 22801.543969120525, 930.5905401623264, 1022.6625213679467, 1043.8173319669027, 1112.3103675721104, 1120.971975700614, 10558.788824223473, 11032.896710328903, 11568.942155289169, 12093.395330233629, 12106.576269830513, 595212.0, 595259.0, 603027.0, 619236.0, 620072.0, 116233.0, 117489.41255293669, 120772.0, 122061.0, 122889.15666265013, 986.1913231150531, 990.6681261777242, 1007.1388962437157, 1007.7883644434604, 1044.3681572648438, 19392.61214775725, 19513.317033903746, 19606.215751369786, 19661.115249813505, 19731.605367892847, 43952.0, 48156.0, 51779.741101294254, 54684.632884178216, 55205.723971379884, 71782.28217717756, 73574.63212683902, 74284.62857685678, 75996.62001689956, 77956.0, 7891.131975482577, 8041.035075790943, 8190.099089100075, 8362.665493380196, 8480.660773568989, 13723.588292351245, 13797.310134493437, 13810.171389716648, 13995.580132596038, 14000.719985600435, 11609.013233875216, 11671.88328116708, 11673.0, 11919.284842909454, 12005.339706316236, 9769.85345219808, 10932.0, 11824.575961927612, 12034.939825300817, 12062.276263424223, 8965.641374344954, 11211.55153793839, 11753.941230293794, 11893.940530297294, 12078.33569153705, 7015.508914375945, 8174.100848906734, 8260.091389947222, 8312.833743324978, 8552.161285323686, 11307.830382544433, 11707.414629268333, 11727.589534366598, 11992.160548761853, 11993.82009269879], "value": 9937.685403841557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.6472717093566, 1521.8782497400205, 1556.0197075842218, 1730.6971280026, 1904.6666833304178, 7813.492123012007, 8452.957735211323, 8723.607437665305, 8732.51971141587, 8813.427127236726, 8555.443896146746, 8625.266852317545, 8721.996970348411, 8738.300935925126, 8752.78118047049, 2305.527366889792, 2346.718393792739, 2346.9530609387803, 2347.4014126397747, 2347.507023525062, 2302.9654555181687, 2332.8600283983014, 2338.7661233876647, 2339.122828939148, 2342.7305859826083, 2294.437862723635, 2310.9537809243807, 2317.629179331307, 2321.6749655048307, 2323.268170526287, 2272.4001171442605, 2293.575688497633, 2300.217925905192, 2304.331743794298, 2317.7913987741017, 2299.022915261024, 2303.896324665394, 2305.7578954209735, 2306.1121468234683, 2307.492351682627, 8619.396642235046, 8631.0, 8828.911710882872, 8829.470231786048, 8830.161134692195, 5161.767720452589, 5321.122014867542, 5326.946730532683, 5331.1470164773455, 5338.866528336784, 3545.503629491873, 3597.3165098631175, 3624.3294990426857, 3671.04552816267, 3674.2284120334493, 1070.9357438553711, 1072.785442911421, 1073.5920350266927, 1079.266099052644, 1094.7099018760034, 11742.11934104937, 11810.586629468013, 11828.053755699524, 11841.82237266433, 11854.229475084092, 3786.3373909565717, 4361.890952726144, 4405.427294451701, 4516.570925762047, 4529.8641040768825, 9102.044285350075, 9118.635254589875, 9131.726048218565, 9145.268378529701, 9166.954165229132, 5123.257127716534, 5187.559057480156, 5192.7403629818355, 5193.636445448782, 5199.480051994846, 4310.892227694333, 4398.318260669537, 4490.057088011489, 4674.555917187861, 4875.390576177978, 3700.5374328208973, 3709.629037096323, 3781.621837816251, 3821.464994900716, 3834.4631751554803, 1127.5658871334595, 1135.8069128248217, 1144.5193018932068, 1144.5593446522983, 1147.977040459203, 887.4896934262824, 924.58393722825, 938.8028514012134, 943.7923656795494, 1002.3584905660383, 5347.0909945309395, 5756.827295181151, 5945.7621695132575, 6083.787067452707, 6203.472704820141, 418.7215501691341, 441.911617676466, 442.77418516556787, 448.40362318116826, 457.0607401789355, 3997.5802540733384, 4038.970062634068, 4050.2709512287483, 4080.2655522006326, 4097.688739603358, 10362.792744145076, 10634.0, 10659.520321585547, 10765.623203187852, 10782.568697252022, 10736.141108711285, 10745.570177192982, 10746.731331716614, 10811.135109191246, 10852.67441976742, 6983.3714965653335, 8166.1833816619055, 8259.628316725762, 8262.215089566482, 8279.965004374573, 5951.0, 6002.369751176238, 6192.628442293477, 6201.906971395342, 6205.410486003822, 9660.95169524148, 10127.24045696561, 10134.949325253327, 10140.391576505433, 10194.43930583825, 9722.465264410524, 10120.139788118093, 10162.695119146438, 10238.078572928473, 10277.331973421704, 6943.3750962411605, 7226.638668066471, 7362.926370736438, 7438.033055702724, 7688.0, 8303.4602750821, 8414.6213420395, 8506.574671266535, 8511.702090426805, 8529.616167272612, 7347.8530429392185, 7494.625268736432, 7586.431017673586, 7607.315341619281, 7611.809704757426, 7241.565506069653, 7338.6697598607125, 7339.559626422431, 7475.588842613708, 7480.962595186989, 6980.301969803182, 7027.648617569203, 7050.929490705027, 7057.117860267466, 7060.399866011447, 4875.1712208923855, 4990.4261009982865, 5058.974705126451, 5092.108880945746, 5107.029664363759, 4955.380577427822, 5071.112555302881, 5134.204198349262, 5165.535101840853, 5254.106801843619], "value": 4460.408399417863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.9801762885412, 306.76532452673706, 313.8791565247379, 314.1862575928345, 315.9320746039601, 5385.730713464331, 5443.891122177559, 5471.06991811392, 5471.5349195318395, 5508.669479831213, 4868.853934381966, 4957.4058807364645, 4999.450060493343, 5428.891422171554, 5443.428440013801, 3842.0235056716306, 3879.72841901067, 3880.641775378623, 4105.3020986432375, 4124.463819703435, 3040.9356725146245, 4031.113155105872, 4035.829609413281, 4095.8361665533344, 4118.897027574305, 4069.7761623110864, 4070.9008567686706, 4080.9387859182134, 4093.3450647896343, 4142.896427589304, 3540.716742660594, 3830.195658911632, 3867.7099217558516, 4139.523954745183, 4146.606072423115, 3565.358235517606, 3573.5533058367705, 3583.928321433583, 3591.1560783215923, 3593.083763640281, 4507.57178068083, 4754.478566858606, 5305.84302340107, 5337.226102215196, 5357.571394288448, 4579.6261121663365, 4715.269133284346, 4730.858074257778, 4758.191107511731, 4761.40482439695, 4543.45478542577, 4901.166801643729, 5653.293338332708, 5688.212775739899, 5759.827205183851, 3507.474248701823, 3643.7995910224927, 3925.6456522499693, 3942.2207343822824, 3958.9208215835524, 5131.433024608139, 5803.82588522345, 5844.7205589820005, 6003.489703375175, 6067.514598832127, 3476.3916314644835, 3850.7497012694084, 3955.129871428281, 3968.2857085724845, 3980.0, 3429.451287793941, 3881.514810648669, 4042.0, 4078.877633670995, 4091.652209562161, 4140.420341152241, 4365.607095361369, 4557.589816916494, 4557.680962332605, 4738.597219236334, 4905.068037072945, 5118.25785261135, 5758.769649213985, 5770.220505568859, 5789.131630255411, 1142.3774043146504, 1172.2966220267772, 1388.9791653125212, 1399.734050530396, 1403.277312184226, 801.8556659801292, 838.287455662694, 852.4799872078028, 852.9082774049227, 866.3372520022189, 5190.792368305226, 5287.656302340336, 5389.9191512127345, 5440.809571664972, 5451.563874889999, 5292.914952434741, 5335.052705762447, 5389.865253368619, 5427.9144171165135, 5927.940720592739, 5063.493650634907, 5323.893522129613, 5328.413874473805, 5364.14173732201, 5388.278919145806, 2709.972900270972, 2783.540715781873, 2876.741093301613, 3086.830224337683, 3131.6242050954033, 4818.927716084261, 5455.345358556999, 5823.56323275756, 6155.952803362365, 6245.750169993149, 4920.114379411669, 5119.564836988823, 5120.678896792712, 5910.290765108129, 6084.630958034495, 5187.766550505236, 5220.321358223407, 5516.841463292673, 6178.66017369049, 6186.597871138361, 5360.70516121617, 5721.685307308138, 5843.860447212753, 5935.762569497172, 5972.970135149297, 4817.879553011203, 5832.970835145967, 5906.940930590639, 5907.261592300963, 5924.585279030426, 6130.877382452237, 6173.351798061319, 6211.2857021443115, 6211.409916057967, 6247.156633854372, 3190.6330771960593, 3371.3425881952785, 3384.0, 3399.7110245629397, 3414.84633191502, 4471.8658440246845, 4809.639277054305, 4967.254911763264, 5055.7219352935945, 5071.847844564669, 4406.294992801137, 4585.380973568525, 4812.855614331575, 4824.927626085681, 4845.238214217862, 4252.4897012358715, 4557.339185817971, 4863.902721945612, 4898.975505122452, 5180.663256888291, 5378.074005975582, 5399.434164092369, 5664.461876121762, 5699.544036477155, 5715.914261286167, 5625.353084395183, 5644.717764111696, 5704.80033198836, 5798.898209340212, 5844.327902291121, 5021.5229553192385, 5705.543556515386, 5705.857353566194, 5733.569982251264, 5740.225069615549], "value": 4071.317915491315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.8873780195169, 739.5193124469095, 796.0208943000109, 801.5110782422724, 826.1325608111481, 15192.696146077073, 15764.132972686526, 15794.60513487162, 15810.4466343678, 15818.446354377598, 13220.40508177132, 13270.800937985938, 13285.800712989312, 13306.06857519974, 13312.267825269606, 708.3624737736027, 730.7588495796401, 895.6954635423971, 904.6562306323588, 909.1317791509093, 874.8075423406872, 905.1536813079791, 909.5088652127843, 910.7996240827008, 911.7766147293889, 953.2993249961307, 960.7790208252106, 966.9178119859786, 969.0116081596767, 969.6945462179391, 697.0415678442142, 921.1341339141253, 962.1196605106319, 962.1917589225014, 962.6486332488627, 710.8258476673196, 712.9287071292881, 713.4470785141505, 714.2714431280065, 714.4784307455535, 15380.92309538445, 15398.307076181598, 15428.151451670154, 15456.149911754848, 15480.5355839325, 13611.387487563083, 13915.999999999898, 13917.86082139186, 14009.509667161601, 14081.85918140826, 12753.171043882117, 12829.67925801853, 12940.547080852126, 13042.282674452901, 13344.933275333658, 4450.10997800438, 4477.216487114774, 4480.932786008212, 4481.551844815525, 4676.438827340707, 116669.82534188517, 119570.0, 119960.0, 123469.9999999991, 125023.37488312591, 10928.398938058483, 10965.945170274097, 10988.780224395627, 11027.117830573536, 11181.664550063511, 18504.352347667766, 20646.483837903874, 21438.82086485227, 21631.67552486714, 21694.674579881314, 8081.555514446762, 8149.511029338259, 8165.836683266301, 8318.70884519039, 8329.250367466835, 4530.977345113253, 4547.7498737569085, 4560.156371071363, 4599.931001034987, 4768.117898188846, 3400.812955287483, 3521.6302288259362, 3522.823858807101, 3525.012996361023, 3529.1353618363664, 619.801663467695, 643.6685107169811, 644.5906849150823, 656.1666683312167, 659.1233659233209, 574.9051406517962, 577.3995045153077, 613.4908026338129, 636.8121404185777, 647.8250872264463, 8916.242119419921, 9050.456972581535, 9148.261830252231, 9195.494247816434, 9339.252859771203, 585.5696063393402, 600.0009983377714, 603.2820943077724, 623.9750409983641, 639.68015992004, 3931.3709806430834, 4395.0, 4400.889977750582, 4402.713823601455, 4566.589006989387, 159630.20184899002, 161495.3850461504, 165095.17452412902, 166231.0, 168227.0, 70307.0, 132990.33504832414, 137052.0, 137385.0, 138760.4107301761, 114615.85384146219, 116841.0, 118034.0, 121356.0, 121823.39088304502, 8421.663133474838, 8565.48607083577, 8630.611622477129, 8782.297416206817, 8928.15182557656, 67098.0, 67511.98732018925, 67890.0, 69341.0, 70493.0, 90585.0, 103354.79330528066, 105124.94875051151, 105769.47115264375, 106996.46501767442, 11552.360867714408, 11798.528058877891, 11849.644510664693, 12007.519699211934, 12177.878221217674, 12418.81371779442, 12545.749085018431, 12651.177673451197, 12951.611451656465, 13031.47874085064, 12026.338551379758, 12231.633051008484, 12269.079819013432, 12425.813612795997, 12508.562200322946, 11761.176717629683, 11904.0, 12124.030077593596, 12528.0, 12543.3101179436, 11844.1709080367, 11863.76272474563, 11868.940655297014, 11970.76058478843, 12500.37498125072, 9912.348223375348, 10145.028172367402, 10163.186945044527, 10321.071103600712, 10493.685189444328, 9922.454265015493, 10180.440075795903, 10204.38773673582, 10211.081002709792, 10251.538680759533], "value": 7808.009814832784, "unit": "score"}], "name": "dromaeo_css", "value": 7390.0885281696665, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 118.0, 118.0, 167.0, 121.0, 117.0, 137.0, 117.0, 152.0, 119.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 185.0, 187.0, 182.0, 183.0, 181.0, 183.0, 184.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 58.0, 108.0, 59.0, 57.0, 61.0, 60.0, 125.0, 56.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 94.0, 71.0, 73.0, 67.0, 95.0, 70.0, 66.0, 102.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 130.0, 87.0, 84.0, 87.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 94.0, 103.0, 149.0, 125.0, 93.0, 93.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 84.0, 84.0, 83.0, 86.0, 84.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 55.0, 54.0, 53.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 73.0, 77.0, 75.0, 73.0, 68.0, 69.0, 70.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 85.0, 86.0, 86.0, 99.0, 102.0, 101.0, 75.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 154.0, 142.0, 138.0, 136.0, 137.0, 137.0, 136.0, 140.0, 151.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 172.0, 173.0, 173.0, 173.0, 172.0, 171.0, 172.0, 169.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 84.0, 66.0, 68.0, 67.0, 66.0, 66.0, 66.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1463.9, "alertThreshold": 2.0}]} 02:29:17 INFO - Return code: 0 02:29:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:29:17 INFO - # TBPL SUCCESS # 02:29:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:29:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:29:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:29:17 INFO - 2016-06-29 02:29:17.873 screenresolution[1927:16331] starting screenresolution argv=screenresolution get 02:29:17 INFO - 2016-06-29 02:29:17.876 screenresolution[1927:16331] Display 0: 1600x1200x32@60 02:29:17 INFO - 2016-06-29 02:29:17.881 screenresolution[1928:16334] starting screenresolution argv=screenresolution list 02:29:17 INFO - Available Modes on Display 0 02:29:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:29:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:29:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:29:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:29:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:29:18 INFO - Intel Iris: 02:29:18 INFO - Chipset Model: Intel Iris 02:29:18 INFO - Type: GPU 02:29:18 INFO - Bus: Built-In 02:29:18 INFO - VRAM (Dynamic, Max): 1536 MB 02:29:18 INFO - Vendor: Intel (0x8086) 02:29:18 INFO - Device ID: 0x0a2e 02:29:18 INFO - Revision ID: 0x0009 02:29:18 INFO - Displays: 02:29:18 INFO - Display: 02:29:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:29:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:29:18 INFO - Display Serial Number: 1600x1200 60 02:29:18 INFO - Main Display: Yes 02:29:18 INFO - Mirror: Off 02:29:18 INFO - Online: Yes 02:29:18 INFO - Rotation: Supported 02:29:18 INFO - Return code: 0 02:29:18 INFO - Running post-action listener: _resource_record_post_action 02:29:18 INFO - ##### 02:29:18 INFO - ##### Finished run-tests step (success) 02:29:18 INFO - ##### 02:29:18 INFO - Running post-run listener: _resource_record_post_run 02:29:18 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 626688; Write bytes: 704559104; Read time: 12; Write time: 1899 02:29:18 INFO - TinderboxPrint: CPU usage
53.8% 02:29:18 INFO - TinderboxPrint: I/O read bytes / time
626,688 / 12 02:29:18 INFO - TinderboxPrint: I/O write bytes / time
704,559,104 / 1,899 02:29:18 INFO - TinderboxPrint: CPU idle
2,238.1 (46.2%) 02:29:18 INFO - TinderboxPrint: CPU system
966.0 (20.0%) 02:29:18 INFO - TinderboxPrint: CPU user
1,637.6 (33.8%) 02:29:18 INFO - TinderboxPrint: Swap in / out
407,334,912 / 0 02:29:18 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398195200; Write bytes: 393383424; Read time: 29615; Write time: 737 02:29:18 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 626688; Write bytes: 293276160; Read time: 12; Write time: 1118 02:29:18 INFO - Running post-run listener: _upload_blobber_files 02:29:18 INFO - Blob upload gear active. 02:29:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:29:18 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 02:29:18 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:29:18 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:29:18 INFO - (blobuploader) - INFO - Open directory for files ... 02:29:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:29:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:29:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:20 INFO - (blobuploader) - INFO - Done attempting. 02:29:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:29:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:29:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:21 INFO - (blobuploader) - INFO - Done attempting. 02:29:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:29:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:29:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:23 INFO - (blobuploader) - INFO - Done attempting. 02:29:23 INFO - (blobuploader) - INFO - Iteration through files over. 02:29:23 INFO - Return code: 0 02:29:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:29:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:29:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ef63ee79df9e362a03e8bbe1ce355d64201141ca0d869c0d5a8b0db0ccddbed848628ad485a1048a3fc3e74ca2eb6a93df599540e832f83d32c717f0a667829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca6d8c870d7da5064db53c79dca7842fb4f1ea1f68e7e4783ff90d6ddaa4820ad3167a69d66ff51af8c7fe211741773d89078ab8a54e4d73a03ba44e9619b1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f625673b51772a6d3249eec8656160f6c910a5bf439f37f9296f422d5a6c8c7024786dcc0d28e2fb0fe175cf9bafe33e37b4c867660b61103bc136d2fe5fc86"} 02:29:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:29:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:29:23 INFO - Contents: 02:29:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ef63ee79df9e362a03e8bbe1ce355d64201141ca0d869c0d5a8b0db0ccddbed848628ad485a1048a3fc3e74ca2eb6a93df599540e832f83d32c717f0a667829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca6d8c870d7da5064db53c79dca7842fb4f1ea1f68e7e4783ff90d6ddaa4820ad3167a69d66ff51af8c7fe211741773d89078ab8a54e4d73a03ba44e9619b1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f625673b51772a6d3249eec8656160f6c910a5bf439f37f9296f422d5a6c8c7024786dcc0d28e2fb0fe175cf9bafe33e37b4c867660b61103bc136d2fe5fc86"} 02:29:23 INFO - Running post-run listener: copy_logs_to_upload_dir 02:29:23 INFO - Copying logs to upload dir... 02:29:23 INFO - mkdir: /builds/slave/test/build/upload/logs 02:29:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.090688 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-29 02:29:23.775276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 02:29:23.779137) ========= 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.d2OVgrn7sj/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.pNF5usZ15w/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/Fx-Team/sha512/3ef63ee79df9e362a03e8bbe1ce355d64201141ca0d869c0d5a8b0db0ccddbed848628ad485a1048a3fc3e74ca2eb6a93df599540e832f83d32c717f0a667829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca6d8c870d7da5064db53c79dca7842fb4f1ea1f68e7e4783ff90d6ddaa4820ad3167a69d66ff51af8c7fe211741773d89078ab8a54e4d73a03ba44e9619b1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f625673b51772a6d3249eec8656160f6c910a5bf439f37f9296f422d5a6c8c7024786dcc0d28e2fb0fe175cf9bafe33e37b4c867660b61103bc136d2fe5fc86"} build_url:https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/ZrkJrrsxS96Ou2skqfp8qg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ef63ee79df9e362a03e8bbe1ce355d64201141ca0d869c0d5a8b0db0ccddbed848628ad485a1048a3fc3e74ca2eb6a93df599540e832f83d32c717f0a667829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca6d8c870d7da5064db53c79dca7842fb4f1ea1f68e7e4783ff90d6ddaa4820ad3167a69d66ff51af8c7fe211741773d89078ab8a54e4d73a03ba44e9619b1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f625673b51772a6d3249eec8656160f6c910a5bf439f37f9296f422d5a6c8c7024786dcc0d28e2fb0fe175cf9bafe33e37b4c867660b61103bc136d2fe5fc86"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 02:29:23.812198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:29:23.812536) ========= 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.d2OVgrn7sj/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.pNF5usZ15w/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005119 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:29:23.861668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:29:23.862009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:29:23.862327) ========= ========= Total master_lag: 0.23 =========