builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0379 starttime: 1468931131.62 results: success (0) buildid: 20160719020320 builduid: dff51de2631244a1ae75b1e19a5d615b revision: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.621622) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.622062) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.622338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.645842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.646276) ========= 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.TtUVD1zbEX/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.F82u2TpY23/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-19 05:25:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-07-19 05:25:31 (18.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.767440) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.767746) ========= 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.TtUVD1zbEX/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.F82u2TpY23/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.026327 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:31.816719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 05:25:31.817113) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5a2837e3fed3cfdf6be39fa756e3be7e1257190 --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 a5a2837e3fed3cfdf6be39fa756e3be7e1257190 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TtUVD1zbEX/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.F82u2TpY23/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-19 05:25:31,899 truncating revision to first 12 chars 2016-07-19 05:25:31,899 Setting DEBUG logging. 2016-07-19 05:25:31,899 attempt 1/10 2016-07-19 05:25:31,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5a2837e3fed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 05:25:32,912 unpacking tar archive at: fx-team-a5a2837e3fed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.287829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 05:25:33.127186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:33.127518) ========= script_repo_revision: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:33.127938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:33.128201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 05:25:33.147497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-19 05:25:33.147933) ========= /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.TtUVD1zbEX/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.F82u2TpY23/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:25:33 INFO - MultiFileLogger online at 20160719 05:25:33 in /builds/slave/test 05:25:33 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 05:25:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:33 INFO - {'append_to_log': False, 05:25:33 INFO - 'base_work_dir': '/builds/slave/test', 05:25:33 INFO - 'blob_upload_branch': 'Fx-Team', 05:25:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:33 INFO - 'branch': 'Fx-Team', 05:25:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:33 INFO - 'config_files': ('talos/mac_config.py',), 05:25:33 INFO - 'default_actions': ('clobber', 05:25:33 INFO - 'read-buildbot-config', 05:25:33 INFO - 'download-and-extract', 05:25:33 INFO - 'populate-webroot', 05:25:33 INFO - 'create-virtualenv', 05:25:33 INFO - 'install', 05:25:33 INFO - 'run-tests'), 05:25:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:33 INFO - 'download_minidump_stackwalk': True, 05:25:33 INFO - 'download_symbols': 'ondemand', 05:25:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:33 INFO - 'installer_path': 'installer.exe', 05:25:33 INFO - 'log_level': 'info', 05:25:33 INFO - 'log_name': 'talos', 05:25:33 INFO - 'log_to_console': True, 05:25:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:25:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:25:33 INFO - 'opt_config_files': (), 05:25:33 INFO - 'pip_index': False, 05:25:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:33 INFO - 'cmd': ('bash', 05:25:33 INFO - '-c', 05:25:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:33 INFO - 'enabled': True, 05:25:33 INFO - 'halt_on_failure': False, 05:25:33 INFO - 'name': 'check_screen_resolution'},), 05:25:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:33 INFO - 'cmd': ('bash', 05:25:33 INFO - '-c', 05:25:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:33 INFO - 'enabled': True, 05:25:33 INFO - 'halt_on_failure': False, 05:25:33 INFO - 'name': 'check_screen_resolution'},), 05:25:33 INFO - 'run_cmd_checks_enabled': True, 05:25:33 INFO - 'sps_profile': False, 05:25:33 INFO - 'sps_profile_interval': 0, 05:25:33 INFO - 'suite': 'dromaeojs', 05:25:33 INFO - 'system_bits': '32', 05:25:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:33 INFO - 'title': 't-yosemite-r7-0379', 05:25:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:33 INFO - 'use_talos_json': True, 05:25:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:33 INFO - 'work_dir': 'build'} 05:25:33 INFO - ##### 05:25:33 INFO - ##### Running clobber step. 05:25:33 INFO - ##### 05:25:33 INFO - Running pre-action listener: _resource_record_pre_action 05:25:33 INFO - Running main action method: clobber 05:25:33 INFO - rmtree: /builds/slave/test/build 05:25:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:35 INFO - Running post-action listener: _resource_record_post_action 05:25:35 INFO - ##### 05:25:35 INFO - ##### Finished clobber step (success) 05:25:35 INFO - ##### 05:25:35 INFO - ##### 05:25:35 INFO - ##### Running read-buildbot-config step. 05:25:35 INFO - ##### 05:25:35 INFO - Running pre-action listener: _resource_record_pre_action 05:25:35 INFO - Running main action method: read_buildbot_config 05:25:35 INFO - Using buildbot properties: 05:25:35 INFO - { 05:25:35 INFO - "project": "", 05:25:35 INFO - "product": "firefox", 05:25:35 INFO - "script_repo_revision": "production", 05:25:35 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:25:35 INFO - "repository": "", 05:25:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:25:35 INFO - "buildid": "20160719020320", 05:25:35 INFO - "pgo_build": "False", 05:25:35 INFO - "basedir": "/builds/slave/test", 05:25:35 INFO - "buildnumber": 850, 05:25:35 INFO - "slavename": "t-yosemite-r7-0379", 05:25:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:25:35 INFO - "platform": "yosemite_r7", 05:25:35 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:25:35 INFO - "branch": "fx-team", 05:25:35 INFO - "repo_path": "integration/fx-team", 05:25:35 INFO - "revision": "a5a2837e3fed3cfdf6be39fa756e3be7e1257190", 05:25:35 INFO - "stage_platform": "macosx64", 05:25:35 INFO - "builduid": "dff51de2631244a1ae75b1e19a5d615b", 05:25:35 INFO - "slavebuilddir": "test" 05:25:35 INFO - } 05:25:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:25:35 INFO - Running post-action listener: _resource_record_post_action 05:25:35 INFO - ##### 05:25:35 INFO - ##### Finished read-buildbot-config step (success) 05:25:35 INFO - ##### 05:25:35 INFO - ##### 05:25:35 INFO - ##### Running download-and-extract step. 05:25:35 INFO - ##### 05:25:35 INFO - Running pre-action listener: _resource_record_pre_action 05:25:35 INFO - Running main action method: download_and_extract 05:25:35 INFO - mkdir: /builds/slave/test/build/tests 05:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:35 INFO - https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:37 INFO - Downloaded 1199 bytes. 05:25:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:25:37 INFO - Using the following test package requirements: 05:25:37 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:25:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:25:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:25:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'jsshell-mac.zip'], 05:25:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:25:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:25:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:25:37 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:25:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:25:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:25:37 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:25:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:25:37 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')]} 05:25:37 INFO - https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:39 INFO - Downloaded 18835456 bytes. 05:25:39 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'] 05:25:39 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 05:25:42 INFO - Return code: 0 05:25:42 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 05:25:42 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')]} 05:25:42 INFO - https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:43 INFO - Downloaded 18835456 bytes. 05:25:43 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'] 05:25:43 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 05:25:46 INFO - Return code: 0 05:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:46 INFO - https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:47 INFO - Downloaded 14403317 bytes. 05:25:47 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'] 05:25:47 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 05:25:48 INFO - Return code: 0 05:25: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')]} 05:25:48 INFO - https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvUffNGHSk2A0thiTsOz9w/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 05:25:51 INFO - Downloaded 112873538 bytes. 05:25:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:25:51 INFO - mkdir: /builds/slave/test/properties 05:25:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:51 INFO - Contents: 05:25:51 INFO - build_url:https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:25:52 INFO - Running post-action listener: _resource_record_post_action 05:25:52 INFO - Running post-action listener: set_extra_try_arguments 05:25:52 INFO - ##### 05:25:52 INFO - ##### Finished download-and-extract step (success) 05:25:52 INFO - ##### 05:25:52 INFO - ##### 05:25:52 INFO - ##### Running populate-webroot step. 05:25:52 INFO - ##### 05:25:52 INFO - Running pre-action listener: _resource_record_pre_action 05:25:52 INFO - Running main action method: populate_webroot 05:25:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:52 INFO - '--tppagecycles', 05:25:52 INFO - '7'], 05:25:52 INFO - 'tests': ['tsvgm']}}, 05:25:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['damp', 'tps']}, 05:25:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'tests': ['damp', 'tps']}, 05:25:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['dromaeo_dom']}, 05:25:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['basic_compositor_video']}, 05:25:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:25:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['a11yr', 05:25:52 INFO - 'ts_paint', 05:25:52 INFO - 'tpaint', 05:25:52 INFO - 'sessionrestore', 05:25:52 INFO - 'sessionrestore_no_auto_restore', 05:25:52 INFO - 'tabpaint']}, 05:25:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:52 INFO - 'ts_paint', 05:25:52 INFO - 'tpaint', 05:25:52 INFO - 'sessionrestore', 05:25:52 INFO - 'sessionrestore_no_auto_restore', 05:25:52 INFO - 'tabpaint']}, 05:25:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:25:52 INFO - 'ts_paint', 05:25:52 INFO - 'tpaint', 05:25:52 INFO - 'sessionrestore', 05:25:52 INFO - 'sessionrestore_no_auto_restore', 05:25:52 INFO - 'tabpaint']}, 05:25:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:25:52 INFO - 'ts_paint', 05:25:52 INFO - 'tpaint', 05:25:52 INFO - 'sessionrestore', 05:25:52 INFO - 'sessionrestore_no_auto_restore', 05:25:52 INFO - 'tabpaint']}, 05:25:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['a11yr', 05:25:52 INFO - 'ts_paint', 05:25:52 INFO - 'tpaint', 05:25:52 INFO - 'sessionrestore', 05:25:52 INFO - 'sessionrestore_no_auto_restore', 05:25:52 INFO - 'tabpaint']}, 05:25:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['a11yr', 05:25:52 INFO - 'ts_paint', 05:25:52 INFO - 'tpaint', 05:25:52 INFO - 'sessionrestore', 05:25:52 INFO - 'sessionrestore_no_auto_restore', 05:25:52 INFO - 'tabpaint']}, 05:25:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['tsvgx', 05:25:52 INFO - 'tsvgr_opacity', 05:25:52 INFO - 'tart', 05:25:52 INFO - 'tscrollx', 05:25:52 INFO - 'cart']}, 05:25:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:52 INFO - 'tsvgr_opacity', 05:25:52 INFO - 'tart', 05:25:52 INFO - 'tscrollx', 05:25:52 INFO - 'cart']}, 05:25:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'talos_options': ['--disable-e10s'], 05:25:52 INFO - 'tests': ['tp5o']}, 05:25:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'tests': ['tp5o']}, 05:25:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'talos_options': ['--disable-e10s', 05:25:52 INFO - '--xperf_path', 05:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:52 INFO - 'tests': ['tp5n']}, 05:25:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:52 INFO - 'talos_options': ['--xperf_path', 05:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:52 INFO - 'tests': ['tp5n']}}, 05:25:52 INFO - 'talos.zip': {'path': '', 05:25:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:52 INFO - Running post-action listener: _resource_record_post_action 05:25:52 INFO - ##### 05:25:52 INFO - ##### Finished populate-webroot step (success) 05:25:52 INFO - ##### 05:25:52 INFO - ##### 05:25:52 INFO - ##### Running create-virtualenv step. 05:25:52 INFO - ##### 05:25:52 INFO - Running pre-action listener: _resource_record_pre_action 05:25:52 INFO - Running main action method: create_virtualenv 05:25:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:25:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:25:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:52 INFO - Using real prefix '/tools/python27' 05:25:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:55 INFO - Installing pip.................done. 05:25:55 INFO - Return code: 0 05:25:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:55 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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:25:55 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 05:25:55 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 05:25:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:25:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:55 INFO - 'HOME': '/Users/cltbld', 05:25:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:55 INFO - 'LOGNAME': 'cltbld', 05:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:55 INFO - 'MOZ_NO_REMOTE': '1', 05:25:55 INFO - 'NO_EM_RESTART': '1', 05:25:55 INFO - 'PAGER': '/bin/cat', 05:25:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:55 INFO - 'PWD': '/builds/slave/test', 05:25:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:55 INFO - 'SHELL': '/bin/bash', 05:25:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:25:55 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:25:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:55 INFO - 'USER': 'cltbld', 05:25:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:55 INFO - 'XPC_FLAGS': '0x0', 05:25:55 INFO - 'XPC_SERVICE_NAME': '0', 05:25:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:25:56 INFO - Cleaning up... 05:25:56 INFO - Return code: 0 05:25:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:56 INFO - 'HOME': '/Users/cltbld', 05:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:56 INFO - 'LOGNAME': 'cltbld', 05:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:56 INFO - 'MOZ_NO_REMOTE': '1', 05:25:56 INFO - 'NO_EM_RESTART': '1', 05:25:56 INFO - 'PAGER': '/bin/cat', 05:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:56 INFO - 'PWD': '/builds/slave/test', 05:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:56 INFO - 'SHELL': '/bin/bash', 05:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:25:56 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:56 INFO - 'USER': 'cltbld', 05:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:56 INFO - 'XPC_FLAGS': '0x0', 05:25:56 INFO - 'XPC_SERVICE_NAME': '0', 05:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:56 INFO - Downloading/unpacking psutil>=3.1.1 05:25:56 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 05:25:56 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 05:25:56 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 05:25:56 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 05:25:56 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 05:25:56 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 05:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:59 INFO - Installing collected packages: psutil 05:25:59 INFO - Running setup.py install for psutil 05:25:59 INFO - building 'psutil._psutil_osx' extension 05:25:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:26:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:26:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:26:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:26:00 INFO - building 'psutil._psutil_posix' extension 05:26:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:26:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:26:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:26:00 INFO - ^ 05:26:00 INFO - 1 warning generated. 05:26:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:26:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:00 INFO - Successfully installed psutil 05:26:00 INFO - Cleaning up... 05:26:00 INFO - Return code: 0 05:26:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:26:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:00 INFO - 'HOME': '/Users/cltbld', 05:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:00 INFO - 'LOGNAME': 'cltbld', 05:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:00 INFO - 'MOZ_NO_REMOTE': '1', 05:26:00 INFO - 'NO_EM_RESTART': '1', 05:26:00 INFO - 'PAGER': '/bin/cat', 05:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:00 INFO - 'PWD': '/builds/slave/test', 05:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:00 INFO - 'SHELL': '/bin/bash', 05:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:00 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:00 INFO - 'USER': 'cltbld', 05:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:00 INFO - 'XPC_FLAGS': '0x0', 05:26:00 INFO - 'XPC_SERVICE_NAME': '0', 05:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:03 INFO - Installing collected packages: mozsystemmonitor 05:26:03 INFO - Running setup.py install for mozsystemmonitor 05:26:03 INFO - Successfully installed mozsystemmonitor 05:26:03 INFO - Cleaning up... 05:26:03 INFO - Return code: 0 05:26:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:03 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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:26:03 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 05:26:03 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 05:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:03 INFO - 'HOME': '/Users/cltbld', 05:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:03 INFO - 'LOGNAME': 'cltbld', 05:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:03 INFO - 'MOZ_NO_REMOTE': '1', 05:26:03 INFO - 'NO_EM_RESTART': '1', 05:26:03 INFO - 'PAGER': '/bin/cat', 05:26:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:03 INFO - 'PWD': '/builds/slave/test', 05:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:03 INFO - 'SHELL': '/bin/bash', 05:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:03 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:03 INFO - 'USER': 'cltbld', 05:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:03 INFO - 'XPC_FLAGS': '0x0', 05:26:03 INFO - 'XPC_SERVICE_NAME': '0', 05:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:03 INFO - Downloading/unpacking jsonschema==2.5.1 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:06 INFO - warning: no files found matching '*.txt' 05:26:06 INFO - no previously-included directories found matching 'build' 05:26:06 INFO - no previously-included directories found matching 'dist' 05:26:06 INFO - no previously-included directories found matching '.git*' 05:26:06 INFO - Installing collected packages: jsonschema, functools32 05:26:06 INFO - Running setup.py install for functools32 05:26:07 INFO - warning: no files found matching '*.txt' 05:26:07 INFO - no previously-included directories found matching 'build' 05:26:07 INFO - no previously-included directories found matching 'dist' 05:26:07 INFO - no previously-included directories found matching '.git*' 05:26:07 INFO - Successfully installed jsonschema functools32 05:26:07 INFO - Cleaning up... 05:26:07 INFO - Return code: 0 05:26:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:07 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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:26:07 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 05:26:07 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 05:26:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:07 INFO - 'HOME': '/Users/cltbld', 05:26:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:07 INFO - 'LOGNAME': 'cltbld', 05:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:07 INFO - 'MOZ_NO_REMOTE': '1', 05:26:07 INFO - 'NO_EM_RESTART': '1', 05:26:07 INFO - 'PAGER': '/bin/cat', 05:26:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:07 INFO - 'PWD': '/builds/slave/test', 05:26:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:07 INFO - 'SHELL': '/bin/bash', 05:26:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:07 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:07 INFO - 'USER': 'cltbld', 05:26:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:07 INFO - 'XPC_FLAGS': '0x0', 05:26:07 INFO - 'XPC_SERVICE_NAME': '0', 05:26:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:07 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 05:26:07 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 05:26:07 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 05:26:07 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 05:26:07 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 05:26:07 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 05:26:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:11 INFO - Downloading docopt-0.6.1.tar.gz 05:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:11 INFO - Running setup.py install for blobuploader 05:26:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:11 INFO - Running setup.py install for requests 05:26:11 INFO - Running setup.py install for docopt 05:26:11 INFO - Successfully installed blobuploader requests docopt 05:26:11 INFO - Cleaning up... 05:26:12 INFO - Return code: 0 05:26:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:12 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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:26:12 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 05:26:12 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 05:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:12 INFO - 'HOME': '/Users/cltbld', 05:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:12 INFO - 'LOGNAME': 'cltbld', 05:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:12 INFO - 'MOZ_NO_REMOTE': '1', 05:26:12 INFO - 'NO_EM_RESTART': '1', 05:26:12 INFO - 'PAGER': '/bin/cat', 05:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:12 INFO - 'PWD': '/builds/slave/test', 05:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:12 INFO - 'SHELL': '/bin/bash', 05:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:12 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:12 INFO - 'USER': 'cltbld', 05:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:12 INFO - 'XPC_FLAGS': '0x0', 05:26:12 INFO - 'XPC_SERVICE_NAME': '0', 05:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-r7r56V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-gP8mAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-hoI1XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-GvqhIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-EpeobU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-3pniXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-HmuBFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-ScEEcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-UawSqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-0q0RxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Hfky7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-NiNXk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-AoAKH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Hac8vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-IBzlLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-W9Rcci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-sid8BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:14 INFO - Running setup.py install for manifestparser 05:26:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:14 INFO - Running setup.py install for mozcrash 05:26:14 INFO - Running setup.py install for mozdebug 05:26:14 INFO - Running setup.py install for mozdevice 05:26:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:26:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:14 INFO - Running setup.py install for mozfile 05:26:14 INFO - Running setup.py install for mozhttpd 05:26:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:14 INFO - Running setup.py install for mozinfo 05:26:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Running setup.py install for mozInstall 05:26:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Running setup.py install for mozleak 05:26:15 INFO - Running setup.py install for mozlog 05:26:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Running setup.py install for moznetwork 05:26:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Running setup.py install for mozprocess 05:26:15 INFO - Running setup.py install for mozprofile 05:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:15 INFO - Running setup.py install for mozrunner 05:26:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:16 INFO - Running setup.py install for mozscreenshot 05:26:16 INFO - Running setup.py install for moztest 05:26:16 INFO - Running setup.py install for mozversion 05:26:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:16 INFO - Cleaning up... 05:26:16 INFO - Return code: 0 05:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:16 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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:26:16 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 05:26:16 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 05:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:16 INFO - 'HOME': '/Users/cltbld', 05:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:16 INFO - 'LOGNAME': 'cltbld', 05:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:16 INFO - 'MOZ_NO_REMOTE': '1', 05:26:16 INFO - 'NO_EM_RESTART': '1', 05:26:16 INFO - 'PAGER': '/bin/cat', 05:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:16 INFO - 'PWD': '/builds/slave/test', 05:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:16 INFO - 'SHELL': '/bin/bash', 05:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:16 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:16 INFO - 'USER': 'cltbld', 05:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:16 INFO - 'XPC_FLAGS': '0x0', 05:26:16 INFO - 'XPC_SERVICE_NAME': '0', 05:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:16 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-NPPmKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-2SKYnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-GubCIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-rauvOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-WTvMNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-MbSzCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-hpJhb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-62wwtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-K1dom6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-HFlJ3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:17 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)) 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:17 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-gUjTSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:18 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-mNxAVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:18 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-dcaGrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:18 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-KTLAzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:18 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-RjCKT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:18 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-KJCYG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:18 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Yo_zuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:18 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)) 05:26:18 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)) 05:26:18 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)) 05:26:18 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)) 05:26:18 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)) 05:26:18 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)) 05:26:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:18 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 05:26:18 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 05:26:18 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 05:26:18 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 05:26:18 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 05:26:18 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 05:26:21 INFO - Downloading blessings-1.6.tar.gz 05:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:21 INFO - Installing collected packages: blessings 05:26:21 INFO - Running setup.py install for blessings 05:26:21 INFO - Successfully installed blessings 05:26:21 INFO - Cleaning up... 05:26:21 INFO - Return code: 0 05:26:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:21 INFO - Reading from file tmpfile_stdout 05:26:21 INFO - Current package versions: 05:26:21 INFO - blessings == 1.6 05:26:21 INFO - blobuploader == 1.2.4 05:26:21 INFO - docopt == 0.6.1 05:26:21 INFO - functools32 == 3.2.3-2 05:26:21 INFO - jsonschema == 2.5.1 05:26:21 INFO - manifestparser == 1.1 05:26:21 INFO - mozInstall == 1.12 05:26:21 INFO - mozcrash == 0.17 05:26:21 INFO - mozdebug == 0.1 05:26:21 INFO - mozdevice == 0.48 05:26:21 INFO - mozfile == 1.2 05:26:21 INFO - mozhttpd == 0.7 05:26:21 INFO - mozinfo == 0.9 05:26:21 INFO - mozleak == 0.1 05:26:21 INFO - mozlog == 3.2 05:26:21 INFO - moznetwork == 0.27 05:26:21 INFO - mozprocess == 0.23 05:26:21 INFO - mozprofile == 0.28 05:26:21 INFO - mozrunner == 6.12 05:26:21 INFO - mozscreenshot == 0.1 05:26:21 INFO - mozsystemmonitor == 0.3 05:26:21 INFO - moztest == 0.7 05:26:21 INFO - mozversion == 1.4 05:26:21 INFO - psutil == 3.1.1 05:26:21 INFO - requests == 1.2.3 05:26:21 INFO - wsgiref == 0.1.2 05:26:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:21 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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:26:21 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 05:26:21 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 05:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:21 INFO - 'HOME': '/Users/cltbld', 05:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:21 INFO - 'LOGNAME': 'cltbld', 05:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:21 INFO - 'MOZ_NO_REMOTE': '1', 05:26:21 INFO - 'NO_EM_RESTART': '1', 05:26:21 INFO - 'PAGER': '/bin/cat', 05:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:21 INFO - 'PWD': '/builds/slave/test', 05:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:21 INFO - 'SHELL': '/bin/bash', 05:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:21 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:21 INFO - 'USER': 'cltbld', 05:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:21 INFO - 'XPC_FLAGS': '0x0', 05:26:21 INFO - 'XPC_SERVICE_NAME': '0', 05:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 INFO - Cleaning up... 05:26:22 INFO - Return code: 0 05:26:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:22 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')]} 05:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:22 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')]} 05:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:22 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 0x105925a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ba618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fad9e070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, '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.TtUVD1zbEX/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.F82u2TpY23/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 05:26:22 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 05:26:22 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 05:26:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:22 INFO - 'HOME': '/Users/cltbld', 05:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:22 INFO - 'LOGNAME': 'cltbld', 05:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:22 INFO - 'MOZ_NO_REMOTE': '1', 05:26:22 INFO - 'NO_EM_RESTART': '1', 05:26:22 INFO - 'PAGER': '/bin/cat', 05:26:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:22 INFO - 'PWD': '/builds/slave/test', 05:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:22 INFO - 'SHELL': '/bin/bash', 05:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:22 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:22 INFO - 'USER': 'cltbld', 05:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:22 INFO - 'XPC_FLAGS': '0x0', 05:26:22 INFO - 'XPC_SERVICE_NAME': '0', 05:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:22 INFO - Cleaning up... 05:26:22 INFO - Return code: 0 05:26:22 INFO - Running post-action listener: _resource_record_post_action 05:26:22 INFO - Running post-action listener: _start_resource_monitoring 05:26:22 INFO - Starting resource monitoring. 05:26:22 INFO - ##### 05:26:22 INFO - ##### Finished create-virtualenv step (success) 05:26:22 INFO - ##### 05:26:22 INFO - ##### 05:26:22 INFO - ##### Running install step. 05:26:22 INFO - ##### 05:26:22 INFO - Running pre-action listener: _resource_record_pre_action 05:26:22 INFO - Running main action method: install 05:26:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:22 INFO - Reading from file tmpfile_stdout 05:26:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:22 INFO - Reading from file tmpfile_stdout 05:26:22 INFO - Output received: 05:26:22 INFO - Usage: mozinstall [options] installer 05:26:22 INFO - Options: 05:26:22 INFO - -h, --help show this help message and exit 05:26:22 INFO - -d DEST, --destination=DEST 05:26:22 INFO - Directory to install application into. [default: 05:26:22 INFO - "/builds/slave/test"] 05:26:22 INFO - --app=APP Application being installed. [default: firefox] 05:26:22 INFO - mkdir: /builds/slave/test/build/application 05:26:22 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'] 05:26:22 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 05:26:57 INFO - Reading from file tmpfile_stdout 05:26:57 INFO - Output received: 05:26:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:26:57 INFO - Running post-action listener: _resource_record_post_action 05:26:57 INFO - ##### 05:26:57 INFO - ##### Finished install step (success) 05:26:57 INFO - ##### 05:26:57 INFO - ##### 05:26:57 INFO - ##### Running run-tests step. 05:26:57 INFO - ##### 05:26:57 INFO - Running pre-action listener: _resource_record_pre_action 05:26:57 INFO - Running main action method: run_tests 05:26:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:57 INFO - 2016-07-19 05:26:57.823 screenresolution[1641:7344] starting screenresolution argv=screenresolution get 05:26:57 INFO - 2016-07-19 05:26:57.825 screenresolution[1641:7344] Display 0: 1600x1200x32@60 05:26:57 INFO - 2016-07-19 05:26:57.831 screenresolution[1642:7346] starting screenresolution argv=screenresolution list 05:26:57 INFO - Available Modes on Display 0 05:26:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:58 INFO - Intel Iris: 05:26:58 INFO - Chipset Model: Intel Iris 05:26:58 INFO - Type: GPU 05:26:58 INFO - Bus: Built-In 05:26:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:58 INFO - Vendor: Intel (0x8086) 05:26:58 INFO - Device ID: 0x0a2e 05:26:58 INFO - Revision ID: 0x0009 05:26:58 INFO - Displays: 05:26:58 INFO - Display: 05:26:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:58 INFO - Display Serial Number: 1600x1200 60 05:26:58 INFO - Main Display: Yes 05:26:58 INFO - Mirror: Off 05:26:58 INFO - Online: Yes 05:26:58 INFO - Rotation: Supported 05:26:58 INFO - Return code: 0 05:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:58 INFO - Python 2.7.3 05:26:58 INFO - Return code: 0 05:26:58 INFO - grabbing minidump binary from tooltool 05:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:58 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 0x105889d30>, '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 0x1055eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105881b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:58 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 05:26:58 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 05:26:58 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 05:26:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:58 INFO - Return code: 0 05:26:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:26:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:26:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:58 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/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--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 05:26:58 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/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0379 --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 05:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TtUVD1zbEX/Render', 05:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:58 INFO - 'HOME': '/Users/cltbld', 05:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:58 INFO - 'LOGNAME': 'cltbld', 05:26:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:58 INFO - 'MOZ_NO_REMOTE': '1', 05:26:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:58 INFO - 'NO_EM_RESTART': '1', 05:26:58 INFO - 'PAGER': '/bin/cat', 05:26:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:58 INFO - 'PWD': '/builds/slave/test', 05:26:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:58 INFO - 'SHELL': '/bin/bash', 05:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F82u2TpY23/Listeners', 05:26:58 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 05:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:58 INFO - 'USER': 'cltbld', 05:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:58 INFO - 'XPC_FLAGS': '0x0', 05:26:58 INFO - 'XPC_SERVICE_NAME': '0', 05:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:58 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/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--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 05:26:58 INFO - mozversion application_buildid: 20160719020320 05:26:58 INFO - mozversion application_changeset: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 05:26:58 INFO - mozversion application_display_name: Nightly 05:26:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:58 INFO - mozversion application_name: Firefox 05:26:58 INFO - mozversion application_remotingname: firefox 05:26:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:26:58 INFO - mozversion application_vendor: Mozilla 05:26:58 INFO - mozversion application_version: 50.0a1 05:26:58 INFO - mozversion platform_buildid: 20160719020320 05:26:58 INFO - mozversion platform_changeset: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 05:26:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:26:58 INFO - mozversion platform_version: 50.0a1 05:26:58 INFO - using testdate: 1468931218 05:26:58 INFO - actual date: 1468931218 05:26:58 INFO - starting webserver on 'localhost:49266' 05:26:58 INFO - SUITE-START | Running 2 tests 05:26:58 INFO - TEST-START | dromaeo_css 05:26:58 INFO - operating with platform_type : mac_ 05:26:58 INFO - Initialising browser for dromaeo_css test... 05:26:58 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpXAgBov/profile http://localhost:49266/getInfo.html) 05:27:00 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 05:27:00 INFO - PROCESS | 1652 | colorDepth:24 05:27:00 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 05:27:00 INFO - PROCESS | 1652 | __metrics 05:27:01 INFO - PROCESS | 1652 | 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" 05:27:01 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:01 INFO - TEST-INFO | 1652: exit 0 05:27:01 INFO - Browser initialized. 05:27:01 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:01 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpXAgBov/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:13 INFO - PROCESS | 1655 | RSS: Main: 245170176 05:27:13 INFO - PROCESS | 1655 | 05:28:05 INFO - PROCESS | 1655 | 1468931285504 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] 05:30:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 05:30:18 INFO - PROCESS | 1655 | RSS: Main: 436920320 05:30:18 INFO - PROCESS | 1655 | 05:33:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 05:33:22 INFO - PROCESS | 1655 | RSS: Main: 383270912 05:33:22 INFO - PROCESS | 1655 | 05:36:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 05:36:25 INFO - PROCESS | 1655 | RSS: Main: 374824960 05:36:25 INFO - PROCESS | 1655 | 05:39:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 05:39:28 INFO - PROCESS | 1655 | RSS: Main: 373518336 05:39:28 INFO - PROCESS | 1655 | 05:42:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 05:42:32 INFO - PROCESS | 1655 | RSS: Main: 340217856 05:42:32 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:45:35 INFO - PROCESS | 1655 | RSS: Main: 414433280 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | __start_tp_report 05:45:35 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 05:45:35 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 05:45:35 INFO - PROCESS | 1655 | |i|pagename|runs| 05:45:35 INFO - PROCESS | 1655 | |0;dojo.html;2501.93745156371;3297.8127873965377;3349.0287816533205;3370.1743072947133;3418.641042690517;5625.240592520008;5634.887302253953;5682.948654498916;5724.141378793172;5748.166515855193;5729.197912292272;5760.62555933864;5761.1358296255585;5762.3373312069125;5766.682832444214;5184.974075129629;5235.581153507729;5239.10935141025;5273.499017593323;5312.2828418163435;5222.060029194743;5258.55302299305;5258.789648414078;5270;5276.472352764731;5174.948250517485;5200.271961925334;5201.115810312237;5202.453742357055;5251.868703282429;5247.737613119367;5260.421353651133;5276.050310944029;5277.8416647500635;5348.572114230852;5074.746262686851;5083.262926875583;5158.097332966753;5196.714180720059;5203.713795741232;5638.464345887134;5696.658200507983;5705.2012718219485;5721.71391430431;5757.222774925373;6272.898578976048;6303.684815759239;6318.7472501100365;6319.6524191169465;6324.430801227865;5610.76563156105;5966.164736936832;6233.968830155865;6356.269029061625;6360.363963603649;5822.272215973004;5826.941730582725;5827.4172582741385;5854.677992710442;5894.086416605433;6274.435300822856;6288.748450061947;6292.748290068346;6301.275353334334;6302.968485157545;5971.223740913653;6048.60684055535;6064.545159113084;6142.416470435302;6159.23009623797;6137.110119032715;6179.2584889812615;6202.255729312511;6213.65824879627;6215;6122.387761223931;6174.228221472316;6179.81460556184;6235.688215589203;6241.970074937675;6225.688715564294;6229.595076320024;6273.686315684289;6282.434580887742;6288.056791481223;4811.182099043171;4874.317595536628;4904.485029071896;4909;4944.381952255968;4380.518143004267;4445.488768791631;4472.172648060119;4481.215787237221;4489.9775501122285;5684.37471878093;5714.79998200061;5750.281214848144;5775.826725198251;5806.216160818235;6285.214348206474;6321.1782468278825;6323.620582765049;6342.112104305401;6358.109864618865;5767.279090113736;5768.798092066758;5776.768929242783;5784.537237021028;5793.2179155814265;5316.069687804618;5368;5369.087255166631;5382.542483888835;5384.40771515133;6263.6241825490615;6265.404786545271;6278.497720182466;6282.968585157045;6285.120083188357;6258.937410625836;6309.3690630936535;6348.428641422294;6349.7142628580905;6350.364963503613;6310.49516038725;6313.936860631335;6313.936860631335;6315.273743519554;6322.36776322364;6072;6116.487945662287;6257.624542527463;6263.530235232467;6267.0286105653695;5116.9232461512365;5956.910646340221;6262.405071518198;6287.591306565058;6291.150694656163;5143.768530416065;6060.969695151496;6072.14989901423;6075.635461872302;6123.510119190543;6114.206128133634;6122.733612273255;6125.357545073132;6137.144455097482;6145.647957449354;5176.818811341585;5961.076033214858;6016.217891674054;6034.668093254913;6060.1212824139375;5985.521158307412;6067.271927368567;6100;6116.797828496971;6193.783217587363;5961.91057134152;5998.520118390431;6017.217761690952;6026.0659597762415;6065.120557519047 05:45:35 INFO - PROCESS | 1655 | |1;ext.html;513.2096571280229;525.1964494323684;535.6759160707774;543.3506959183775;554.9361823390311;23886.88056559717;40860;41370;41706.16587668253;41717.582824171746;43202.7839860801;43412;43568.12863742723;43602.12795744083;43638;8701;9644.22846172308;9810.754731131743;9817.852732208987;9821.263405244636;8087.757367278961;11854.288742675424;12019.459124339382;12022.819657705099;12238.877611223863;11870.287782733021;11951.880481195207;11962.581309654164;11963.521459141624;11975.341356225405;8829.646814127427;8963.686270980485;11887.286762794216;11945.58190463334;11994.22037567564;8777.73666789991;8854.557272136368;11572.59495917639;11771;11821.881781182165;41119.972000700225;41493.37759933603;41534.75395738133;41536.37695434571;41736;3536.7877927324444;3590.35373632746;4006.338954072604;4233.978830105861;4254.680898932562;31475.52786708201;32027.359452811048;32325;32430.675693243;32624.836875815705;3266.591676040495;3302.0424077017638;3331.783434076777;3352.2960178362327;3413.1808365992233;479896;483963;485141;486099;486153;61940.69029654823;62183.6890815543;62624.68687656624;62637.686811566564;62661.43346416376;64984.700305994564;65062;65082.67458662771;65206.67396663081;65431.67284163549;16249.918750406408;16861.325546978227;16874.74687879683;16877.240524176195;16885.24016419264;11716.414179291172;11897.167198296209;12712.42794074269;12928.806067908989;12988.090833641554;17180.828191718174;17215.22531486086;17225.65548689019;17230.310787568356;17255.137243137793;5663.292088488939;6555.278919318871;6561.2782593914635;6635.170603674541;6637.634930078795;852.1660043102528;883.960221790021;929.6792606550729;987.8518222266574;1131.5191043806349;26523.104531179826;30647.387052259277;31053;31239.219019524695;31505.36989260202;1080.4705694209938;1130.1298000539703;1133.8525991621202;1135.6649788312468;1186.2526608236756;15300.464483743015;15991.36034558628;16045.277962491717;16059;16495.422660206834;692044;696879;702296.4885175541;702811;704268;59802;60092;60118;60122.098168527504;60222.698886505284;1272.1476610670873;1314.1523717202542;1395.4348488862026;1419.8793102586396;1442.7980082788417;31116.066518004496;31962.68037319597;31969.520457193626;32653.673463265062;32778.67221327756;51382.74308628433;51818.48181518137;51923.740381299365;52012;52035;377775;443168;445924;447896;448136;40167.799161004004;40765.796171018956;41656.750297491126;41693;41780.164396712506;48327.03345933132;48768.02463950772;49243.01513969629;49291.753541232065;49823;32670.50994235136;39733.403998940616;40255.396169058076;41451.37822932598;41543.58456415397;34551;39445.09128743821;40558.39162412507;40738.79630601828;41329.58670413378;38336.84989450321;39232.607673922896;39371.803140985256;39454.61908833177;39518.40722389109;29043.419131617673;32365.676343236268;34151.829240853636;35124.473132903535;35232.29535409329;21755.78244217601;25624.87187564125;25766.871165644803;25994.35014124662;26221.34446638849 05:45:35 INFO - PROCESS | 1655 | |2;jquery.html;324.4111936834645;335.9697627213552;356.21987846615923;381.4012001158182;406.461438593863;15716.764248536281;17883.463496095123;20486.888391429497;21156;21198.89400552995;18148.81851181488;20627.27804526842;21383.893080534614;21750.89124554379;21767;5475.397706252309;5976.19321391612;6217.378262173769;6251.281102673182;6257.749690012394;4281.892952676177;4514.6388288936805;6030.125631783389;6588.8023359299295;6916.377526022657;6550.508711846631;6850.794476165723;6870.896936545956;6890.966355046733;6898.172219333687;6741.359570840787;6766.627835469048;6769.661516924159;6780;6795.728170873159;5667.866426714673;5880.617759845639;5901.822945311647;5943.257092863392;5949.791757288517;26423.47153056928;27078.32304192391;27149.45701085967;27331.86334068337;27376;2475.207933461275;2488.5645012122986;2517.6852893388327;2568.165346262472;2583.7932965362725;13420.396082176325;15493.922530387388;16032.038077715375;16463.176841158012;16481.835181648148;1830.3685228596246;1849.4544109487733;1906.1231833356674;1921.5292253397868;1926.5376309685714;61462.69268653673;79418.60290698567;80088.19911800866;127716;129001.35499322537;8326.04250511199;9213.447193168431;9690.273229507815;10919.781604367869;11097.667069987914;11444.656660300205;13663.453461861613;13778.242196679079;13808.17150970945;13836.23900685472;8652.567371631394;8686.869696954423;8734.388592798443;8736.737897863075;8781.34139939507;8890.244329232088;8913.420627659181;8914.28685705142;9072.319576031825;9102.90897091034;6555.541112122106;6690.933090669128;6692.799216023527;6692.933070669328;6750.864982700318;1693.5088824240831;1796.1558067708418;1800.5498625343664;1822.6354729054242;1825.6855064353645;770.5761830992932;937.554661535765;967.2890425537224;1043.4834756795283;1068.471106802138;20014.399568012985;22444.989975451143;22629;22630.886845565667;23016.194433195094;963.4171326347599;975.4537459022828;987.9506024698736;1028.1671845804922;1055.9736006599742;9172.908270917338;11913.940430297793;11959.820602690967;12188.146829721834;12301.446434910451;595117;612559;621319;628377;629246;95075;122764;127902;129427;129824.70175298315;910.3672947301562;916.4272329793879;1034.3690348887174;1100.6147848253047;1104.5526561742506;16670.916645416695;20385.388438346872;20496.69254961147;21149;21309;41560.753177404724;46661.766691166325;52354;53495;53895.19157212723;75214.24785752072;76453;76571;77310;77474.6126269365;5887.20522729426;7231.8553628928175;7255.746048888263;8353.289970352587;8470.915290847013;8885.511296878734;12366.505339786308;13113.672158196121;13951.372188251757;14028.649283767987;11687.240329378903;11867.228630139014;11868.347240901488;11941.52233910634;12020.519179233082;11466.025387842126;11742.412879355827;11768.646940591796;12008.75982480363;12015.219010764622;11565.826512602149;11784.76430471403;12022.458989345325;12038.337891416057;12096.213746106476;8183.304419124441;8201.548914809504;8247.463914845515;8301.128381519853;8470.83058338842;11721.003714684348;11824.645260642195;11947.76104477923;11968.521259149536;11972.461239244081 05:45:35 INFO - PROCESS | 1655 | |3;mootools.html;1551.1081128351198;1591.5543647778622;1780.7685000949875;1901.8478521718264;1916.6262578797132;8524.829503409936;8776.341774366916;8981.95509022454;9009.774755631113;9043.593038313275;7787.844243115134;8035.437519373646;8451.53516556589;8744.519051452167;8795.208431241186;2322.152414368756;2356.45801465663;2357.691481227918;2359.834811563191;2361.161787565407;2335.7313908900437;2338.38032921276;2367.5264947010583;2369.6208606622945;2374.76252374762;2081.9687704684443;2153.720016397874;2154.8922553872244;2158.352494251726;2340.028888011473;2276.3171048685413;2360.2565191964477;2361.51588924271;2364.4916342986166;2372;2312.340982819905;2328.941776455602;2334.8132149428175;2336.4275752440763;2343.0042232051483;8869.201771840566;8923.330750193696;8927.508987005713;8928.464292142493;8933.46399216049;5157.767900444489;5271.499207575274;5331.920021199685;5334.546563542103;5341.759620817073;3433.7081348085194;3542.36237477254;3576.3920133577353;3596.478510615972;3617.2584620152807;1061.644349143038;1084.3331351219022;1084.3656460970342;1089.0742868561738;1104.3318792130726;11550.422478876106;11566.826497602542;11581.305121692641;11589.710257243552;11631.30212187263;3840.577536470986;4548.408706868086;4574.8562859285175;4667.8599642010795;4684.2271025281125;9849.655262065793;9874.60501579943;9890;9897.65358212459;9901.60393584263;5286.894262114736;5290.9735451322495;5291.1798671206025;5292.285541451854;5311.920321195185;3907.4529565860803;4157.355609880473;4210.473690788652;4691.413573303337;4845.685030473008;3836.271108489378;3884.6115388460926;3958.287508248485;3988.960110398859;4018.8995275117773;1251.4493622805937;1266.5883587833991;1271.262667652759;1285.203174032106;1289.6389011076913;822.5393779483509;877.1842186766369;904.8099899021148;929.2983797233181;945.9905400946041;5660;5878.588498805043;5882.941170588325;5980.162777211194;6115.480184184395;427.5831064711881;433.425710933015;434.4938147058704;439.1480527776104;451.31174958189024;3671;3974.4435778990965;4002.699797515198;4059.79701014954;4095.2219078375015;10318.690439286833;10759.892401076046;10836.458177091114;10869.45652717361;10888.40113793749;10804.1896857736;10816.513256903458;10818.29681070728;10828.24202305831;10829.945850270857;7561.697532098655;7885.960570197112;8199.631016604268;8258.628361723737;8264.917350826536;6005.484049806009;6035.818925432244;6057.273127224585;6081.756729730938;6136.588584625651;10168;10233.897661023295;10316.43259620698;10320.896791032294;10349;9931.354461959949;10031.749206269902;10285.125764310118;10435.426051567236;10482.266241363031;7035.6833942471685;7241.348278654947;7420.480566360303;7542.094948606203;8003.719869804529;8284.088750237348;8356.665733370597;8418.663253470038;8431.747047588582;8441.15588441151;7347.595882226529;7446.218147094477;7490.737824176128;7543.169637107673;7559.924400755922;7260.49176557657;7275.708971641075;7354.080739907512;7420.295071968154;7533.1336896257635;6995.0906382172025;7033.050538177281;7078.823029424306;7083.610401427971;7087.433005359662;4871.318015477907;5068.442471328225;5091.210862316347;5109.054824857413;5119.960302691974;5037;5048;5110.514501122388;5116.3860336758335;5257.553107985864 05:45:35 INFO - PROCESS | 1655 | |4;prototype.html;253.96952365716106;308.7607104494017;315.96840315968404;319.6914977047152;321.79887570268585;5325.751291712062;5370.194470829378;5383.407825139237;5389.1646794746775;5403.864903377417;4312.956870431295;5062.544371006608;5174.689518628885;5294.761735721892;5301.542075929121;3679.6872265857432;4007.777627823513;4084.5711200323985;4130.566290539495;4141.275276826558;3457.3258214648154;3959.564447910742;4125.2986992211245;4137.420761093449;4146.460960075186;2977.895773647923;3845.154325923558;4050.736702114353;4124.97937510312;4188.874333769992;3415.7779744316663;4057.513098428178;4082.8775136745944;4086.5504794472586;4103.999999999985;3281.770276080675;3553.4314509678584;3554.147004718849;3561.4301711726;3563.7861728296384;4272.9104078459795;4871.621487241689;5082.745862706887;5120.667156634807;5162.432132465426;4656.580907718288;4672.462666793294;4683.859484215479;4697.295405689139;4726.314684370747;4484.484284307314;5598.272224610774;5612.831615051555;5634.408387119334;5639.746211420496;3746.5316835395574;3973.264945984973;3981.5819338969573;3987.7806720630356;4008.8574756194635;5915.08316210988;5924.703764811742;5929.377415371367;5934.703264836741;5951.761929522814;4052.858149964796;4071.755694658271;4076.3274059779806;4078.225137223977;4078.6940979426663;3988.6210809973004;4108.91782164355;4114.218298523271;4125.257453658371;4136.234796562646;3950.9012274693364;4714.198586240347;4719.433667959798;4729.989754354386;4737.644676649265;4427.003924117048;5632.549396048306;5667.1782591524825;5734.655920644775;5747.798827041033;1058.433737950193;1163.6392718257368;1385.889128869688;1404.5505438259659;1405.8523854995078;797.3421926910322;856.8072183758604;908.9681861134828;916.1342531307984;965.165132160676;5209.140491818807;5222.686638801684;5261.894762104736;5286.60350473716;5289.656172348785;5727.8568035799435;5745.88508229833;5776.797812076557;5786.826395208151;5827.533797296206;5032.515407954662;5063.3417655704525;5117.539795968642;5250.816221432232;5274.340707411574;2999.6850330715397;3013.472642287591;3027.576139340494;3031.2570272093194;3039.6200474940633;5206.943257413301;5941.910871336933;5960.92703313399;5963.880722385528;5964.940350596526;5162.3030890830005;5867.061270196748;5869.266341707286;5887.558433117533;5932.822015339547;5155.639105262596;5677.602567820213;5738.82354117405;5860.124760076735;5919.733611987384;5115.74421278942;5508.889822203453;5709.9714501427225;5719.428057194247;5731.8567035824435;4863.610911127031;5490.7762356245785;5600.299962504687;5645.548356131581;5667.291588551431;5098.719570423514;5216.530512253916;5245.842624721265;5847.210626565359;5906.881862362815;3597.640235976486;3803.1633040730994;3974.7615143091507;4003.57962413954;4036.91926161481;4783.306420568929;4808.3989501312335;5448.891022179455;5643.943560564342;5694.857628559319;4663.580277775017;5442.945570544244;5537.363203231519;5544.500994910478;5546.140348246028;5104.897902042013;5518.2826232591115;5621.9156712650165;5636.702529020569;5638.746256418389;5502.532284755841;5502.862428439321;5517.310336207974;5530.787684925901;5551;5336.519713225828;5362.71294889216;5628.521575665951;5632.662040277596;5650.463205995424;5041.571466425248;5462.8907421850545;5499.377683583272;5525.254090697705;5537.861553461034 05:45:35 INFO - PROCESS | 1655 | |5;yui.html;628.6825153297585;744.2817680937894;754.0762565856822;776.2625505769519;817.6524976884823;14045.789313160298;15198.088114713111;15205.16371599563;15210.23948802561;15223.619409514768;11551.768964620702;13465.394057267422;13888.23614701191;13920.791188132187;14273.50042748504;876.5266755951778;888.6134531478828;890.2432932007774;892.1257167975388;893.7631527645146;860.5482121885997;870.6169285514353;871.6905498548019;872.4852337121097;872.9258013068896;916.9037251088606;918.0727465260102;918.2011649864627;918.8254231695956;919.8068405634825;914.6387177065088;914.6935776514875;915.3135148638521;915.3501014279869;917.687986084731;678.9966050169718;679.3715812873122;679.7654809090856;679.8402375441767;681.2914568848391;12906.612801615967;12922.28927408992;12931.224126552437;12931.741365172738;12932.612021639367;12165.20926139798;12183.93908030463;12222.938885305606;12255.816162757477;12735.617931462071;8675.783105422352;11276;11509.94245028778;12045.63863084109;12283.93858030713;4645.976770116162;4664.790084446174;4668.95331046692;4688.320193571947;4713.835015774465;108475;113674.35907691048;114337.4283128579;114384.85615143825;114620.42689786498;10876.184286178568;11055.502502387411;11066.778664426667;11149.498272577754;11546.76906461866;21200.575988480145;21205.893970530047;21206.893965530075;21223.68164477534;21232.681509777365;7115.89326160108;7947.642356093874;7969.203079691984;8003.559804210708;8034.196580341919;4000.859969901098;4429.136318417942;4484.304932735431;4503.347014682852;4673.971726220226;3395.575553055868;3407.16524451511;3492.5634295713035;3494.790312581253;3497.213127046445;651.8500744828716;656.9113169722026;660.7191943424122;667.89981502774;723.3959643697572;613.2610204703321;670.0167504187558;687.7764726463919;697.8778713725078;706.0997228533661;9649.179819715262;9838.65564705232;9881.703548893545;9924.801503970024;9926.652567160114;585.2742599176989;591.4262967120426;642.5341627320249;676.8172593399754;691.381213813634;4568.729408962802;4601.148787474328;4729.385179926657;4751.168545504523;4896.902061958812;93551;136609.63390366168;145174;165805.17097414436;165982;73880;85651.57174214089;105285;113920.75990501187;139873;98841;100965.48551771729;104259.95740042655;106005;106381.46809265904;9349.85975210386;9530.332876698565;9558.617655293989;9570.808583828424;9701.272404569545;57122.28705134153;58093;58382;58603;59482;65278;65697;82244;90700;91840.54079729559;12007.519699211934;13450.120099275347;14051.156930584199;14090.295485225903;14319.427222910967;14847.480338188112;15153.772693409828;15553.222338883237;15842.841571584599;15910.920445397698;13762.311884405939;13866.584002479942;13993.930030349784;14122.929385353007;14206.360713767699;13365.933170334474;13486.86513134856;13591;13787.034907556375;13931.721365572834;13614.523491677744;13872.514461993782;14028.579142625738;14360.856391435951;14372.36313098716;11170.08010694223;11301.660950171508;11448.803201380495;11563.537458501902;12389.132760706663;8927.598258078273;10401.739956500845;10722.296772021065;11503.411732360151;11746.119041071783 05:45:35 INFO - PROCESS | 1655 | __end_tp_report 05:45:35 INFO - PROCESS | 1655 | __start_cc_report 05:45:35 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1905 05:45:35 INFO - PROCESS | 1655 | __end_cc_report 05:45:35 INFO - PROCESS | 1655 | __startTimestamp1468932335363__endTimestamp 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | ------- Summary: start ------- 05:45:35 INFO - PROCESS | 1655 | Number of tests: 6 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5738.35 Median:5966.16 stddev:666.79 (11.2%) stddev-sans-first:618.61 05:45:35 INFO - PROCESS | 1655 | Values: 2501.9 3297.8 3349.0 3370.2 3418.6 5625.2 5634.9 5682.9 5724.1 5748.2 5729.2 5760.6 5761.1 5762.3 5766.7 5185.0 5235.6 5239.1 5273.5 5312.3 5222.1 5258.6 5258.8 5270.0 5276.5 5174.9 5200.3 5201.1 5202.5 5251.9 5247.7 5260.4 5276.1 5277.8 5348.6 5074.7 5083.3 5158.1 5196.7 5203.7 5638.5 5696.7 5705.2 5721.7 5757.2 6272.9 6303.7 6318.7 6319.7 6324.4 5610.8 5966.2 6234.0 6356.3 6360.4 5822.3 5826.9 5827.4 5854.7 5894.1 6274.4 6288.7 6292.7 6301.3 6303.0 5971.2 6048.6 6064.5 6142.4 6159.2 6137.1 6179.3 6202.3 6213.7 6215.0 6122.4 6174.2 6179.8 6235.7 6242.0 6225.7 6229.6 6273.7 6282.4 6288.1 4811.2 4874.3 4904.5 4909.0 4944.4 4380.5 4445.5 4472.2 4481.2 4490.0 5684.4 5714.8 5750.3 5775.8 5806.2 6285.2 6321.2 6323.6 6342.1 6358.1 5767.3 5768.8 5776.8 5784.5 5793.2 5316.1 5368.0 5369.1 5382.5 5384.4 6263.6 6265.4 6278.5 6283.0 6285.1 6258.9 6309.4 6348.4 6349.7 6350.4 6310.5 6313.9 6313.9 6315.3 6322.4 6072.0 6116.5 6257.6 6263.5 6267.0 5116.9 5956.9 6262.4 6287.6 6291.2 5143.8 6061.0 6072.1 6075.6 6123.5 6114.2 6122.7 6125.4 6137.1 6145.6 5176.8 5961.1 6016.2 6034.7 6060.1 5985.5 6067.3 6100.0 6116.8 6193.8 5961.9 5998.5 6017.2 6026.1 6065.1 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:68710.88 Median:40211.60 stddev:147285.58 (366.3%) stddev-sans-first:147609.75 05:45:35 INFO - PROCESS | 1655 | Values: 513.2 525.2 535.7 543.4 554.9 23886.9 40860.0 41370.0 41706.2 41717.6 43202.8 43412.0 43568.1 43602.1 43638.0 8701.0 9644.2 9810.8 9817.9 9821.3 8087.8 11854.3 12019.5 12022.8 12238.9 11870.3 11951.9 11962.6 11963.5 11975.3 8829.6 8963.7 11887.3 11945.6 11994.2 8777.7 8854.6 11572.6 11771.0 11821.9 41120.0 41493.4 41534.8 41536.4 41736.0 3536.8 3590.4 4006.3 4234.0 4254.7 31475.5 32027.4 32325.0 32430.7 32624.8 3266.6 3302.0 3331.8 3352.3 3413.2 479896.0 483963.0 485141.0 486099.0 486153.0 61940.7 62183.7 62624.7 62637.7 62661.4 64984.7 65062.0 65082.7 65206.7 65431.7 16249.9 16861.3 16874.7 16877.2 16885.2 11716.4 11897.2 12712.4 12928.8 12988.1 17180.8 17215.2 17225.7 17230.3 17255.1 5663.3 6555.3 6561.3 6635.2 6637.6 852.2 884.0 929.7 987.9 1131.5 26523.1 30647.4 31053.0 31239.2 31505.4 1080.5 1130.1 1133.9 1135.7 1186.3 15300.5 15991.4 16045.3 16059.0 16495.4 692044.0 696879.0 702296.5 702811.0 704268.0 59802.0 60092.0 60118.0 60122.1 60222.7 1272.1 1314.2 1395.4 1419.9 1442.8 31116.1 31962.7 31969.5 32653.7 32778.7 51382.7 51818.5 51923.7 52012.0 52035.0 377775.0 443168.0 445924.0 447896.0 448136.0 40167.8 40765.8 41656.8 41693.0 41780.2 48327.0 48768.0 49243.0 49291.8 49823.0 32670.5 39733.4 40255.4 41451.4 41543.6 34551.0 39445.1 40558.4 40738.8 41329.6 38336.8 39232.6 39371.8 39454.6 39518.4 29043.4 32365.7 34151.8 35124.5 35232.3 21755.8 25624.9 25766.9 25994.4 26221.3 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35007.26 Median:27240.66 stddev:102283.59 (375.5%) stddev-sans-first:102537.37 05:45:35 INFO - PROCESS | 1655 | Values: 324.4 336.0 356.2 381.4 406.5 15716.8 17883.5 20486.9 21156.0 21198.9 18148.8 20627.3 21383.9 21750.9 21767.0 5475.4 5976.2 6217.4 6251.3 6257.7 4281.9 4514.6 6030.1 6588.8 6916.4 6550.5 6850.8 6870.9 6891.0 6898.2 6741.4 6766.6 6769.7 6780.0 6795.7 5667.9 5880.6 5901.8 5943.3 5949.8 26423.5 27078.3 27149.5 27331.9 27376.0 2475.2 2488.6 2517.7 2568.2 2583.8 13420.4 15493.9 16032.0 16463.2 16481.8 1830.4 1849.5 1906.1 1921.5 1926.5 61462.7 79418.6 80088.2 127716.0 129001.4 8326.0 9213.4 9690.3 10919.8 11097.7 11444.7 13663.5 13778.2 13808.2 13836.2 8652.6 8686.9 8734.4 8736.7 8781.3 8890.2 8913.4 8914.3 9072.3 9102.9 6555.5 6690.9 6692.8 6692.9 6750.9 1693.5 1796.2 1800.5 1822.6 1825.7 770.6 937.6 967.3 1043.5 1068.5 20014.4 22445.0 22629.0 22630.9 23016.2 963.4 975.5 988.0 1028.2 1056.0 9172.9 11913.9 11959.8 12188.1 12301.4 595117.0 612559.0 621319.0 628377.0 629246.0 95075.0 122764.0 127902.0 129427.0 129824.7 910.4 916.4 1034.4 1100.6 1104.6 16670.9 20385.4 20496.7 21149.0 21309.0 41560.8 46661.8 52354.0 53495.0 53895.2 75214.2 76453.0 76571.0 77310.0 77474.6 5887.2 7231.9 7255.7 8353.3 8470.9 8885.5 12366.5 13113.7 13951.4 14028.6 11687.2 11867.2 11868.3 11941.5 12020.5 11466.0 11742.4 11768.6 12008.8 12015.2 11565.8 11784.8 12022.5 12038.3 12096.2 8183.3 8201.5 8247.5 8301.1 8470.8 11721.0 11824.6 11947.8 11968.5 11972.5 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5706.80 Median:4676.04 stddev:3245.03 (69.4%) stddev-sans-first:3239.11 05:45:35 INFO - PROCESS | 1655 | Values: 1551.1 1591.6 1780.8 1901.8 1916.6 8524.8 8776.3 8982.0 9009.8 9043.6 7787.8 8035.4 8451.5 8744.5 8795.2 2322.2 2356.5 2357.7 2359.8 2361.2 2335.7 2338.4 2367.5 2369.6 2374.8 2082.0 2153.7 2154.9 2158.4 2340.0 2276.3 2360.3 2361.5 2364.5 2372.0 2312.3 2328.9 2334.8 2336.4 2343.0 8869.2 8923.3 8927.5 8928.5 8933.5 5157.8 5271.5 5331.9 5334.5 5341.8 3433.7 3542.4 3576.4 3596.5 3617.3 1061.6 1084.3 1084.4 1089.1 1104.3 11550.4 11566.8 11581.3 11589.7 11631.3 3840.6 4548.4 4574.9 4667.9 4684.2 9849.7 9874.6 9890.0 9897.7 9901.6 5286.9 5291.0 5291.2 5292.3 5311.9 3907.5 4157.4 4210.5 4691.4 4845.7 3836.3 3884.6 3958.3 3989.0 4018.9 1251.4 1266.6 1271.3 1285.2 1289.6 822.5 877.2 904.8 929.3 946.0 5660.0 5878.6 5882.9 5980.2 6115.5 427.6 433.4 434.5 439.1 451.3 3671.0 3974.4 4002.7 4059.8 4095.2 10318.7 10759.9 10836.5 10869.5 10888.4 10804.2 10816.5 10818.3 10828.2 10829.9 7561.7 7886.0 8199.6 8258.6 8264.9 6005.5 6035.8 6057.3 6081.8 6136.6 10168.0 10233.9 10316.4 10320.9 10349.0 9931.4 10031.7 10285.1 10435.4 10482.3 7035.7 7241.3 7420.5 7542.1 8003.7 8284.1 8356.7 8418.7 8431.7 8441.2 7347.6 7446.2 7490.7 7543.2 7559.9 7260.5 7275.7 7354.1 7420.3 7533.1 6995.1 7033.1 7078.8 7083.6 7087.4 4871.3 5068.4 5091.2 5109.1 5120.0 5037.0 5048.0 5110.5 5116.4 5257.6 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4570.44 Median:5162.37 stddev:1387.04 (26.9%) stddev-sans-first:1352.56 05:45:35 INFO - PROCESS | 1655 | Values: 254.0 308.8 316.0 319.7 321.8 5325.8 5370.2 5383.4 5389.2 5403.9 4313.0 5062.5 5174.7 5294.8 5301.5 3679.7 4007.8 4084.6 4130.6 4141.3 3457.3 3959.6 4125.3 4137.4 4146.5 2977.9 3845.2 4050.7 4125.0 4188.9 3415.8 4057.5 4082.9 4086.6 4104.0 3281.8 3553.4 3554.1 3561.4 3563.8 4272.9 4871.6 5082.7 5120.7 5162.4 4656.6 4672.5 4683.9 4697.3 4726.3 4484.5 5598.3 5612.8 5634.4 5639.7 3746.5 3973.3 3981.6 3987.8 4008.9 5915.1 5924.7 5929.4 5934.7 5951.8 4052.9 4071.8 4076.3 4078.2 4078.7 3988.6 4108.9 4114.2 4125.3 4136.2 3950.9 4714.2 4719.4 4730.0 4737.6 4427.0 5632.5 5667.2 5734.7 5747.8 1058.4 1163.6 1385.9 1404.6 1405.9 797.3 856.8 909.0 916.1 965.2 5209.1 5222.7 5261.9 5286.6 5289.7 5727.9 5745.9 5776.8 5786.8 5827.5 5032.5 5063.3 5117.5 5250.8 5274.3 2999.7 3013.5 3027.6 3031.3 3039.6 5206.9 5941.9 5960.9 5963.9 5964.9 5162.3 5867.1 5869.3 5887.6 5932.8 5155.6 5677.6 5738.8 5860.1 5919.7 5115.7 5508.9 5710.0 5719.4 5731.9 4863.6 5490.8 5600.3 5645.5 5667.3 5098.7 5216.5 5245.8 5847.2 5906.9 3597.6 3803.2 3974.8 4003.6 4036.9 4783.3 4808.4 5448.9 5643.9 5694.9 4663.6 5442.9 5537.4 5544.5 5546.1 5104.9 5518.3 5621.9 5636.7 5638.7 5502.5 5502.9 5517.3 5530.8 5551.0 5336.5 5362.7 5628.5 5632.7 5650.5 5041.6 5462.9 5499.4 5525.3 5537.9 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:23349.57 Median:4456.72 stddev:36863.40 (827.1%) stddev-sans-first:36927.34 05:45:35 INFO - PROCESS | 1655 | Values: 628.7 744.3 754.1 776.3 817.7 14045.8 15198.1 15205.2 15210.2 15223.6 11551.8 13465.4 13888.2 13920.8 14273.5 876.5 888.6 890.2 892.1 893.8 860.5 870.6 871.7 872.5 872.9 916.9 918.1 918.2 918.8 919.8 914.6 914.7 915.3 915.4 917.7 679.0 679.4 679.8 679.8 681.3 12906.6 12922.3 12931.2 12931.7 12932.6 12165.2 12183.9 12222.9 12255.8 12735.6 8675.8 11276.0 11509.9 12045.6 12283.9 4646.0 4664.8 4669.0 4688.3 4713.8 108475.0 113674.4 114337.4 114384.9 114620.4 10876.2 11055.5 11066.8 11149.5 11546.8 21200.6 21205.9 21206.9 21223.7 21232.7 7115.9 7947.6 7969.2 8003.6 8034.2 4000.9 4429.1 4484.3 4503.3 4674.0 3395.6 3407.2 3492.6 3494.8 3497.2 651.9 656.9 660.7 667.9 723.4 613.3 670.0 687.8 697.9 706.1 9649.2 9838.7 9881.7 9924.8 9926.7 585.3 591.4 642.5 676.8 691.4 4568.7 4601.1 4729.4 4751.2 4896.9 93551.0 136609.6 145174.0 165805.2 165982.0 73880.0 85651.6 105285.0 113920.8 139873.0 98841.0 100965.5 104260.0 106005.0 106381.5 9349.9 9530.3 9558.6 9570.8 9701.3 57122.3 58093.0 58382.0 58603.0 59482.0 65278.0 65697.0 82244.0 90700.0 91840.5 12007.5 13450.1 14051.2 14090.3 14319.4 14847.5 15153.8 15553.2 15842.8 15910.9 13762.3 13866.6 13993.9 14122.9 14206.4 13365.9 13486.9 13591.0 13787.0 13931.7 13614.5 13872.5 14028.6 14360.9 14372.4 11170.1 11301.7 11448.8 11563.5 12389.1 8927.6 10401.7 10722.3 11503.4 11746.1 05:45:35 INFO - PROCESS | 1655 | -------- Summary: end -------- 05:45:35 INFO - PROCESS | 1655 | 05:45:35 INFO - TEST-INFO | 1655: exit 0 05:45:35 INFO - TEST-OK | dromaeo_css | took 1117550ms 05:45:35 INFO - TEST-START | kraken 05:45:35 INFO - operating with platform_type : mac_ 05:45:35 INFO - Initialising browser for kraken test... 05:45:35 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpmAXCAZ/profile http://localhost:49266/getInfo.html) 05:45:38 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:45:38 INFO - PROCESS | 1665 | colorDepth:24 05:45:38 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:45:38 INFO - PROCESS | 1665 | __metrics 05:45:38 INFO - PROCESS | 1665 | 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" 05:45:38 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:39 INFO - TEST-INFO | 1665: exit 0 05:45:39 INFO - Browser initialized. 05:45:39 INFO - Running cycle 1/1 for kraken test... 05:45:39 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpmAXCAZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:51 INFO - PROCESS | 1666 | RSS: Main: 244953088 05:45:51 INFO - PROCESS | 1666 | 05:45:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:54 INFO - PROCESS | 1666 | RSS: Main: 294907904 05:45:54 INFO - PROCESS | 1666 | 05:45:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:45:57 INFO - PROCESS | 1666 | RSS: Main: 305463296 05:45:57 INFO - PROCESS | 1666 | 05:46:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:46:02 INFO - PROCESS | 1666 | RSS: Main: 392155136 05:46:02 INFO - PROCESS | 1666 | 05:46:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:46:04 INFO - PROCESS | 1666 | RSS: Main: 292638720 05:46:04 INFO - PROCESS | 1666 | 05:46:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:07 INFO - PROCESS | 1666 | RSS: Main: 296742912 05:46:07 INFO - PROCESS | 1666 | 05:46:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:11 INFO - PROCESS | 1666 | RSS: Main: 334553088 05:46:11 INFO - PROCESS | 1666 | 05:46:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:14 INFO - PROCESS | 1666 | RSS: Main: 335306752 05:46:14 INFO - PROCESS | 1666 | 05:46:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:46:18 INFO - PROCESS | 1666 | RSS: Main: 334458880 05:46:18 INFO - PROCESS | 1666 | 05:46:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:20 INFO - PROCESS | 1666 | RSS: Main: 312188928 05:46:20 INFO - PROCESS | 1666 | 05:46:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:22 INFO - PROCESS | 1666 | RSS: Main: 318902272 05:46:22 INFO - PROCESS | 1666 | 05:46:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:25 INFO - PROCESS | 1666 | RSS: Main: 316272640 05:46:25 INFO - PROCESS | 1666 | 05:46:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:29 INFO - PROCESS | 1666 | RSS: Main: 325844992 05:46:29 INFO - PROCESS | 1666 | 05:46:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:32 INFO - PROCESS | 1666 | RSS: Main: 327737344 05:46:32 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:46:34 INFO - PROCESS | 1666 | RSS: Main: 371150848 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | __start_tp_report 05:46:34 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:46:34 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:46:34 INFO - PROCESS | 1666 | |i|pagename|runs| 05:46:34 INFO - PROCESS | 1666 | |0;ai-astar;102;113;113;112;113;111;112;113;112;111 05:46:34 INFO - PROCESS | 1666 | |1;audio-beat-detection;144;107;107;148;128;135;156;108;159;104 05:46:34 INFO - PROCESS | 1666 | |2;audio-dft;186;184;187;183;185;188;189;255;182;181 05:46:34 INFO - PROCESS | 1666 | |3;audio-fft;76;89;58;87;61;73;81;82;84;58 05:46:34 INFO - PROCESS | 1666 | |4;audio-oscillator;82;90;92;72;70;68;98;70;67;102 05:46:34 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;86;88;85;90;84;89;90;132;108 05:46:34 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;95;103;147;121;94;95;95;94;94 05:46:34 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;86;85;84;84;86;96;88;86;85 05:46:34 INFO - PROCESS | 1666 | |8;json-parse-financial;54;53;52;53;53;53;53;53;52;53 05:46:34 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;78;74;78;72;71;72;72;72;71 05:46:34 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;86;83;84;82;81;80;82;82;82;80 05:46:34 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;135;137;138;135;134;136;136;136;222;139 05:46:34 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;163;163;165;166;165;162;163;165;200;161 05:46:34 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;68;66;66;66;65;64;65;67;68;76 05:46:34 INFO - PROCESS | 1666 | __end_tp_report 05:46:34 INFO - PROCESS | 1666 | __start_cc_report 05:46:34 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2020 05:46:34 INFO - PROCESS | 1666 | __end_cc_report 05:46:34 INFO - PROCESS | 1666 | __startTimestamp1468932394594__endTimestamp 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:46:34 INFO - PROCESS | 1666 | Number of tests: 14 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.33 (3.0%) stddev-sans-first:0.83 05:46:34 INFO - PROCESS | 1666 | Values: 102.0 113.0 113.0 112.0 113.0 111.0 112.0 113.0 112.0 111.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:139.50 stddev:21.81 (15.6%) stddev-sans-first:22.51 05:46:34 INFO - PROCESS | 1666 | Values: 144.0 107.0 107.0 148.0 128.0 135.0 156.0 108.0 159.0 104.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:192.00 Median:186.50 stddev:22.29 (11.9%) stddev-sans-first:23.53 05:46:34 INFO - PROCESS | 1666 | Values: 186.0 184.0 187.0 183.0 185.0 188.0 189.0 255.0 182.0 181.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:74.90 Median:81.50 stddev:11.95 (14.7%) stddev-sans-first:12.67 05:46:34 INFO - PROCESS | 1666 | Values: 76.0 89.0 58.0 87.0 61.0 73.0 81.0 82.0 84.0 58.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:81.10 Median:77.00 stddev:13.42 (17.4%) stddev-sans-first:14.23 05:46:34 INFO - PROCESS | 1666 | Values: 82.0 90.0 92.0 72.0 70.0 68.0 98.0 70.0 67.0 102.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:88.50 stddev:14.92 (16.9%) stddev-sans-first:15.71 05:46:34 INFO - PROCESS | 1666 | Values: 89.0 86.0 88.0 85.0 90.0 84.0 89.0 90.0 132.0 108.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:94.50 stddev:17.51 (18.5%) stddev-sans-first:18.31 05:46:34 INFO - PROCESS | 1666 | Values: 95.0 95.0 103.0 147.0 121.0 94.0 95.0 95.0 94.0 94.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:86.00 stddev:3.50 (4.1%) stddev-sans-first:3.71 05:46:34 INFO - PROCESS | 1666 | Values: 86.0 86.0 85.0 84.0 84.0 86.0 96.0 88.0 86.0 85.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.44 05:46:34 INFO - PROCESS | 1666 | Values: 54.0 53.0 52.0 53.0 53.0 53.0 53.0 53.0 52.0 53.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:72.00 stddev:3.30 (4.6%) stddev-sans-first:2.78 05:46:34 INFO - PROCESS | 1666 | Values: 67.0 78.0 74.0 78.0 72.0 71.0 72.0 72.0 72.0 71.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.81 (2.2%) stddev-sans-first:1.30 05:46:34 INFO - PROCESS | 1666 | Values: 86.0 83.0 84.0 82.0 81.0 80.0 82.0 82.0 82.0 80.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:136.50 stddev:27.17 (19.9%) stddev-sans-first:28.58 05:46:34 INFO - PROCESS | 1666 | Values: 135.0 137.0 138.0 135.0 134.0 136.0 136.0 136.0 222.0 139.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:165.00 stddev:11.60 (7.0%) stddev-sans-first:12.19 05:46:34 INFO - PROCESS | 1666 | Values: 163.0 163.0 165.0 166.0 165.0 162.0 163.0 165.0 200.0 161.0 05:46:34 INFO - PROCESS | 1666 | 05:46:34 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.50 stddev:3.38 (5.1%) stddev-sans-first:3.57 05:46:34 INFO - PROCESS | 1666 | Values: 68.0 66.0 66.0 66.0 65.0 64.0 65.0 67.0 68.0 76.0 05:46:34 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:46:34 INFO - PROCESS | 1666 | 05:46:35 INFO - TEST-INFO | 1666: exit 0 05:46:35 INFO - TEST-OK | kraken | took 59573ms 05:46:35 INFO - SUITE-END | took 1177s 05:46:35 INFO - Completed test suite (00:19:37) 05:46:35 INFO - javascript benchmark 05:46:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2501.93745156371, 3297.8127873965377, 3349.0287816533205, 3370.1743072947133, 3418.641042690517, 5625.240592520008, 5634.887302253953, 5682.948654498916, 5724.141378793172, 5748.166515855193, 5729.197912292272, 5760.62555933864, 5761.1358296255585, 5762.3373312069125, 5766.682832444214, 5184.974075129629, 5235.581153507729, 5239.10935141025, 5273.499017593323, 5312.2828418163435, 5222.060029194743, 5258.55302299305, 5258.789648414078, 5270.0, 5276.472352764731, 5174.948250517485, 5200.271961925334, 5201.115810312237, 5202.453742357055, 5251.868703282429, 5247.737613119367, 5260.421353651133, 5276.050310944029, 5277.8416647500635, 5348.572114230852, 5074.746262686851, 5083.262926875583, 5158.097332966753, 5196.714180720059, 5203.713795741232, 5638.464345887134, 5696.658200507983, 5705.2012718219485, 5721.71391430431, 5757.222774925373, 6272.898578976048, 6303.684815759239, 6318.7472501100365, 6319.6524191169465, 6324.430801227865, 5610.76563156105, 5966.164736936832, 6233.968830155865, 6356.269029061625, 6360.363963603649, 5822.272215973004, 5826.941730582725, 5827.4172582741385, 5854.677992710442, 5894.086416605433, 6274.435300822856, 6288.748450061947, 6292.748290068346, 6301.275353334334, 6302.968485157545, 5971.223740913653, 6048.60684055535, 6064.545159113084, 6142.416470435302, 6159.23009623797, 6137.110119032715, 6179.2584889812615, 6202.255729312511, 6213.65824879627, 6215.0, 6122.387761223931, 6174.228221472316, 6179.81460556184, 6235.688215589203, 6241.970074937675, 6225.688715564294, 6229.595076320024, 6273.686315684289, 6282.434580887742, 6288.056791481223, 4811.182099043171, 4874.317595536628, 4904.485029071896, 4909.0, 4944.381952255968, 4380.518143004267, 4445.488768791631, 4472.172648060119, 4481.215787237221, 4489.9775501122285, 5684.37471878093, 5714.79998200061, 5750.281214848144, 5775.826725198251, 5806.216160818235, 6285.214348206474, 6321.1782468278825, 6323.620582765049, 6342.112104305401, 6358.109864618865, 5767.279090113736, 5768.798092066758, 5776.768929242783, 5784.537237021028, 5793.2179155814265, 5316.069687804618, 5368.0, 5369.087255166631, 5382.542483888835, 5384.40771515133, 6263.6241825490615, 6265.404786545271, 6278.497720182466, 6282.968585157045, 6285.120083188357, 6258.937410625836, 6309.3690630936535, 6348.428641422294, 6349.7142628580905, 6350.364963503613, 6310.49516038725, 6313.936860631335, 6313.936860631335, 6315.273743519554, 6322.36776322364, 6072.0, 6116.487945662287, 6257.624542527463, 6263.530235232467, 6267.0286105653695, 5116.9232461512365, 5956.910646340221, 6262.405071518198, 6287.591306565058, 6291.150694656163, 5143.768530416065, 6060.969695151496, 6072.14989901423, 6075.635461872302, 6123.510119190543, 6114.206128133634, 6122.733612273255, 6125.357545073132, 6137.144455097482, 6145.647957449354, 5176.818811341585, 5961.076033214858, 6016.217891674054, 6034.668093254913, 6060.1212824139375, 5985.521158307412, 6067.271927368567, 6100.0, 6116.797828496971, 6193.783217587363, 5961.91057134152, 5998.520118390431, 6017.217761690952, 6026.0659597762415, 6065.120557519047], "value": 5693.3987645251345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.2096571280229, 525.1964494323684, 535.6759160707774, 543.3506959183775, 554.9361823390311, 23886.88056559717, 40860.0, 41370.0, 41706.16587668253, 41717.582824171746, 43202.7839860801, 43412.0, 43568.12863742723, 43602.12795744083, 43638.0, 8701.0, 9644.22846172308, 9810.754731131743, 9817.852732208987, 9821.263405244636, 8087.757367278961, 11854.288742675424, 12019.459124339382, 12022.819657705099, 12238.877611223863, 11870.287782733021, 11951.880481195207, 11962.581309654164, 11963.521459141624, 11975.341356225405, 8829.646814127427, 8963.686270980485, 11887.286762794216, 11945.58190463334, 11994.22037567564, 8777.73666789991, 8854.557272136368, 11572.59495917639, 11771.0, 11821.881781182165, 41119.972000700225, 41493.37759933603, 41534.75395738133, 41536.37695434571, 41736.0, 3536.7877927324444, 3590.35373632746, 4006.338954072604, 4233.978830105861, 4254.680898932562, 31475.52786708201, 32027.359452811048, 32325.0, 32430.675693243, 32624.836875815705, 3266.591676040495, 3302.0424077017638, 3331.783434076777, 3352.2960178362327, 3413.1808365992233, 479896.0, 483963.0, 485141.0, 486099.0, 486153.0, 61940.69029654823, 62183.6890815543, 62624.68687656624, 62637.686811566564, 62661.43346416376, 64984.700305994564, 65062.0, 65082.67458662771, 65206.67396663081, 65431.67284163549, 16249.918750406408, 16861.325546978227, 16874.74687879683, 16877.240524176195, 16885.24016419264, 11716.414179291172, 11897.167198296209, 12712.42794074269, 12928.806067908989, 12988.090833641554, 17180.828191718174, 17215.22531486086, 17225.65548689019, 17230.310787568356, 17255.137243137793, 5663.292088488939, 6555.278919318871, 6561.2782593914635, 6635.170603674541, 6637.634930078795, 852.1660043102528, 883.960221790021, 929.6792606550729, 987.8518222266574, 1131.5191043806349, 26523.104531179826, 30647.387052259277, 31053.0, 31239.219019524695, 31505.36989260202, 1080.4705694209938, 1130.1298000539703, 1133.8525991621202, 1135.6649788312468, 1186.2526608236756, 15300.464483743015, 15991.36034558628, 16045.277962491717, 16059.0, 16495.422660206834, 692044.0, 696879.0, 702296.4885175541, 702811.0, 704268.0, 59802.0, 60092.0, 60118.0, 60122.098168527504, 60222.698886505284, 1272.1476610670873, 1314.1523717202542, 1395.4348488862026, 1419.8793102586396, 1442.7980082788417, 31116.066518004496, 31962.68037319597, 31969.520457193626, 32653.673463265062, 32778.67221327756, 51382.74308628433, 51818.48181518137, 51923.740381299365, 52012.0, 52035.0, 377775.0, 443168.0, 445924.0, 447896.0, 448136.0, 40167.799161004004, 40765.796171018956, 41656.750297491126, 41693.0, 41780.164396712506, 48327.03345933132, 48768.02463950772, 49243.01513969629, 49291.753541232065, 49823.0, 32670.50994235136, 39733.403998940616, 40255.396169058076, 41451.37822932598, 41543.58456415397, 34551.0, 39445.09128743821, 40558.39162412507, 40738.79630601828, 41329.58670413378, 38336.84989450321, 39232.607673922896, 39371.803140985256, 39454.61908833177, 39518.40722389109, 29043.419131617673, 32365.676343236268, 34151.829240853636, 35124.473132903535, 35232.29535409329, 21755.78244217601, 25624.87187564125, 25766.871165644803, 25994.35014124662, 26221.34446638849], "value": 20667.229155094527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.4111936834645, 335.9697627213552, 356.21987846615923, 381.4012001158182, 406.461438593863, 15716.764248536281, 17883.463496095123, 20486.888391429497, 21156.0, 21198.89400552995, 18148.81851181488, 20627.27804526842, 21383.893080534614, 21750.89124554379, 21767.0, 5475.397706252309, 5976.19321391612, 6217.378262173769, 6251.281102673182, 6257.749690012394, 4281.892952676177, 4514.6388288936805, 6030.125631783389, 6588.8023359299295, 6916.377526022657, 6550.508711846631, 6850.794476165723, 6870.896936545956, 6890.966355046733, 6898.172219333687, 6741.359570840787, 6766.627835469048, 6769.661516924159, 6780.0, 6795.728170873159, 5667.866426714673, 5880.617759845639, 5901.822945311647, 5943.257092863392, 5949.791757288517, 26423.47153056928, 27078.32304192391, 27149.45701085967, 27331.86334068337, 27376.0, 2475.207933461275, 2488.5645012122986, 2517.6852893388327, 2568.165346262472, 2583.7932965362725, 13420.396082176325, 15493.922530387388, 16032.038077715375, 16463.176841158012, 16481.835181648148, 1830.3685228596246, 1849.4544109487733, 1906.1231833356674, 1921.5292253397868, 1926.5376309685714, 61462.69268653673, 79418.60290698567, 80088.19911800866, 127716.0, 129001.35499322537, 8326.04250511199, 9213.447193168431, 9690.273229507815, 10919.781604367869, 11097.667069987914, 11444.656660300205, 13663.453461861613, 13778.242196679079, 13808.17150970945, 13836.23900685472, 8652.567371631394, 8686.869696954423, 8734.388592798443, 8736.737897863075, 8781.34139939507, 8890.244329232088, 8913.420627659181, 8914.28685705142, 9072.319576031825, 9102.90897091034, 6555.541112122106, 6690.933090669128, 6692.799216023527, 6692.933070669328, 6750.864982700318, 1693.5088824240831, 1796.1558067708418, 1800.5498625343664, 1822.6354729054242, 1825.6855064353645, 770.5761830992932, 937.554661535765, 967.2890425537224, 1043.4834756795283, 1068.471106802138, 20014.399568012985, 22444.989975451143, 22629.0, 22630.886845565667, 23016.194433195094, 963.4171326347599, 975.4537459022828, 987.9506024698736, 1028.1671845804922, 1055.9736006599742, 9172.908270917338, 11913.940430297793, 11959.820602690967, 12188.146829721834, 12301.446434910451, 595117.0, 612559.0, 621319.0, 628377.0, 629246.0, 95075.0, 122764.0, 127902.0, 129427.0, 129824.70175298315, 910.3672947301562, 916.4272329793879, 1034.3690348887174, 1100.6147848253047, 1104.5526561742506, 16670.916645416695, 20385.388438346872, 20496.69254961147, 21149.0, 21309.0, 41560.753177404724, 46661.766691166325, 52354.0, 53495.0, 53895.19157212723, 75214.24785752072, 76453.0, 76571.0, 77310.0, 77474.6126269365, 5887.20522729426, 7231.8553628928175, 7255.746048888263, 8353.289970352587, 8470.915290847013, 8885.511296878734, 12366.505339786308, 13113.672158196121, 13951.372188251757, 14028.649283767987, 11687.240329378903, 11867.228630139014, 11868.347240901488, 11941.52233910634, 12020.519179233082, 11466.025387842126, 11742.412879355827, 11768.646940591796, 12008.75982480363, 12015.219010764622, 11565.826512602149, 11784.76430471403, 12022.458989345325, 12038.337891416057, 12096.213746106476, 8183.304419124441, 8201.548914809504, 8247.463914845515, 8301.128381519853, 8470.83058338842, 11721.003714684348, 11824.645260642195, 11947.76104477923, 11968.521259149536, 11972.461239244081], "value": 9892.40058014255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.1081128351198, 1591.5543647778622, 1780.7685000949875, 1901.8478521718264, 1916.6262578797132, 8524.829503409936, 8776.341774366916, 8981.95509022454, 9009.774755631113, 9043.593038313275, 7787.844243115134, 8035.437519373646, 8451.53516556589, 8744.519051452167, 8795.208431241186, 2322.152414368756, 2356.45801465663, 2357.691481227918, 2359.834811563191, 2361.161787565407, 2335.7313908900437, 2338.38032921276, 2367.5264947010583, 2369.6208606622945, 2374.76252374762, 2081.9687704684443, 2153.720016397874, 2154.8922553872244, 2158.352494251726, 2340.028888011473, 2276.3171048685413, 2360.2565191964477, 2361.51588924271, 2364.4916342986166, 2372.0, 2312.340982819905, 2328.941776455602, 2334.8132149428175, 2336.4275752440763, 2343.0042232051483, 8869.201771840566, 8923.330750193696, 8927.508987005713, 8928.464292142493, 8933.46399216049, 5157.767900444489, 5271.499207575274, 5331.920021199685, 5334.546563542103, 5341.759620817073, 3433.7081348085194, 3542.36237477254, 3576.3920133577353, 3596.478510615972, 3617.2584620152807, 1061.644349143038, 1084.3331351219022, 1084.3656460970342, 1089.0742868561738, 1104.3318792130726, 11550.422478876106, 11566.826497602542, 11581.305121692641, 11589.710257243552, 11631.30212187263, 3840.577536470986, 4548.408706868086, 4574.8562859285175, 4667.8599642010795, 4684.2271025281125, 9849.655262065793, 9874.60501579943, 9890.0, 9897.65358212459, 9901.60393584263, 5286.894262114736, 5290.9735451322495, 5291.1798671206025, 5292.285541451854, 5311.920321195185, 3907.4529565860803, 4157.355609880473, 4210.473690788652, 4691.413573303337, 4845.685030473008, 3836.271108489378, 3884.6115388460926, 3958.287508248485, 3988.960110398859, 4018.8995275117773, 1251.4493622805937, 1266.5883587833991, 1271.262667652759, 1285.203174032106, 1289.6389011076913, 822.5393779483509, 877.1842186766369, 904.8099899021148, 929.2983797233181, 945.9905400946041, 5660.0, 5878.588498805043, 5882.941170588325, 5980.162777211194, 6115.480184184395, 427.5831064711881, 433.425710933015, 434.4938147058704, 439.1480527776104, 451.31174958189024, 3671.0, 3974.4435778990965, 4002.699797515198, 4059.79701014954, 4095.2219078375015, 10318.690439286833, 10759.892401076046, 10836.458177091114, 10869.45652717361, 10888.40113793749, 10804.1896857736, 10816.513256903458, 10818.29681070728, 10828.24202305831, 10829.945850270857, 7561.697532098655, 7885.960570197112, 8199.631016604268, 8258.628361723737, 8264.917350826536, 6005.484049806009, 6035.818925432244, 6057.273127224585, 6081.756729730938, 6136.588584625651, 10168.0, 10233.897661023295, 10316.43259620698, 10320.896791032294, 10349.0, 9931.354461959949, 10031.749206269902, 10285.125764310118, 10435.426051567236, 10482.266241363031, 7035.6833942471685, 7241.348278654947, 7420.480566360303, 7542.094948606203, 8003.719869804529, 8284.088750237348, 8356.665733370597, 8418.663253470038, 8431.747047588582, 8441.15588441151, 7347.595882226529, 7446.218147094477, 7490.737824176128, 7543.169637107673, 7559.924400755922, 7260.49176557657, 7275.708971641075, 7354.080739907512, 7420.295071968154, 7533.1336896257635, 6995.0906382172025, 7033.050538177281, 7078.823029424306, 7083.610401427971, 7087.433005359662, 4871.318015477907, 5068.442471328225, 5091.210862316347, 5109.054824857413, 5119.960302691974, 5037.0, 5048.0, 5110.514501122388, 5116.3860336758335, 5257.553107985864], "value": 4495.366124577778, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.96952365716106, 308.7607104494017, 315.96840315968404, 319.6914977047152, 321.79887570268585, 5325.751291712062, 5370.194470829378, 5383.407825139237, 5389.1646794746775, 5403.864903377417, 4312.956870431295, 5062.544371006608, 5174.689518628885, 5294.761735721892, 5301.542075929121, 3679.6872265857432, 4007.777627823513, 4084.5711200323985, 4130.566290539495, 4141.275276826558, 3457.3258214648154, 3959.564447910742, 4125.2986992211245, 4137.420761093449, 4146.460960075186, 2977.895773647923, 3845.154325923558, 4050.736702114353, 4124.97937510312, 4188.874333769992, 3415.7779744316663, 4057.513098428178, 4082.8775136745944, 4086.5504794472586, 4103.999999999985, 3281.770276080675, 3553.4314509678584, 3554.147004718849, 3561.4301711726, 3563.7861728296384, 4272.9104078459795, 4871.621487241689, 5082.745862706887, 5120.667156634807, 5162.432132465426, 4656.580907718288, 4672.462666793294, 4683.859484215479, 4697.295405689139, 4726.314684370747, 4484.484284307314, 5598.272224610774, 5612.831615051555, 5634.408387119334, 5639.746211420496, 3746.5316835395574, 3973.264945984973, 3981.5819338969573, 3987.7806720630356, 4008.8574756194635, 5915.08316210988, 5924.703764811742, 5929.377415371367, 5934.703264836741, 5951.761929522814, 4052.858149964796, 4071.755694658271, 4076.3274059779806, 4078.225137223977, 4078.6940979426663, 3988.6210809973004, 4108.91782164355, 4114.218298523271, 4125.257453658371, 4136.234796562646, 3950.9012274693364, 4714.198586240347, 4719.433667959798, 4729.989754354386, 4737.644676649265, 4427.003924117048, 5632.549396048306, 5667.1782591524825, 5734.655920644775, 5747.798827041033, 1058.433737950193, 1163.6392718257368, 1385.889128869688, 1404.5505438259659, 1405.8523854995078, 797.3421926910322, 856.8072183758604, 908.9681861134828, 916.1342531307984, 965.165132160676, 5209.140491818807, 5222.686638801684, 5261.894762104736, 5286.60350473716, 5289.656172348785, 5727.8568035799435, 5745.88508229833, 5776.797812076557, 5786.826395208151, 5827.533797296206, 5032.515407954662, 5063.3417655704525, 5117.539795968642, 5250.816221432232, 5274.340707411574, 2999.6850330715397, 3013.472642287591, 3027.576139340494, 3031.2570272093194, 3039.6200474940633, 5206.943257413301, 5941.910871336933, 5960.92703313399, 5963.880722385528, 5964.940350596526, 5162.3030890830005, 5867.061270196748, 5869.266341707286, 5887.558433117533, 5932.822015339547, 5155.639105262596, 5677.602567820213, 5738.82354117405, 5860.124760076735, 5919.733611987384, 5115.74421278942, 5508.889822203453, 5709.9714501427225, 5719.428057194247, 5731.8567035824435, 4863.610911127031, 5490.7762356245785, 5600.299962504687, 5645.548356131581, 5667.291588551431, 5098.719570423514, 5216.530512253916, 5245.842624721265, 5847.210626565359, 5906.881862362815, 3597.640235976486, 3803.1633040730994, 3974.7615143091507, 4003.57962413954, 4036.91926161481, 4783.306420568929, 4808.3989501312335, 5448.891022179455, 5643.943560564342, 5694.857628559319, 4663.580277775017, 5442.945570544244, 5537.363203231519, 5544.500994910478, 5546.140348246028, 5104.897902042013, 5518.2826232591115, 5621.9156712650165, 5636.702529020569, 5638.746256418389, 5502.532284755841, 5502.862428439321, 5517.310336207974, 5530.787684925901, 5551.0, 5336.519713225828, 5362.71294889216, 5628.521575665951, 5632.662040277596, 5650.463205995424, 5041.571466425248, 5462.8907421850545, 5499.377683583272, 5525.254090697705, 5537.861553461034], "value": 4122.766614010013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.6825153297585, 744.2817680937894, 754.0762565856822, 776.2625505769519, 817.6524976884823, 14045.789313160298, 15198.088114713111, 15205.16371599563, 15210.23948802561, 15223.619409514768, 11551.768964620702, 13465.394057267422, 13888.23614701191, 13920.791188132187, 14273.50042748504, 876.5266755951778, 888.6134531478828, 890.2432932007774, 892.1257167975388, 893.7631527645146, 860.5482121885997, 870.6169285514353, 871.6905498548019, 872.4852337121097, 872.9258013068896, 916.9037251088606, 918.0727465260102, 918.2011649864627, 918.8254231695956, 919.8068405634825, 914.6387177065088, 914.6935776514875, 915.3135148638521, 915.3501014279869, 917.687986084731, 678.9966050169718, 679.3715812873122, 679.7654809090856, 679.8402375441767, 681.2914568848391, 12906.612801615967, 12922.28927408992, 12931.224126552437, 12931.741365172738, 12932.612021639367, 12165.20926139798, 12183.93908030463, 12222.938885305606, 12255.816162757477, 12735.617931462071, 8675.783105422352, 11276.0, 11509.94245028778, 12045.63863084109, 12283.93858030713, 4645.976770116162, 4664.790084446174, 4668.95331046692, 4688.320193571947, 4713.835015774465, 108475.0, 113674.35907691048, 114337.4283128579, 114384.85615143825, 114620.42689786498, 10876.184286178568, 11055.502502387411, 11066.778664426667, 11149.498272577754, 11546.76906461866, 21200.575988480145, 21205.893970530047, 21206.893965530075, 21223.68164477534, 21232.681509777365, 7115.89326160108, 7947.642356093874, 7969.203079691984, 8003.559804210708, 8034.196580341919, 4000.859969901098, 4429.136318417942, 4484.304932735431, 4503.347014682852, 4673.971726220226, 3395.575553055868, 3407.16524451511, 3492.5634295713035, 3494.790312581253, 3497.213127046445, 651.8500744828716, 656.9113169722026, 660.7191943424122, 667.89981502774, 723.3959643697572, 613.2610204703321, 670.0167504187558, 687.7764726463919, 697.8778713725078, 706.0997228533661, 9649.179819715262, 9838.65564705232, 9881.703548893545, 9924.801503970024, 9926.652567160114, 585.2742599176989, 591.4262967120426, 642.5341627320249, 676.8172593399754, 691.381213813634, 4568.729408962802, 4601.148787474328, 4729.385179926657, 4751.168545504523, 4896.902061958812, 93551.0, 136609.63390366168, 145174.0, 165805.17097414436, 165982.0, 73880.0, 85651.57174214089, 105285.0, 113920.75990501187, 139873.0, 98841.0, 100965.48551771729, 104259.95740042655, 106005.0, 106381.46809265904, 9349.85975210386, 9530.332876698565, 9558.617655293989, 9570.808583828424, 9701.272404569545, 57122.28705134153, 58093.0, 58382.0, 58603.0, 59482.0, 65278.0, 65697.0, 82244.0, 90700.0, 91840.54079729559, 12007.519699211934, 13450.120099275347, 14051.156930584199, 14090.295485225903, 14319.427222910967, 14847.480338188112, 15153.772693409828, 15553.222338883237, 15842.841571584599, 15910.920445397698, 13762.311884405939, 13866.584002479942, 13993.930030349784, 14122.929385353007, 14206.360713767699, 13365.933170334474, 13486.86513134856, 13591.0, 13787.034907556375, 13931.721365572834, 13614.523491677744, 13872.514461993782, 14028.579142625738, 14360.856391435951, 14372.36313098716, 11170.08010694223, 11301.660950171508, 11448.803201380495, 11563.537458501902, 12389.132760706663, 8927.598258078273, 10401.739956500845, 10722.296772021065, 11503.411732360151, 11746.119041071783], "value": 7762.780281973504, "unit": "score"}], "name": "dromaeo_css", "value": 7424.418801206959, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 112.0, 113.0, 111.0, 112.0, 113.0, 112.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 107.0, 107.0, 148.0, 128.0, 135.0, 156.0, 108.0, 159.0, 104.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 187.0, 183.0, 185.0, 188.0, 189.0, 255.0, 182.0, 181.0], "value": 192.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 89.0, 58.0, 87.0, 61.0, 73.0, 81.0, 82.0, 84.0, 58.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 90.0, 92.0, 72.0, 70.0, 68.0, 98.0, 70.0, 67.0, 102.0], "value": 81.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 90.0, 84.0, 89.0, 90.0, 132.0, 108.0], "value": 94.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 103.0, 147.0, 121.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 84.0, 84.0, 86.0, 96.0, 88.0, 86.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 74.0, 78.0, 72.0, 71.0, 72.0, 72.0, 72.0, 71.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 82.0, 81.0, 80.0, 82.0, 82.0, 82.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 138.0, 135.0, 134.0, 136.0, 136.0, 136.0, 222.0, 139.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 166.0, 165.0, 162.0, 163.0, 165.0, 200.0, 161.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 65.0, 64.0, 65.0, 67.0, 68.0, 76.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1459.8, "alertThreshold": 2.0}]} 05:46:35 INFO - Return code: 0 05:46:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:46:35 INFO - # TBPL SUCCESS # 05:46:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:35 INFO - 2016-07-19 05:46:35.900 screenresolution[1670:9521] starting screenresolution argv=screenresolution get 05:46:35 INFO - 2016-07-19 05:46:35.902 screenresolution[1670:9521] Display 0: 1600x1200x32@60 05:46:35 INFO - 2016-07-19 05:46:35.909 screenresolution[1671:9524] starting screenresolution argv=screenresolution list 05:46:35 INFO - Available Modes on Display 0 05:46:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:36 INFO - Intel Iris: 05:46:36 INFO - Chipset Model: Intel Iris 05:46:36 INFO - Type: GPU 05:46:36 INFO - Bus: Built-In 05:46:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:36 INFO - Vendor: Intel (0x8086) 05:46:36 INFO - Device ID: 0x0a2e 05:46:36 INFO - Revision ID: 0x0009 05:46:36 INFO - Displays: 05:46:36 INFO - Display: 05:46:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:36 INFO - Display Serial Number: 1600x1200 60 05:46:36 INFO - Main Display: Yes 05:46:36 INFO - Mirror: Off 05:46:36 INFO - Online: Yes 05:46:36 INFO - Rotation: Supported 05:46:36 INFO - Return code: 0 05:46:36 INFO - Running post-action listener: _resource_record_post_action 05:46:36 INFO - ##### 05:46:36 INFO - ##### Finished run-tests step (success) 05:46:36 INFO - ##### 05:46:36 INFO - Running post-run listener: _resource_record_post_run 05:46:36 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 37045760; Write bytes: 705210368; Read time: 239; Write time: 1963 05:46:36 INFO - TinderboxPrint: CPU usage
53.5% 05:46:36 INFO - TinderboxPrint: I/O read bytes / time
37,045,760 / 239 05:46:36 INFO - TinderboxPrint: I/O write bytes / time
705,210,368 / 1,963 05:46:36 INFO - TinderboxPrint: CPU idle
2,254.9 (46.5%) 05:46:36 INFO - TinderboxPrint: CPU system
973.0 (20.0%) 05:46:36 INFO - TinderboxPrint: CPU user
1,625.7 (33.5%) 05:46:36 INFO - TinderboxPrint: Swap in / out
458,776,576 / 0 05:46:36 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 401498624; Write bytes: 395732992; Read time: 30619; Write time: 829 05:46:36 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34932224; Write bytes: 293679104; Read time: 218; Write time: 1093 05:46:36 INFO - Running post-run listener: _upload_blobber_files 05:46:36 INFO - Blob upload gear active. 05:46:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:36 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 05:46:36 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'] 05:46:36 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 05:46:37 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:46:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:38 INFO - (blobuploader) - INFO - Done attempting. 05:46:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:46:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:39 INFO - (blobuploader) - INFO - Done attempting. 05:46:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:46:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:41 INFO - (blobuploader) - INFO - Done attempting. 05:46:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:41 INFO - Return code: 0 05:46:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06272eb2c240bf940a79388bf3f97a38dc7cf8ef7a275489d3e178e35ba15b69e9b66b8c490b8a8efe52c77f23f4c62f966d5d020d9c33f50dcb4bbd0bef3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/851af88178e6bcd630d881acbe67e5eed0077118f28a2cc7507f11a9815091bcea1706d970b18e6e4db332a23518364d767e20cc8a2dfbacc4539cdfa980346f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1dd102120e60a849815a785422da17162b2617405d1f1987d1890e149b35fc0cd741323804bb3ff1203d208f8034ae80c8dfb648f7f51c400e395fabb9e589a"} 05:46:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:41 INFO - Contents: 05:46:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06272eb2c240bf940a79388bf3f97a38dc7cf8ef7a275489d3e178e35ba15b69e9b66b8c490b8a8efe52c77f23f4c62f966d5d020d9c33f50dcb4bbd0bef3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/851af88178e6bcd630d881acbe67e5eed0077118f28a2cc7507f11a9815091bcea1706d970b18e6e4db332a23518364d767e20cc8a2dfbacc4539cdfa980346f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1dd102120e60a849815a785422da17162b2617405d1f1987d1890e149b35fc0cd741323804bb3ff1203d208f8034ae80c8dfb648f7f51c400e395fabb9e589a"} 05:46:41 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:41 INFO - Copying logs to upload dir... 05:46:41 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.696430 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-19 05:46:41.879779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:41.883322) ========= 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.TtUVD1zbEX/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.F82u2TpY23/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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/d06272eb2c240bf940a79388bf3f97a38dc7cf8ef7a275489d3e178e35ba15b69e9b66b8c490b8a8efe52c77f23f4c62f966d5d020d9c33f50dcb4bbd0bef3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/851af88178e6bcd630d881acbe67e5eed0077118f28a2cc7507f11a9815091bcea1706d970b18e6e4db332a23518364d767e20cc8a2dfbacc4539cdfa980346f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1dd102120e60a849815a785422da17162b2617405d1f1987d1890e149b35fc0cd741323804bb3ff1203d208f8034ae80c8dfb648f7f51c400e395fabb9e589a"} build_url:https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010956 build_url: 'https://queue.taskcluster.net/v1/task/KvUffNGHSk2A0thiTsOz9w/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/d06272eb2c240bf940a79388bf3f97a38dc7cf8ef7a275489d3e178e35ba15b69e9b66b8c490b8a8efe52c77f23f4c62f966d5d020d9c33f50dcb4bbd0bef3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/851af88178e6bcd630d881acbe67e5eed0077118f28a2cc7507f11a9815091bcea1706d970b18e6e4db332a23518364d767e20cc8a2dfbacc4539cdfa980346f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1dd102120e60a849815a785422da17162b2617405d1f1987d1890e149b35fc0cd741323804bb3ff1203d208f8034ae80c8dfb648f7f51c400e395fabb9e589a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:41.915989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:41.916310) ========= 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.TtUVD1zbEX/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.F82u2TpY23/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.004908 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:42.090361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 05:46:42.090674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 05:46:42.091030) ========= ========= Total master_lag: 0.29 =========