builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0133 starttime: 1469049065.14 results: success (0) buildid: 20160720123119 builduid: 3b318d53dfbe4ead828bc2dbbb887347 revision: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.135841) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.136372) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.136934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.161971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.162403) ========= 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.zCtrALtKLL/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.6HGMr6sbp2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-20 14:11:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.41M=0.001s 2016-07-20 14:11:05 (9.41 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.268086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.268442) ========= 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.zCtrALtKLL/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.6HGMr6sbp2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.032965 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:05.322921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-20 14:11:05.323353) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b125c700ca86f4aecf1d5c5ee86d94f783abffa3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b125c700ca86f4aecf1d5c5ee86d94f783abffa3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zCtrALtKLL/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.6HGMr6sbp2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-20 14:11:05,396 truncating revision to first 12 chars 2016-07-20 14:11:05,397 Setting DEBUG logging. 2016-07-20 14:11:05,397 attempt 1/10 2016-07-20 14:11:05,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b125c700ca86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 14:11:07,702 unpacking tar archive at: autoland-b125c700ca86/testing/mozharness/ program finished with exit code 0 elapsedTime=2.556330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-20 14:11:07.901783) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:07.902147) ========= script_repo_revision: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:07.902540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:07.902857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 14:11:07.921198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-20 14:11:07.921488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zCtrALtKLL/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.6HGMr6sbp2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:08 INFO - MultiFileLogger online at 20160720 14:11:08 in /builds/slave/test 14:11:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:11:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:08 INFO - {'append_to_log': False, 14:11:08 INFO - 'base_work_dir': '/builds/slave/test', 14:11:08 INFO - 'blob_upload_branch': 'Autoland', 14:11:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:08 INFO - 'branch': 'Autoland', 14:11:08 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:08 INFO - 'config_files': ('talos/mac_config.py',), 14:11:08 INFO - 'default_actions': ('clobber', 14:11:08 INFO - 'read-buildbot-config', 14:11:08 INFO - 'download-and-extract', 14:11:08 INFO - 'populate-webroot', 14:11:08 INFO - 'create-virtualenv', 14:11:08 INFO - 'install', 14:11:08 INFO - 'run-tests'), 14:11:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:08 INFO - 'download_minidump_stackwalk': True, 14:11:08 INFO - 'download_symbols': 'ondemand', 14:11:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:08 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:08 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:08 INFO - 'installer_path': 'installer.exe', 14:11:08 INFO - 'log_level': 'info', 14:11:08 INFO - 'log_name': 'talos', 14:11:08 INFO - 'log_to_console': True, 14:11:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:11:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:11:08 INFO - 'opt_config_files': (), 14:11:08 INFO - 'pip_index': False, 14:11:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:11:08 INFO - 'cmd': ('bash', 14:11:08 INFO - '-c', 14:11:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:11:08 INFO - 'enabled': True, 14:11:08 INFO - 'halt_on_failure': False, 14:11:08 INFO - 'name': 'check_screen_resolution'},), 14:11:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:11:08 INFO - 'cmd': ('bash', 14:11:08 INFO - '-c', 14:11:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:11:08 INFO - 'enabled': True, 14:11:08 INFO - 'halt_on_failure': False, 14:11:08 INFO - 'name': 'check_screen_resolution'},), 14:11:08 INFO - 'run_cmd_checks_enabled': True, 14:11:08 INFO - 'sps_profile': False, 14:11:08 INFO - 'sps_profile_interval': 0, 14:11:08 INFO - 'suite': 'dromaeojs', 14:11:08 INFO - 'system_bits': '32', 14:11:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:08 INFO - 'title': 't-yosemite-r7-0133', 14:11:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:08 INFO - 'use_talos_json': True, 14:11:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:08 INFO - 'work_dir': 'build'} 14:11:08 INFO - [mozharness: 2016-07-20 21:11:08.112194Z] Running clobber step. 14:11:08 INFO - Running pre-action listener: _resource_record_pre_action 14:11:08 INFO - Running main action method: clobber 14:11:08 INFO - rmtree: /builds/slave/test/build 14:11:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:10 INFO - Running post-action listener: _resource_record_post_action 14:11:10 INFO - [mozharness: 2016-07-20 21:11:10.289992Z] Finished clobber step (success) 14:11:10 INFO - [mozharness: 2016-07-20 21:11:10.290156Z] Running read-buildbot-config step. 14:11:10 INFO - Running pre-action listener: _resource_record_pre_action 14:11:10 INFO - Running main action method: read_buildbot_config 14:11:10 INFO - Using buildbot properties: 14:11:10 INFO - { 14:11:10 INFO - "project": "", 14:11:10 INFO - "product": "firefox", 14:11:10 INFO - "script_repo_revision": "production", 14:11:10 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:11:10 INFO - "repository": "", 14:11:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:11:10 INFO - "buildid": "20160720123119", 14:11:10 INFO - "pgo_build": "False", 14:11:10 INFO - "basedir": "/builds/slave/test", 14:11:10 INFO - "buildnumber": 64, 14:11:10 INFO - "slavename": "t-yosemite-r7-0133", 14:11:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:11:10 INFO - "platform": "yosemite_r7", 14:11:10 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:11:10 INFO - "branch": "autoland", 14:11:10 INFO - "repo_path": "integration/autoland", 14:11:10 INFO - "revision": "b125c700ca86f4aecf1d5c5ee86d94f783abffa3", 14:11:10 INFO - "stage_platform": "macosx64", 14:11:10 INFO - "builduid": "3b318d53dfbe4ead828bc2dbbb887347", 14:11:10 INFO - "slavebuilddir": "test" 14:11:10 INFO - } 14:11:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 14:11:10 INFO - Running post-action listener: _resource_record_post_action 14:11:10 INFO - [mozharness: 2016-07-20 21:11:10.293366Z] Finished read-buildbot-config step (success) 14:11:10 INFO - [mozharness: 2016-07-20 21:11:10.293499Z] Running download-and-extract step. 14:11:10 INFO - Running pre-action listener: _resource_record_pre_action 14:11:10 INFO - Running main action method: download_and_extract 14:11:10 INFO - mkdir: /builds/slave/test/build/tests 14:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:10 INFO - https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:11 INFO - Downloaded 1199 bytes. 14:11:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:11:11 INFO - Using the following test package requirements: 14:11:11 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:11:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 14:11:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 14:11:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'jsshell-mac.zip'], 14:11:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 14:11:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:11:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 14:11:11 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 14:11:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 14:11:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:11 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 14:11:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:11:11 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')]} 14:11:11 INFO - https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:11:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:16 INFO - Downloaded 18800838 bytes. 14:11:16 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'] 14:11:16 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 14:11:19 INFO - Return code: 0 14:11:19 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 14:11:19 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')]} 14:11:19 INFO - https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:24 INFO - Downloaded 18800838 bytes. 14:11:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:11:28 INFO - Return code: 0 14:11:28 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')]} 14:11:28 INFO - https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:29 INFO - Downloaded 14403317 bytes. 14:11:29 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'] 14:11:29 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 14:11:29 INFO - Return code: 0 14:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:29 INFO - https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 14:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/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 14:11:32 INFO - Downloaded 112862505 bytes. 14:11:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:32 INFO - mkdir: /builds/slave/test/properties 14:11:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:32 INFO - Contents: 14:11:32 INFO - build_url:https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:33 INFO - Running post-action listener: _resource_record_post_action 14:11:33 INFO - Running post-action listener: set_extra_try_arguments 14:11:33 INFO - [mozharness: 2016-07-20 21:11:33.603640Z] Finished download-and-extract step (success) 14:11:33 INFO - [mozharness: 2016-07-20 21:11:33.603828Z] Running populate-webroot step. 14:11:33 INFO - Running pre-action listener: _resource_record_pre_action 14:11:33 INFO - Running main action method: populate_webroot 14:11:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:33 INFO - '--tppagecycles', 14:11:33 INFO - '7'], 14:11:33 INFO - 'tests': ['tsvgm']}}, 14:11:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['damp', 'tps']}, 14:11:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'tests': ['damp', 'tps']}, 14:11:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['dromaeo_dom']}, 14:11:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['basic_compositor_video']}, 14:11:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['a11yr', 14:11:33 INFO - 'ts_paint', 14:11:33 INFO - 'tpaint', 14:11:33 INFO - 'sessionrestore', 14:11:33 INFO - 'sessionrestore_no_auto_restore', 14:11:33 INFO - 'tabpaint']}, 14:11:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:33 INFO - 'ts_paint', 14:11:33 INFO - 'tpaint', 14:11:33 INFO - 'sessionrestore', 14:11:33 INFO - 'sessionrestore_no_auto_restore', 14:11:33 INFO - 'tabpaint']}, 14:11:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:33 INFO - 'ts_paint', 14:11:33 INFO - 'tpaint', 14:11:33 INFO - 'sessionrestore', 14:11:33 INFO - 'sessionrestore_no_auto_restore', 14:11:33 INFO - 'tabpaint']}, 14:11:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:33 INFO - 'ts_paint', 14:11:33 INFO - 'tpaint', 14:11:33 INFO - 'sessionrestore', 14:11:33 INFO - 'sessionrestore_no_auto_restore', 14:11:33 INFO - 'tabpaint']}, 14:11:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['a11yr', 14:11:33 INFO - 'ts_paint', 14:11:33 INFO - 'tpaint', 14:11:33 INFO - 'sessionrestore', 14:11:33 INFO - 'sessionrestore_no_auto_restore', 14:11:33 INFO - 'tabpaint']}, 14:11:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['a11yr', 14:11:33 INFO - 'ts_paint', 14:11:33 INFO - 'tpaint', 14:11:33 INFO - 'sessionrestore', 14:11:33 INFO - 'sessionrestore_no_auto_restore', 14:11:33 INFO - 'tabpaint']}, 14:11:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['tsvgx', 14:11:33 INFO - 'tsvgr_opacity', 14:11:33 INFO - 'tart', 14:11:33 INFO - 'tscrollx', 14:11:33 INFO - 'cart']}, 14:11:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:33 INFO - 'tsvgr_opacity', 14:11:33 INFO - 'tart', 14:11:33 INFO - 'tscrollx', 14:11:33 INFO - 'cart']}, 14:11:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'talos_options': ['--disable-e10s'], 14:11:33 INFO - 'tests': ['tp5o']}, 14:11:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'tests': ['tp5o']}, 14:11:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'talos_options': ['--disable-e10s', 14:11:33 INFO - '--xperf_path', 14:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:33 INFO - 'tests': ['tp5n']}, 14:11:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:33 INFO - 'talos_options': ['--xperf_path', 14:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:33 INFO - 'tests': ['tp5n']}}, 14:11:33 INFO - 'talos.zip': {'path': '', 14:11:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:33 INFO - Running post-action listener: _resource_record_post_action 14:11:33 INFO - [mozharness: 2016-07-20 21:11:33.622554Z] Finished populate-webroot step (success) 14:11:33 INFO - [mozharness: 2016-07-20 21:11:33.622669Z] Running create-virtualenv step. 14:11:33 INFO - Running pre-action listener: _resource_record_pre_action 14:11:33 INFO - Running main action method: create_virtualenv 14:11:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:33 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 14:11:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:33 INFO - Using real prefix '/tools/python27' 14:11:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:37 INFO - Installing pip.................done. 14:11:37 INFO - Return code: 0 14:11:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:37 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 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:37 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 14:11:37 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 14:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:37 INFO - 'HOME': '/Users/cltbld', 14:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:37 INFO - 'LOGNAME': 'cltbld', 14:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:37 INFO - 'MOZ_NO_REMOTE': '1', 14:11:37 INFO - 'NO_EM_RESTART': '1', 14:11:37 INFO - 'PAGER': '/bin/cat', 14:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:37 INFO - 'PWD': '/builds/slave/test', 14:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:37 INFO - 'SHELL': '/bin/bash', 14:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:11:37 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:37 INFO - 'USER': 'cltbld', 14:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:37 INFO - 'XPC_FLAGS': '0x0', 14:11:37 INFO - 'XPC_SERVICE_NAME': '0', 14:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:37 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 14:11:37 INFO - Cleaning up... 14:11:37 INFO - Return code: 0 14:11:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:37 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 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:37 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 14:11:37 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 14:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:37 INFO - 'HOME': '/Users/cltbld', 14:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:37 INFO - 'LOGNAME': 'cltbld', 14:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:37 INFO - 'MOZ_NO_REMOTE': '1', 14:11:37 INFO - 'NO_EM_RESTART': '1', 14:11:37 INFO - 'PAGER': '/bin/cat', 14:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:37 INFO - 'PWD': '/builds/slave/test', 14:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:37 INFO - 'SHELL': '/bin/bash', 14:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:11:37 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:37 INFO - 'USER': 'cltbld', 14:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:37 INFO - 'XPC_FLAGS': '0x0', 14:11:37 INFO - 'XPC_SERVICE_NAME': '0', 14:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:37 INFO - Downloading/unpacking psutil>=3.1.1 14:11:37 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 14:11:37 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 14:11:37 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 14:11:37 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 14:11:37 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 14:11:37 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 14:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:40 INFO - Installing collected packages: psutil 14:11:40 INFO - Running setup.py install for psutil 14:11:40 INFO - building 'psutil._psutil_osx' extension 14:11:40 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 14:11:41 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 14:11:41 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 14:11:41 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 14:11:41 INFO - building 'psutil._psutil_posix' extension 14:11:41 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 14:11:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:11:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:11:41 INFO - ^ 14:11:41 INFO - 1 warning generated. 14:11:41 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 14:11:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:41 INFO - Successfully installed psutil 14:11:41 INFO - Cleaning up... 14:11:41 INFO - Return code: 0 14:11:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:41 INFO - 'HOME': '/Users/cltbld', 14:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:41 INFO - 'LOGNAME': 'cltbld', 14:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:41 INFO - 'MOZ_NO_REMOTE': '1', 14:11:41 INFO - 'NO_EM_RESTART': '1', 14:11:41 INFO - 'PAGER': '/bin/cat', 14:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:41 INFO - 'PWD': '/builds/slave/test', 14:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:41 INFO - 'SHELL': '/bin/bash', 14:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:11:41 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:41 INFO - 'USER': 'cltbld', 14:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:41 INFO - 'XPC_FLAGS': '0x0', 14:11:41 INFO - 'XPC_SERVICE_NAME': '0', 14:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:42 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 14:11:42 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 14:11:42 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 14:11:42 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 14:11:42 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 14:11:42 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 14:11:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:44 INFO - Installing collected packages: mozsystemmonitor 14:11:44 INFO - Running setup.py install for mozsystemmonitor 14:11:44 INFO - Successfully installed mozsystemmonitor 14:11:44 INFO - Cleaning up... 14:11:44 INFO - Return code: 0 14:11:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:44 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')]} 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:44 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')]} 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:44 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 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:44 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 14:11:44 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 14:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:44 INFO - 'HOME': '/Users/cltbld', 14:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:44 INFO - 'LOGNAME': 'cltbld', 14:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:44 INFO - 'MOZ_NO_REMOTE': '1', 14:11:44 INFO - 'NO_EM_RESTART': '1', 14:11:44 INFO - 'PAGER': '/bin/cat', 14:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:44 INFO - 'PWD': '/builds/slave/test', 14:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:44 INFO - 'SHELL': '/bin/bash', 14:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:11:44 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:44 INFO - 'USER': 'cltbld', 14:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:44 INFO - 'XPC_FLAGS': '0x0', 14:11:44 INFO - 'XPC_SERVICE_NAME': '0', 14:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:45 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:47 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 14:11:47 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 14:11:47 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 14:11:47 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 14:11:47 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 14:11:47 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 14:11:47 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:48 INFO - warning: no files found matching '*.txt' 14:11:48 INFO - no previously-included directories found matching 'build' 14:11:48 INFO - no previously-included directories found matching 'dist' 14:11:48 INFO - no previously-included directories found matching '.git*' 14:11:48 INFO - Installing collected packages: jsonschema, functools32 14:11:48 INFO - Running setup.py install for functools32 14:11:48 INFO - warning: no files found matching '*.txt' 14:11:48 INFO - no previously-included directories found matching 'build' 14:11:48 INFO - no previously-included directories found matching 'dist' 14:11:48 INFO - no previously-included directories found matching '.git*' 14:11:48 INFO - Successfully installed jsonschema functools32 14:11:48 INFO - Cleaning up... 14:11:48 INFO - Return code: 0 14:11:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:11:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:11:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:48 INFO - 'HOME': '/Users/cltbld', 14:11:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:48 INFO - 'LOGNAME': 'cltbld', 14:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:48 INFO - 'MOZ_NO_REMOTE': '1', 14:11:48 INFO - 'NO_EM_RESTART': '1', 14:11:48 INFO - 'PAGER': '/bin/cat', 14:11:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:48 INFO - 'PWD': '/builds/slave/test', 14:11:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:48 INFO - 'SHELL': '/bin/bash', 14:11:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:11:48 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:11:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:48 INFO - 'USER': 'cltbld', 14:11:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:48 INFO - 'XPC_FLAGS': '0x0', 14:11:48 INFO - 'XPC_SERVICE_NAME': '0', 14:11:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:50 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:52 INFO - Downloading docopt-0.6.1.tar.gz 14:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:52 INFO - Running setup.py install for blobuploader 14:11:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:52 INFO - Running setup.py install for requests 14:11:52 INFO - Running setup.py install for docopt 14:11:53 INFO - Successfully installed blobuploader requests docopt 14:11:53 INFO - Cleaning up... 14:11:53 INFO - Return code: 0 14:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:53 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 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:53 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 14:11:53 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 14:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:53 INFO - 'HOME': '/Users/cltbld', 14:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:53 INFO - 'LOGNAME': 'cltbld', 14:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:53 INFO - 'MOZ_NO_REMOTE': '1', 14:11:53 INFO - 'NO_EM_RESTART': '1', 14:11:53 INFO - 'PAGER': '/bin/cat', 14:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:53 INFO - 'PWD': '/builds/slave/test', 14:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:53 INFO - 'SHELL': '/bin/bash', 14:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:11:53 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:53 INFO - 'USER': 'cltbld', 14:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:53 INFO - 'XPC_FLAGS': '0x0', 14:11:53 INFO - 'XPC_SERVICE_NAME': '0', 14:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:53 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-E6ogFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:53 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-BM3YTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:53 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-c37rQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:53 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-A_IlLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:53 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-qGSmsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:53 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-yCauuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-4bs5Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-suskeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-DFi7Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-LQD5JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-siVrA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-LCgTfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-jHzirN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Lc1Oab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-8E88_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:54 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-GF2Psn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:55 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Y0zKAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:55 INFO - Running setup.py install for manifestparser 14:11:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Running setup.py install for mozcrash 14:11:55 INFO - Running setup.py install for mozdebug 14:11:55 INFO - Running setup.py install for mozdevice 14:11:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Running setup.py install for mozfile 14:11:55 INFO - Running setup.py install for mozhttpd 14:11:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for mozinfo 14:11:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for mozInstall 14:11:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for mozleak 14:11:56 INFO - Running setup.py install for mozlog 14:11:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for moznetwork 14:11:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for mozprocess 14:11:56 INFO - Running setup.py install for mozprofile 14:11:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:57 INFO - Running setup.py install for mozrunner 14:11:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:57 INFO - Running setup.py install for mozscreenshot 14:11:57 INFO - Running setup.py install for moztest 14:11:57 INFO - Running setup.py install for mozversion 14:11:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:57 INFO - Cleaning up... 14:11:57 INFO - Return code: 0 14:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:57 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')]} 14:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:57 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')]} 14:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:57 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 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:11:57 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 14:11:57 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 14:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:57 INFO - 'HOME': '/Users/cltbld', 14:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:57 INFO - 'LOGNAME': 'cltbld', 14:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:57 INFO - 'MOZ_NO_REMOTE': '1', 14:11:57 INFO - 'NO_EM_RESTART': '1', 14:11:57 INFO - 'PAGER': '/bin/cat', 14:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:57 INFO - 'PWD': '/builds/slave/test', 14:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:57 INFO - 'SHELL': '/bin/bash', 14:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:11:57 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:57 INFO - 'USER': 'cltbld', 14:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:57 INFO - 'XPC_FLAGS': '0x0', 14:11:57 INFO - 'XPC_SERVICE_NAME': '0', 14:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-2OTlhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Z3OFbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-PvIvu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-1kexvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-30d6iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Pns8d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-dPbQHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-ar9UuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:58 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)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-tc1IdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:59 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-HJqeIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Kobo0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:59 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-VZtd2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:59 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Gv0qvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:59 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-NFOJ5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:59 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Z_LDVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:59 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-KZEBsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:59 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)) 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Y9pyWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:59 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)) 14:11:59 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)) 14:11:59 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)) 14:11:59 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)) 14:11:59 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)) 14:11:59 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)) 14:11:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:02 INFO - Downloading blessings-1.6.tar.gz 14:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:02 INFO - Installing collected packages: blessings 14:12:02 INFO - Running setup.py install for blessings 14:12:02 INFO - Successfully installed blessings 14:12:02 INFO - Cleaning up... 14:12:02 INFO - Return code: 0 14:12:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:12:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:03 INFO - Reading from file tmpfile_stdout 14:12:03 INFO - Current package versions: 14:12:03 INFO - blessings == 1.6 14:12:03 INFO - blobuploader == 1.2.4 14:12:03 INFO - docopt == 0.6.1 14:12:03 INFO - functools32 == 3.2.3-2 14:12:03 INFO - jsonschema == 2.5.1 14:12:03 INFO - manifestparser == 1.1 14:12:03 INFO - mozInstall == 1.12 14:12:03 INFO - mozcrash == 0.17 14:12:03 INFO - mozdebug == 0.1 14:12:03 INFO - mozdevice == 0.48 14:12:03 INFO - mozfile == 1.2 14:12:03 INFO - mozhttpd == 0.7 14:12:03 INFO - mozinfo == 0.9 14:12:03 INFO - mozleak == 0.1 14:12:03 INFO - mozlog == 3.3 14:12:03 INFO - moznetwork == 0.27 14:12:03 INFO - mozprocess == 0.23 14:12:03 INFO - mozprofile == 0.28 14:12:03 INFO - mozrunner == 6.12 14:12:03 INFO - mozscreenshot == 0.1 14:12:03 INFO - mozsystemmonitor == 0.3 14:12:03 INFO - moztest == 0.7 14:12:03 INFO - mozversion == 1.4 14:12:03 INFO - psutil == 3.1.1 14:12:03 INFO - requests == 1.2.3 14:12:03 INFO - wsgiref == 0.1.2 14:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12: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')]} 14:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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')]} 14:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:03 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 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:12:03 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 14:12:03 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 14:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:03 INFO - 'HOME': '/Users/cltbld', 14:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:03 INFO - 'LOGNAME': 'cltbld', 14:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:03 INFO - 'MOZ_NO_REMOTE': '1', 14:12:03 INFO - 'NO_EM_RESTART': '1', 14:12:03 INFO - 'PAGER': '/bin/cat', 14:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:03 INFO - 'PWD': '/builds/slave/test', 14:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:03 INFO - 'SHELL': '/bin/bash', 14:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:12:03 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:03 INFO - 'USER': 'cltbld', 14:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:03 INFO - 'XPC_FLAGS': '0x0', 14:12:03 INFO - 'XPC_SERVICE_NAME': '0', 14:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 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)) 14:12:03 INFO - Cleaning up... 14:12:03 INFO - Return code: 0 14:12:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:12: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')]} 14:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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')]} 14:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8ca7c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, '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.zCtrALtKLL/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.6HGMr6sbp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 14:12: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'] in /builds/slave/test/build 14:12: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 14:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:03 INFO - 'HOME': '/Users/cltbld', 14:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:03 INFO - 'LOGNAME': 'cltbld', 14:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:03 INFO - 'MOZ_NO_REMOTE': '1', 14:12:03 INFO - 'NO_EM_RESTART': '1', 14:12:03 INFO - 'PAGER': '/bin/cat', 14:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:03 INFO - 'PWD': '/builds/slave/test', 14:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:03 INFO - 'SHELL': '/bin/bash', 14:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:12:03 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:03 INFO - 'USER': 'cltbld', 14:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:03 INFO - 'XPC_FLAGS': '0x0', 14:12:03 INFO - 'XPC_SERVICE_NAME': '0', 14:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:12:03 INFO - Cleaning up... 14:12:03 INFO - Return code: 0 14:12:03 INFO - Running post-action listener: _resource_record_post_action 14:12:03 INFO - Running post-action listener: _start_resource_monitoring 14:12:03 INFO - Starting resource monitoring. 14:12:03 INFO - [mozharness: 2016-07-20 21:12:03.965508Z] Finished create-virtualenv step (success) 14:12:03 INFO - [mozharness: 2016-07-20 21:12:03.966491Z] Running install step. 14:12:03 INFO - Running pre-action listener: _resource_record_pre_action 14:12:03 INFO - Running main action method: install 14:12:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:04 INFO - Reading from file tmpfile_stdout 14:12:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:12:04 INFO - Reading from file tmpfile_stdout 14:12:04 INFO - Output received: 14:12:04 INFO - Usage: mozinstall [options] installer 14:12:04 INFO - Options: 14:12:04 INFO - -h, --help show this help message and exit 14:12:04 INFO - -d DEST, --destination=DEST 14:12:04 INFO - Directory to install application into. [default: 14:12:04 INFO - "/builds/slave/test"] 14:12:04 INFO - --app=APP Application being installed. [default: firefox] 14:12:04 INFO - mkdir: /builds/slave/test/build/application 14:12:04 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'] 14:12:04 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 14:12:38 INFO - Reading from file tmpfile_stdout 14:12:38 INFO - Output received: 14:12:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:12:38 INFO - Running post-action listener: _resource_record_post_action 14:12:38 INFO - [mozharness: 2016-07-20 21:12:38.352481Z] Finished install step (success) 14:12:38 INFO - [mozharness: 2016-07-20 21:12:38.352612Z] Running run-tests step. 14:12:38 INFO - Running pre-action listener: _resource_record_pre_action 14:12:38 INFO - Running main action method: run_tests 14:12:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:38 INFO - 2016-07-20 14:12:38.365 screenresolution[1640:7599] starting screenresolution argv=screenresolution get 14:12:38 INFO - 2016-07-20 14:12:38.368 screenresolution[1640:7599] Display 0: 1600x1200x32@60 14:12:38 INFO - 2016-07-20 14:12:38.373 screenresolution[1641:7601] starting screenresolution argv=screenresolution list 14:12:38 INFO - Available Modes on Display 0 14:12:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:38 INFO - Intel Iris: 14:12:38 INFO - Chipset Model: Intel Iris 14:12:38 INFO - Type: GPU 14:12:38 INFO - Bus: Built-In 14:12:38 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:38 INFO - Vendor: Intel (0x8086) 14:12:38 INFO - Device ID: 0x0a2e 14:12:38 INFO - Revision ID: 0x0009 14:12:38 INFO - Displays: 14:12:38 INFO - Display: 14:12:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:38 INFO - Display Serial Number: 1600x1200 60 14:12:38 INFO - Main Display: Yes 14:12:38 INFO - Mirror: Off 14:12:38 INFO - Online: Yes 14:12:38 INFO - Rotation: Supported 14:12:38 INFO - Return code: 0 14:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:38 INFO - Python 2.7.3 14:12:38 INFO - Return code: 0 14:12:38 INFO - grabbing minidump binary from tooltool 14:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:38 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 0x10fab3d30>, '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 0x10f818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10faabb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:38 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 14:12:38 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 14:12:38 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 14:12:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:38 INFO - Return code: 0 14:12:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:12:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:12:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 14:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0133 --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 14:12:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCtrALtKLL/Render', 14:12:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:38 INFO - 'HOME': '/Users/cltbld', 14:12:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:38 INFO - 'LOGNAME': 'cltbld', 14:12:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:38 INFO - 'MOZ_NO_REMOTE': '1', 14:12:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:38 INFO - 'NO_EM_RESTART': '1', 14:12:38 INFO - 'PAGER': '/bin/cat', 14:12:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:38 INFO - 'PWD': '/builds/slave/test', 14:12:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:38 INFO - 'SHELL': '/bin/bash', 14:12:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HGMr6sbp2/Listeners', 14:12:38 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:12:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:38 INFO - 'USER': 'cltbld', 14:12:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:38 INFO - 'XPC_FLAGS': '0x0', 14:12:38 INFO - 'XPC_SERVICE_NAME': '0', 14:12:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 14:12:38 INFO - mozversion application_buildid: 20160720123119 14:12:38 INFO - mozversion application_changeset: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 14:12:38 INFO - mozversion application_display_name: Nightly 14:12:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:38 INFO - mozversion application_name: Firefox 14:12:38 INFO - mozversion application_remotingname: firefox 14:12:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:12:38 INFO - mozversion application_vendor: Mozilla 14:12:38 INFO - mozversion application_version: 50.0a1 14:12:38 INFO - mozversion platform_buildid: 20160720123119 14:12:38 INFO - mozversion platform_changeset: b125c700ca86f4aecf1d5c5ee86d94f783abffa3 14:12:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:12:38 INFO - mozversion platform_version: 50.0a1 14:12:38 INFO - using testdate: 1469049158 14:12:38 INFO - actual date: 1469049158 14:12:38 INFO - starting webserver on 'localhost:49273' 14:12:38 INFO - SUITE-START | Running 2 tests 14:12:38 INFO - TEST-START | dromaeo_css 14:12:38 INFO - operating with platform_type : mac_ 14:12:38 INFO - Initialising browser for dromaeo_css test... 14:12:38 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp8HJVVf/profile http://localhost:49273/getInfo.html) 14:12:41 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 14:12:41 INFO - PROCESS | 1651 | colorDepth:24 14:12:41 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 14:12:41 INFO - PROCESS | 1651 | __metrics 14:12:41 INFO - PROCESS | 1651 | 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" 14:12:41 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:42 INFO - TEST-INFO | 1651: exit 0 14:12:42 INFO - Browser initialized. 14:12:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:42 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp8HJVVf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:54 INFO - PROCESS | 1653 | RSS: Main: 245493760 14:12:54 INFO - PROCESS | 1653 | 14:13:45 INFO - PROCESS | 1653 | 1469049225328 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] 14:15:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 14:15:57 INFO - PROCESS | 1653 | RSS: Main: 379826176 14:15:57 INFO - PROCESS | 1653 | 14:19:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 14:19:01 INFO - PROCESS | 1653 | RSS: Main: 382038016 14:19:01 INFO - PROCESS | 1653 | 14:22:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 14:22:04 INFO - PROCESS | 1653 | RSS: Main: 372830208 14:22:04 INFO - PROCESS | 1653 | 14:25:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 14:25:07 INFO - PROCESS | 1653 | RSS: Main: 373141504 14:25:07 INFO - PROCESS | 1653 | 14:28:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 14:28:11 INFO - PROCESS | 1653 | RSS: Main: 342904832 14:28:11 INFO - PROCESS | 1653 | 14:31:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 14:31:15 INFO - PROCESS | 1653 | RSS: Main: 403320832 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | __start_tp_report 14:31:15 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 14:31:15 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 14:31:15 INFO - PROCESS | 1653 | |i|pagename|runs| 14:31:15 INFO - PROCESS | 1653 | |0;dojo.html;3388.2037721135534;3401.5067815166803;3415.231572896098;3418;3474.2704032153247;5683.886322273563;5739.397363276858;5747.195392645022;5814.389489103647;5834.533237341007;5786.189933409316;5794.855128621786;5892.08672655738;5919.408059194078;5923.526117910567;5157.638965272433;5218.739063046852;5232.110541207985;5245.816396426126;5361.5978801589845;5360.624756267063;5375.569954403658;5382.8923421531545;5393.379761327439;5419.864503387407;4131.917361652765;5165.7158856262895;5204.271402003685;5216.895662086737;5250.8687282817855;5183.092958732244;5247.23915032322;5267.47325267474;5268.973655131738;5273.789048438058;5213.921791173136;5216.165413533854;5232.607554433433;5291.391489978663;5347;5791.913121303184;5876.08920617305;5888.5289176865745;5894.764209431618;5900.704964751788;6105.035213715971;6354.2692590352235;6361.3638636136475;6368.745250190033;6374.012028135647;6273.309935907047;6275.7175927082935;6298.937010629881;6369.8407539811415;6375.968120159416;5991.970040149771;5994.550408719363;5997.0404735242155;5998.670073146019;6000.279966404059;6254.405831446005;6262.624242545462;6277.027060805583;6351.55539112267;6370.1718776558755;6176.629402235881;6219.191505104308;6225.097360882737;6226.6575338355915;6226.906596401058;6336.461400780985;6352.333005034498;6364.872702546016;6369.044643303541;6376.29860715321;6112.442689633878;6179.84550386235;6255.280642726145;6280.466160376328;6310.5267104967315;6139.995903338765;6201.596896201732;6279.591826531261;6282.654454005074;6287.622742635456;5021.874453138701;5029.321041659402;5037;5037.974810125926;5075.289459475676;4513.255312873404;4531.478879928784;4533.682642215079;4549.226631472658;4574.702644328175;5718.714064296852;5759.539236861041;5763.88472230553;5771.220885180531;5845.824625261249;6291.622502649856;6306.148669929593;6317.684115794192;6320.652364119926;6321.778737744249;5777.6822274775295;5848.619839710405;5854.560907931922;5871.383504732027;5904.0553511437965;5338.145896656516;5442.755076021588;5444.237806707064;5494.120940649477;5498.697571633518;6289.905651415233;6375.553711240169;6376.93623063782;6383.010633351838;6389.7763578274535;5293.258943747801;6316.968415157895;6327.683615819283;6335.90496142549;6348.746050158126;4920.40955085392;5384.326959130109;6293.622382657055;6312.968435157794;6348.873022539431;6153.692315384303;6206.441420272016;6215.347388524321;6221;6241.563090583615;6134.325224225421;6297.1813664223355;6297.4647154992335;6309.779157729457;6311.905321420274;6078.908816367846;6173.444390004921;6200.286966998853;6218.595791273553;6222.502199824094;6137.622145770902;6142.600730952474;6144.324124346408;6162.568620196544;6195.566310358232;6140.662263575547;6144.201253836973;6149.385061493815;6169;6177.2587289525545;6102.809952059306;6135.049067394561;6151.292601350902;6154;6161.260648722182;5927.31835838884;6006;6006.879862402815;6014.849628759316;6092.299385570716 14:31:15 INFO - PROCESS | 1653 | |1;ext.html;502.7958040493019;508.7837668990679;517.5161224255321;540.2085944091905;541.3233458177278;30877.073687789376;42637.57362426379;44037.11925761491;44042.559574404244;44162;45440.091198176015;45749;45806.31290530645;45819;46199.53800461994;8761.912380876205;9833.60665573378;10030.297879148462;10038.949805250964;10048.698539043804;8735.301175905912;12049.397530123502;12244.204126731735;12270.263784172934;12499.187552809084;12281.570145044925;12353.567625133122;12360.690982725413;12367.938160309186;12386.256824590508;8881.422707524054;11956.983656389217;12268.07989400794;12314.81527777084;12353.258804471716;11952.223105498115;12251.448684809206;12254.326012069332;12259.203151795105;12364.56724014655;42414.57585424137;42691.78654106709;42722.145557088996;42751.35872961908;42778.35832462516;3780.584135745093;3789.9242015159543;3811.5807261201244;4073.307537718595;4285.357196420562;32811.50782738261;33948.49077263843;34141.829290853384;34185.14537136567;34228.82885585581;3235.7411407087375;3410.641882602316;3419.760616756828;3447.896563103111;3451.4822776583715;343762;344464;344786;344917;348012;65114.67442662851;65476.67261663661;65507;65622;65635;67747.66126169337;67970.32029679739;68544;68777;68874.3112568868;14391.424343026161;16199.919000404923;17189;17225.913870430566;17265;12015.939920300518;12262.019038476901;13062.738745225042;13251.66870828237;13330.066895317428;16896.915515422592;17422.738658920127;17441.91279043622;17465.650686986442;17496;6671.266160722316;6734.797956061326;6816.931830681729;6841.3842754152365;6853.211880633791;854.3976496570027;942.6276620734772;1005.7636455432968;1014.2950649298814;1091.7325255312498;30665;31225.21936951549;31265.687343126734;31879;32021.039368818972;1050.3960222871726;1073.2755390111643;1116.9609063682733;1133.920625556203;1170.9355985420714;15993.36026558948;16302.266398011881;16366.018038917702;16366.836331636769;16648.500544983668;699741;704204;706580;712054;712481;63095.36904630895;63186.684066580296;63237.36762632407;63333.36666633367;63343.366566333745;1261.829652996852;1398.5594537720585;1411.498917884157;1434.7058852935331;1434.9139051656934;31472;32408.35183296368;32636;32996.34007319888;33252.83373583117;48650.270245945634;53400.198997015854;53740.462595373545;53913.460865392415;53950.73024634852;516214;586632;595547;595627.2405017766;597012;29989.250268743457;36967.075823104635;41822;42472.36291455692;46139.30791038204;50380;50417.74791126168;50768.23847642362;51480;51922;39780.20439591134;40880;41326.79336603298;42047.789761051;43199.784001079795;41763.7911810439;41804.372934406616;41909.371359430246;42313.519026833914;43111.84440778011;39665;40349.39475907922;40942.567010154504;41046.79476602598;41067.383989239584;34780.82609586936;35845.28309433744;36592.45111323279;36620.81689591535;36912.630873692;21671.783282166976;25894.223173304832;26211.868940655175;26783.196504104908;27013.729862701122 14:31:15 INFO - PROCESS | 1653 | |2;jquery.html;356.7538398505033;374.6366024955794;377.8771899132782;388.8877809464931;410.42335518596366;14721.926390368046;15551.688966220669;20758;21147.682784758243;21185.258515951944;20400.89799551004;20508.69236961443;20819.375418737425;20861.47846303843;20866.165353385848;5829.533637309016;5859.501942334907;6081.179040829497;6089.360617135203;6089.573729838913;6002;6153.692315384235;6154.876902461948;6160.2915664698685;6168.907466388007;6063.6361818290825;6148.600340977844;6163.7226324815265;6733.461323094165;6794.626295553742;6576.835579110512;6829.863402731968;6833.794986150423;6835.726570937181;6843.692033858513;4970.353853998993;5930.673812940287;5935.080062590306;5943.078822782432;5957.225560677128;13294;13331.933340333333;13370;13524.120932139478;13565.932170339183;2193.890305484719;2485;2972.4055188962293;2981.5378616314506;3060.693930606944;9954.153896918771;10047.899521004769;10433.16534677224;10452.216083793746;10470.371777693363;1804.7563578916809;1834.4129878438905;1862.8602854785809;1901.5531350132708;1964.312490628283;117392;130730;131812;132123;132946.335268324;11344.886551134548;11377.431128443544;11558.422078896021;11569;11798.233114847679;14588.635284117981;14617.634559136106;14621.415143394357;14631.341589628491;14646.194459304841;8406.117357677478;8542.658293668308;8553.23020928107;8575.914240857512;8682.652693892174;8562;8581.313494920392;8591.269742071994;8738.86891696625;8741;4500.729956202638;4507.752073635981;4514.977425112854;4515.841945531956;4589.2886602576655;1877.6338613970418;1923.2307077168964;1926.2391355414813;1926.8651194416257;1934.4970307719814;888.2583043158905;894.7852515396258;940.4780346907532;979.7256768104942;998.4708104704519;19899.900500497406;21159.471013224793;21254.78745212528;21389.037493312528;21506.677399839016;827.6027506796771;891.7859713668803;905.2757793764962;954.8281309364243;966.5698764050071;9001.63993440255;9953.552090155961;11154.274972126786;11202.831957520644;11250;625015;635306;635848;642071;644688;94805;125190;132833;135076;141188;965.4689920543673;996.7657600463886;1018.9439580823274;1045.095991966943;1047.319242492371;18469.53826154357;18948.810511894706;19017.714734279274;19021.90489047546;19138.598615658488;52638.73680631573;58370.4162958365;58753.4124658748;60611;61315.693421532604;76485;87364.1263587356;89407.55296223477;91777.62333565135;91821.54089229512;7955.562444065632;8008.171603677175;8131.227533384319;8136.349092072502;8345.499270043816;11376.653960524649;12645.936770316457;13113.606591802261;13130.015248856183;13142.474301027853;10966.506507207354;11247.906825622691;11272.66182014541;11400.600978965696;11421.857814218512;10003.699889003341;10937.56249750001;11231.775364492827;11269.985701286923;11356;9968;11067.335959842436;11109.944450277697;11420.371879546705;11490.425478726198;6612.335064779972;7786;8044.83910321802;8182.099969003524;8268.545230012407;9955.701328960144;10832.079273261546;11136.832947505956;11197;11263.436828158723 14:31:15 INFO - PROCESS | 1653 | |3;mootools.html;1540.468538354268;1574.1499590221279;1758.4021432712882;1871.93448229312;1895.327158858606;8604.784880377985;9050.27597792176;9051;9051.63793448263;9055.547222638857;7930.643121059552;8110.026796784379;8638.352123590741;8847.690330838406;8877;2390.3426557696644;2411.1560953666253;2414.167112346238;2415.9516809663796;2425.563398588253;2378.47673511828;2382.9761702383016;2423.218934083456;2423.51529694061;2428.9271321860374;2100.8109270165683;2333.9066437342485;2388.4028992751814;2397.6643269942224;2398.37642213025;2288.3135059482174;2302.2977991712687;2307.757685443038;2313.086330899302;2314.722233331994;2361.8700971446565;2390.952180956371;2395.3053614451787;2397.5924092904247;2402.6756387887585;9120.179183873417;9162.770930726718;9176.128267814614;9180.632774689004;9198.770030749218;4683.765811709401;5186.5850731941355;5391.892162156735;5396.244525766396;5405.054115529767;3148.763842711806;3446.4141096013486;3511.490833829106;3652.4156135018534;3663.5420572428447;1092.2627226621998;1097.6663354024818;1100.4772732951865;1115.4813011949482;1120.5685810962839;11618.128640352008;11829.112816538795;11841.23032002917;11853.703657408547;11894.345810980392;4604.815807367735;4646.4191976003;4802.087603355351;4820.855374338776;4822.758862056883;10006.049425304584;10007.749806254902;10024.699259022242;10040.849387259197;10045.79908401828;5372.221027950925;5373.811916582901;5379.865503362369;5382.757775900016;5396.217548455452;3917.804109794556;4398.802053907518;4565.246734288805;4876.634252431082;4916.8770780730765;3347.6317605063423;3918.7648741075627;4037.7779222142476;4076.490438695163;4090.877273681794;1295.6242689619905;1304.6673098360047;1307.607717684691;1323.232525135419;1324.3576865220361;815.983680326402;824.8474032304043;927.1284992107397;942.9203561921698;991.2466525440573;5841;5852;5986.221791167208;6004.399560044048;6178.938210617926;453.4830293465452;461.9630429565627;474.810075969608;475.10917030567686;475.9428868535729;3873.8063096845044;4041.777702226406;4073.279287871572;4089.2434899543678;4115.814788334532;10555.10281626055;10789.946050269855;10925.235233533735;10940.070094042096;10943.398113103696;10861.1854110942;10870.94564527188;10871.347719136877;10879.891201088047;10888.455577221108;8091.676332946734;8176.46852954556;8356.665733370719;8392.28665563434;8407.873881891654;5783.363829978614;5814.825555233349;5866.911996319973;5922.585419020627;5943.910841337297;9941;10121.645742398981;10205.285630005828;10240.078392944672;10259.435731034864;9824.754381140528;10187.13409360183;10203.897961020592;10349.74125646865;10369.325993810378;7035.226125126334;7283.963580182065;7449.664765085476;7690.154083050748;7888.408369372435;8320.916790832256;8640.524771137396;8650.740477785677;8654.22112009922;8656.26421754158;6367.42693157618;7594.430417718803;7601.239876012354;7692.807679808049;7717.2668596483245;7423.703051877865;7458.328750412489;7467.029286192977;7578.166401695698;7669.386449083949;6998.895016574654;7171.49799514029;7178.282171782989;7180.281971802778;7183.712651493882;4950.421381058461;5074.695518268915;5133.666311689728;5148.742562871917;5162.741862906764;5027.899442011212;5027.974860125676;5152.330197074356;5180.792768289226;5327.227552005015 14:31:15 INFO - PROCESS | 1653 | |4;prototype.html;305.30847630117785;305.33894119231866;318.1426056776986;324.9951250731238;328.367891808269;5380.192971054339;5408.783648654054;5431.343440250722;5478.397376288605;5479.53423958964;5042.697438153713;5148;5329.786808527664;5374.516293533581;5455.208994695767;3658.9817050914708;3876.341022026262;4099;4104.21466662003;4167.916641667165;3475.582930048398;4075.6535694466006;4118.299889018874;4167.791610419466;4171.979140104295;3234.3181545596276;4041.009952561612;4121.773302468363;4133;4137.13120244749;4072.9389059164137;4089.5092588889224;4092.386142078682;4097.221527909687;4117.94992276969;3092.721655051034;3536.6286539913194;3537.6816086552076;3541.6281290464644;3564.697000754939;4371.759553224571;5311.867203319909;5343.332083489564;5346.732663366816;5374.408815030382;4368.170047690928;4654.348391225231;4676.953230467686;4695.929561056552;4699.365585645928;4588.466880501995;4879.414470263591;5703.771849126071;5728.914066289009;5729.942700572982;3425.520427140202;3870.9225815483533;3872.206197729459;3882.4758657581147;3905.7265991380614;4831.396075490564;5161.974190129063;5955.52355811534;5956;5965.642061476326;3460.1522626956557;3902.3561112416132;3917.4515567820526;3921.3529767588598;3922.9800251934703;3940.408938659224;3951.9012024699036;3956.9802150989062;3972.212504373044;4010.7192496524963;3950.802459877052;4212.978935105305;4329.956700433018;4654.697444666086;4670.9766451167525;5728.169415434739;5728.341240757283;5729.656220626775;5732.512736417451;5754.625949313281;1279.8272233248392;1338.2505796753849;1359.6872719274622;1360.911540749868;1368.438940034601;718.7664009197032;757.4167890724111;846.8679800409537;877.9517126557973;880.0143838900473;4286.764227967492;4291.527931927485;4383.627391671744;4385.802638881258;4398.328635118634;4430.556944305544;4888.802243450377;4904.8773780655765;4922;4924.9507504925205;4168.416421700964;4177.767558570229;4298.591633794785;4520.784815440411;4525.615322697542;2229.4983628683417;2566.268613445159;2587.301428614301;3052.138195700621;3107.704768047032;5380.166074258496;5602.327720673464;6017.398260173947;6024.759009639653;6070.3929607038945;4953.826616068421;5136.101182293084;5159.742012899415;5474.153440211147;5997.850053748692;6002.309734380602;6030;6035.336113027563;6045.939540604538;6064.878702425926;5847.356790753099;5854.214464588342;5924.289085309791;5936.643801371932;5940.188447357654;4857.551138691569;5543.972280138573;5811;5840.386759390372;5844.327902291291;5329.081530648886;6037.09443583466;6045.727942242522;6056.273247210363;6058.84852878664;3947.565767765601;3971.3447281199433;3984.322665146874;3986.6412022918075;3995.380715989026;5592.440755924537;5646.548276137982;5842;5858.853528661817;5888;4668.719876807402;4765.928511072406;5560.944390556043;5581.358143813513;5738.512226460798;5724.255846739898;5759.568032397503;5761.983305842921;5809.186713859978;5818.418158184317;5296.523312901703;5338.839834804962;5535.612507124462;5575.804846830341;5605.5515558756015;5234.005538947587;5708.571857110816;5731.595759039062;5733.512651424676;5744.4829965303325;4657;5541.722913854372;5587.664740115606;5599.748011339581;5650.519705825051 14:31:15 INFO - PROCESS | 1653 | |5;yui.html;740.2375553180223;741.5624781378986;746.3357611725564;788.9842203155937;833.9457935234209;15002.174880381588;16115.516534503955;16150.75773863393;16154.273057712402;16173.19134043296;13606.863931360684;13689.247091409969;13701.246431446267;13709.314534273271;14086.859131408683;726.1612837173047;749.4828568287891;895.0020726889504;917.7200953709133;920.5765347939956;917.8485549884294;927.188709878856;931.6599441203946;933.1834644685899;933.6358820060182;985.871836661233;987.3384832162468;987.9506024698736;988.332875309167;991.9702408927744;979.0796651147898;980.789130336981;981.9263555233315;984.3798407003578;985.1626117799849;582.1006544888158;724.1129616220088;738.6712912753827;743.8177646476648;744.888266759985;15042.172680502568;15084.39662413502;15084.39662413502;15114.168720720467;15121.546353609408;13846.792298115537;14106.85893141076;14187.645308867257;14231.715365692731;14285.428582856674;11306.660800176009;11719.472623731952;11733.354665493394;12778.680532986657;13381.330933453288;3843.404272337792;4561.612262957653;4646.303054541812;4759.643026772971;4799.544043315879;99488.50255748675;101553.98446015519;102553.48723256336;108860.36709449365;109131;11003.779924401468;11158.107351411867;11162.888371116185;11238.38188899602;11622.94188529052;22334;22423.77576224217;22466.550668986856;22473.55052898933;22703.432414189778;8120.228578285053;8127.2279133482225;8151.429399941947;8213.79465513367;8400.579971001425;4523.660725445605;4661.95338046622;4710.3405523226775;4797.736124513185;4802.447718512346;3482.564679415073;3578.4453409721013;3580.445031020196;3582.0686621478603;3584.1039740064984;633.4932054356497;645.2998496631208;651.133991790917;661.0744957060155;661.1834384535096;603.7584966013629;677.9254282028973;699.860027994393;708.1537562612629;718.3678363040596;8239.299659529008;9254.537273136451;9932.553035113437;10006.899931000742;10052.798944021224;593.2021431175062;604.4529700620946;624.687656171914;675.0427477510888;694.6804469943781;4512.661550383735;4566.566176213254;4628.837990670378;4637;4718.952810471851;89714.55142724376;91664;92427;154227;154952.22523887534;130959.34520327338;133863;135290;137028.31485842506;138274;74939;101321;110307.44846275878;114815;115970.42014789872;8543.188397102265;8552.444091134057;8903.73288801337;8956.529084124657;9174;57196;58463.12305315339;60390.69804650949;60451.09323360065;61400;87752.1224787744;93448.53275733578;93804.53097734468;94244.52877735568;94533.75887087335;11847.348395838311;12195.634130976085;12501.374931253218;12673.493060277486;12714.237145771283;13511.932440337736;13547.458101675822;13637.24995125238;13931.373088210852;14009.579712608638;12704.682382940131;12799.680007999874;12831.422585983466;12849.550265740654;13224.206547607175;11100.888991110309;13861.514846980308;14211.786823197453;14219.360128794022;14637.560873173821;13601.115927464683;14215;14236.217008064656;14253.216073116078;14411.495597654452;10712.035286704524;11115.88884111181;11354.205205635526;11469.254498457574;11471.713207169887;8613.612387442456;8644.481331120152;9436.197923176607;10753;11270.83093753578 14:31:15 INFO - PROCESS | 1653 | __end_tp_report 14:31:15 INFO - PROCESS | 1653 | __start_cc_report 14:31:15 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1425 14:31:15 INFO - PROCESS | 1653 | __end_cc_report 14:31:15 INFO - PROCESS | 1653 | __startTimestamp1469050275237__endTimestamp 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | ------- Summary: start ------- 14:31:15 INFO - PROCESS | 1653 | Number of tests: 6 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5801.17 Median:6078.91 stddev:648.27 (10.7%) stddev-sans-first:622.01 14:31:15 INFO - PROCESS | 1653 | Values: 3388.2 3401.5 3415.2 3418.0 3474.3 5683.9 5739.4 5747.2 5814.4 5834.5 5786.2 5794.9 5892.1 5919.4 5923.5 5157.6 5218.7 5232.1 5245.8 5361.6 5360.6 5375.6 5382.9 5393.4 5419.9 4131.9 5165.7 5204.3 5216.9 5250.9 5183.1 5247.2 5267.5 5269.0 5273.8 5213.9 5216.2 5232.6 5291.4 5347.0 5791.9 5876.1 5888.5 5894.8 5900.7 6105.0 6354.3 6361.4 6368.7 6374.0 6273.3 6275.7 6298.9 6369.8 6376.0 5992.0 5994.6 5997.0 5998.7 6000.3 6254.4 6262.6 6277.0 6351.6 6370.2 6176.6 6219.2 6225.1 6226.7 6226.9 6336.5 6352.3 6364.9 6369.0 6376.3 6112.4 6179.8 6255.3 6280.5 6310.5 6140.0 6201.6 6279.6 6282.7 6287.6 5021.9 5029.3 5037.0 5038.0 5075.3 4513.3 4531.5 4533.7 4549.2 4574.7 5718.7 5759.5 5763.9 5771.2 5845.8 6291.6 6306.1 6317.7 6320.7 6321.8 5777.7 5848.6 5854.6 5871.4 5904.1 5338.1 5442.8 5444.2 5494.1 5498.7 6289.9 6375.6 6376.9 6383.0 6389.8 5293.3 6317.0 6327.7 6335.9 6348.7 4920.4 5384.3 6293.6 6313.0 6348.9 6153.7 6206.4 6215.3 6221.0 6241.6 6134.3 6297.2 6297.5 6309.8 6311.9 6078.9 6173.4 6200.3 6218.6 6222.5 6137.6 6142.6 6144.3 6162.6 6195.6 6140.7 6144.2 6149.4 6169.0 6177.3 6102.8 6135.0 6151.3 6154.0 6161.3 5927.3 6006.0 6006.9 6014.8 6092.3 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:70070.30 Median:36939.85 stddev:150902.18 (408.5%) stddev-sans-first:151235.11 14:31:15 INFO - PROCESS | 1653 | Values: 502.8 508.8 517.5 540.2 541.3 30877.1 42637.6 44037.1 44042.6 44162.0 45440.1 45749.0 45806.3 45819.0 46199.5 8761.9 9833.6 10030.3 10038.9 10048.7 8735.3 12049.4 12244.2 12270.3 12499.2 12281.6 12353.6 12360.7 12367.9 12386.3 8881.4 11957.0 12268.1 12314.8 12353.3 11952.2 12251.4 12254.3 12259.2 12364.6 42414.6 42691.8 42722.1 42751.4 42778.4 3780.6 3789.9 3811.6 4073.3 4285.4 32811.5 33948.5 34141.8 34185.1 34228.8 3235.7 3410.6 3419.8 3447.9 3451.5 343762.0 344464.0 344786.0 344917.0 348012.0 65114.7 65476.7 65507.0 65622.0 65635.0 67747.7 67970.3 68544.0 68777.0 68874.3 14391.4 16199.9 17189.0 17225.9 17265.0 12015.9 12262.0 13062.7 13251.7 13330.1 16896.9 17422.7 17441.9 17465.7 17496.0 6671.3 6734.8 6816.9 6841.4 6853.2 854.4 942.6 1005.8 1014.3 1091.7 30665.0 31225.2 31265.7 31879.0 32021.0 1050.4 1073.3 1117.0 1133.9 1170.9 15993.4 16302.3 16366.0 16366.8 16648.5 699741.0 704204.0 706580.0 712054.0 712481.0 63095.4 63186.7 63237.4 63333.4 63343.4 1261.8 1398.6 1411.5 1434.7 1434.9 31472.0 32408.4 32636.0 32996.3 33252.8 48650.3 53400.2 53740.5 53913.5 53950.7 516214.0 586632.0 595547.0 595627.2 597012.0 29989.3 36967.1 41822.0 42472.4 46139.3 50380.0 50417.7 50768.2 51480.0 51922.0 39780.2 40880.0 41326.8 42047.8 43199.8 41763.8 41804.4 41909.4 42313.5 43111.8 39665.0 40349.4 40942.6 41046.8 41067.4 34780.8 35845.3 36592.5 36620.8 36912.6 21671.8 25894.2 26211.9 26783.2 27013.7 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:36444.54 Median:3021.12 stddev:106336.68 (3519.8%) stddev-sans-first:106600.46 14:31:15 INFO - PROCESS | 1653 | Values: 356.8 374.6 377.9 388.9 410.4 14721.9 15551.7 20758.0 21147.7 21185.3 20400.9 20508.7 20819.4 20861.5 20866.2 5829.5 5859.5 6081.2 6089.4 6089.6 6002.0 6153.7 6154.9 6160.3 6168.9 6063.6 6148.6 6163.7 6733.5 6794.6 6576.8 6829.9 6833.8 6835.7 6843.7 4970.4 5930.7 5935.1 5943.1 5957.2 13294.0 13331.9 13370.0 13524.1 13565.9 2193.9 2485.0 2972.4 2981.5 3060.7 9954.2 10047.9 10433.2 10452.2 10470.4 1804.8 1834.4 1862.9 1901.6 1964.3 117392.0 130730.0 131812.0 132123.0 132946.3 11344.9 11377.4 11558.4 11569.0 11798.2 14588.6 14617.6 14621.4 14631.3 14646.2 8406.1 8542.7 8553.2 8575.9 8682.7 8562.0 8581.3 8591.3 8738.9 8741.0 4500.7 4507.8 4515.0 4515.8 4589.3 1877.6 1923.2 1926.2 1926.9 1934.5 888.3 894.8 940.5 979.7 998.5 19899.9 21159.5 21254.8 21389.0 21506.7 827.6 891.8 905.3 954.8 966.6 9001.6 9953.6 11154.3 11202.8 11250.0 625015.0 635306.0 635848.0 642071.0 644688.0 94805.0 125190.0 132833.0 135076.0 141188.0 965.5 996.8 1018.9 1045.1 1047.3 18469.5 18948.8 19017.7 19021.9 19138.6 52638.7 58370.4 58753.4 60611.0 61315.7 76485.0 87364.1 89407.6 91777.6 91821.5 7955.6 8008.2 8131.2 8136.3 8345.5 11376.7 12645.9 13113.6 13130.0 13142.5 10966.5 11247.9 11272.7 11400.6 11421.9 10003.7 10937.6 11231.8 11270.0 11356.0 9968.0 11067.3 11109.9 11420.4 11490.4 6612.3 7786.0 8044.8 8182.1 8268.5 9955.7 10832.1 11136.8 11197.0 11263.4 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5766.59 Median:2579.29 stddev:3271.76 (126.8%) stddev-sans-first:3265.52 14:31:15 INFO - PROCESS | 1653 | Values: 1540.5 1574.1 1758.4 1871.9 1895.3 8604.8 9050.3 9051.0 9051.6 9055.5 7930.6 8110.0 8638.4 8847.7 8877.0 2390.3 2411.2 2414.2 2416.0 2425.6 2378.5 2383.0 2423.2 2423.5 2428.9 2100.8 2333.9 2388.4 2397.7 2398.4 2288.3 2302.3 2307.8 2313.1 2314.7 2361.9 2391.0 2395.3 2397.6 2402.7 9120.2 9162.8 9176.1 9180.6 9198.8 4683.8 5186.6 5391.9 5396.2 5405.1 3148.8 3446.4 3511.5 3652.4 3663.5 1092.3 1097.7 1100.5 1115.5 1120.6 11618.1 11829.1 11841.2 11853.7 11894.3 4604.8 4646.4 4802.1 4820.9 4822.8 10006.0 10007.7 10024.7 10040.8 10045.8 5372.2 5373.8 5379.9 5382.8 5396.2 3917.8 4398.8 4565.2 4876.6 4916.9 3347.6 3918.8 4037.8 4076.5 4090.9 1295.6 1304.7 1307.6 1323.2 1324.4 816.0 824.8 927.1 942.9 991.2 5841.0 5852.0 5986.2 6004.4 6178.9 453.5 462.0 474.8 475.1 475.9 3873.8 4041.8 4073.3 4089.2 4115.8 10555.1 10789.9 10925.2 10940.1 10943.4 10861.2 10870.9 10871.3 10879.9 10888.5 8091.7 8176.5 8356.7 8392.3 8407.9 5783.4 5814.8 5866.9 5922.6 5943.9 9941.0 10121.6 10205.3 10240.1 10259.4 9824.8 10187.1 10203.9 10349.7 10369.3 7035.2 7284.0 7449.7 7690.2 7888.4 8320.9 8640.5 8650.7 8654.2 8656.3 6367.4 7594.4 7601.2 7692.8 7717.3 7423.7 7458.3 7467.0 7578.2 7669.4 6998.9 7171.5 7178.3 7180.3 7183.7 4950.4 5074.7 5133.7 5148.7 5162.7 5027.9 5028.0 5152.3 5180.8 5327.2 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4529.95 Median:4913.44 stddev:1419.55 (28.9%) stddev-sans-first:1387.67 14:31:15 INFO - PROCESS | 1653 | Values: 305.3 305.3 318.1 325.0 328.4 5380.2 5408.8 5431.3 5478.4 5479.5 5042.7 5148.0 5329.8 5374.5 5455.2 3659.0 3876.3 4099.0 4104.2 4167.9 3475.6 4075.7 4118.3 4167.8 4172.0 3234.3 4041.0 4121.8 4133.0 4137.1 4072.9 4089.5 4092.4 4097.2 4117.9 3092.7 3536.6 3537.7 3541.6 3564.7 4371.8 5311.9 5343.3 5346.7 5374.4 4368.2 4654.3 4677.0 4695.9 4699.4 4588.5 4879.4 5703.8 5728.9 5729.9 3425.5 3870.9 3872.2 3882.5 3905.7 4831.4 5162.0 5955.5 5956.0 5965.6 3460.2 3902.4 3917.5 3921.4 3923.0 3940.4 3951.9 3957.0 3972.2 4010.7 3950.8 4213.0 4330.0 4654.7 4671.0 5728.2 5728.3 5729.7 5732.5 5754.6 1279.8 1338.3 1359.7 1360.9 1368.4 718.8 757.4 846.9 878.0 880.0 4286.8 4291.5 4383.6 4385.8 4398.3 4430.6 4888.8 4904.9 4922.0 4925.0 4168.4 4177.8 4298.6 4520.8 4525.6 2229.5 2566.3 2587.3 3052.1 3107.7 5380.2 5602.3 6017.4 6024.8 6070.4 4953.8 5136.1 5159.7 5474.2 5997.9 6002.3 6030.0 6035.3 6045.9 6064.9 5847.4 5854.2 5924.3 5936.6 5940.2 4857.6 5544.0 5811.0 5840.4 5844.3 5329.1 6037.1 6045.7 6056.3 6058.8 3947.6 3971.3 3984.3 3986.6 3995.4 5592.4 5646.5 5842.0 5858.9 5888.0 4668.7 4765.9 5560.9 5581.4 5738.5 5724.3 5759.6 5762.0 5809.2 5818.4 5296.5 5338.8 5535.6 5575.8 5605.6 5234.0 5708.6 5731.6 5733.5 5744.5 4657.0 5541.7 5587.7 5599.7 5650.5 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:23761.91 Median:4518.16 stddev:37210.03 (823.6%) stddev-sans-first:37274.26 14:31:15 INFO - PROCESS | 1653 | Values: 740.2 741.6 746.3 789.0 833.9 15002.2 16115.5 16150.8 16154.3 16173.2 13606.9 13689.2 13701.2 13709.3 14086.9 726.2 749.5 895.0 917.7 920.6 917.8 927.2 931.7 933.2 933.6 985.9 987.3 988.0 988.3 992.0 979.1 980.8 981.9 984.4 985.2 582.1 724.1 738.7 743.8 744.9 15042.2 15084.4 15084.4 15114.2 15121.5 13846.8 14106.9 14187.6 14231.7 14285.4 11306.7 11719.5 11733.4 12778.7 13381.3 3843.4 4561.6 4646.3 4759.6 4799.5 99488.5 101554.0 102553.5 108860.4 109131.0 11003.8 11158.1 11162.9 11238.4 11622.9 22334.0 22423.8 22466.6 22473.6 22703.4 8120.2 8127.2 8151.4 8213.8 8400.6 4523.7 4662.0 4710.3 4797.7 4802.4 3482.6 3578.4 3580.4 3582.1 3584.1 633.5 645.3 651.1 661.1 661.2 603.8 677.9 699.9 708.2 718.4 8239.3 9254.5 9932.6 10006.9 10052.8 593.2 604.5 624.7 675.0 694.7 4512.7 4566.6 4628.8 4637.0 4719.0 89714.6 91664.0 92427.0 154227.0 154952.2 130959.3 133863.0 135290.0 137028.3 138274.0 74939.0 101321.0 110307.4 114815.0 115970.4 8543.2 8552.4 8903.7 8956.5 9174.0 57196.0 58463.1 60390.7 60451.1 61400.0 87752.1 93448.5 93804.5 94244.5 94533.8 11847.3 12195.6 12501.4 12673.5 12714.2 13511.9 13547.5 13637.2 13931.4 14009.6 12704.7 12799.7 12831.4 12849.6 13224.2 11100.9 13861.5 14211.8 14219.4 14637.6 13601.1 14215.0 14236.2 14253.2 14411.5 10712.0 11115.9 11354.2 11469.3 11471.7 8613.6 8644.5 9436.2 10753.0 11270.8 14:31:15 INFO - PROCESS | 1653 | -------- Summary: end -------- 14:31:15 INFO - PROCESS | 1653 | 14:31:15 INFO - TEST-INFO | 1653: exit 0 14:31:15 INFO - TEST-OK | dromaeo_css | took 1116911ms 14:31:15 INFO - TEST-START | kraken 14:31:15 INFO - operating with platform_type : mac_ 14:31:15 INFO - Initialising browser for kraken test... 14:31:15 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpD4zipV/profile http://localhost:49273/getInfo.html) 14:31:17 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 14:31:17 INFO - PROCESS | 1664 | colorDepth:24 14:31:17 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 14:31:17 INFO - PROCESS | 1664 | __metrics 14:31:18 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:31:18 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:18 INFO - TEST-INFO | 1664: exit 0 14:31:18 INFO - Browser initialized. 14:31:18 INFO - Running cycle 1/1 for kraken test... 14:31:18 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpD4zipV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:30 INFO - PROCESS | 1665 | RSS: Main: 245411840 14:31:30 INFO - PROCESS | 1665 | 14:31:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:34 INFO - PROCESS | 1665 | RSS: Main: 295407616 14:31:34 INFO - PROCESS | 1665 | 14:31:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 14:31:37 INFO - PROCESS | 1665 | RSS: Main: 305475584 14:31:37 INFO - PROCESS | 1665 | 14:31:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 14:31:41 INFO - PROCESS | 1665 | RSS: Main: 392323072 14:31:41 INFO - PROCESS | 1665 | 14:31:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 14:31:44 INFO - PROCESS | 1665 | RSS: Main: 292950016 14:31:44 INFO - PROCESS | 1665 | 14:31:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:47 INFO - PROCESS | 1665 | RSS: Main: 297099264 14:31:47 INFO - PROCESS | 1665 | 14:31:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:50 INFO - PROCESS | 1665 | RSS: Main: 334249984 14:31:50 INFO - PROCESS | 1665 | 14:31:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:53 INFO - PROCESS | 1665 | RSS: Main: 334614528 14:31:53 INFO - PROCESS | 1665 | 14:31:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 14:31:57 INFO - PROCESS | 1665 | RSS: Main: 335224832 14:31:57 INFO - PROCESS | 1665 | 14:31:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:59 INFO - PROCESS | 1665 | RSS: Main: 312406016 14:31:59 INFO - PROCESS | 1665 | 14:32:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:32:01 INFO - PROCESS | 1665 | RSS: Main: 320008192 14:32:01 INFO - PROCESS | 1665 | 14:32:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:32:04 INFO - PROCESS | 1665 | RSS: Main: 322449408 14:32:04 INFO - PROCESS | 1665 | 14:32:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:32:08 INFO - PROCESS | 1665 | RSS: Main: 327016448 14:32:08 INFO - PROCESS | 1665 | 14:32:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:32:11 INFO - PROCESS | 1665 | RSS: Main: 329252864 14:32:11 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 14:32:13 INFO - PROCESS | 1665 | RSS: Main: 372830208 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | __start_tp_report 14:32:13 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 14:32:13 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 14:32:13 INFO - PROCESS | 1665 | |i|pagename|runs| 14:32:13 INFO - PROCESS | 1665 | |0;ai-astar;101;114;114;113;113;114;113;112;112;111 14:32:13 INFO - PROCESS | 1665 | |1;audio-beat-detection;145;109;104;161;106;105;129;109;137;107 14:32:13 INFO - PROCESS | 1665 | |2;audio-dft;182;185;182;181;182;185;180;181;185;183 14:32:13 INFO - PROCESS | 1665 | |3;audio-fft;78;73;57;107;82;82;63;64;82;55 14:32:13 INFO - PROCESS | 1665 | |4;audio-oscillator;84;87;93;71;70;68;96;85;97;135 14:32:13 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;87;83;88;88;87;84;87;85;94;83 14:32:13 INFO - PROCESS | 1665 | |6;imaging-darkroom;101;93;92;94;92;94;93;92;93;92 14:32:13 INFO - PROCESS | 1665 | |7;imaging-desaturate;84;87;84;85;82;84;83;86;83;83 14:32:13 INFO - PROCESS | 1665 | |8;json-parse-financial;55;51;50;52;53;52;51;50;50;51 14:32:13 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;67;72;84;76;73;73;71;71;71;73 14:32:13 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;84;81;86;84;84;83;77;84;83;86 14:32:13 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;147;146;148;136;137;151;129;140;246;136 14:32:13 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;163;163;162;164;165;166;162;161;165;161 14:32:13 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;65;67;67;67;67;67;67;66;67;66 14:32:13 INFO - PROCESS | 1665 | __end_tp_report 14:32:13 INFO - PROCESS | 1665 | __start_cc_report 14:32:13 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2037 14:32:13 INFO - PROCESS | 1665 | __end_cc_report 14:32:13 INFO - PROCESS | 1665 | __startTimestamp1469050333833__endTimestamp 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | ------- Summary: start ------- 14:32:13 INFO - PROCESS | 1665 | Number of tests: 14 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.89 (3.4%) stddev-sans-first:1.05 14:32:13 INFO - PROCESS | 1665 | Values: 101.0 114.0 114.0 113.0 113.0 114.0 113.0 112.0 112.0 111.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:119.00 stddev:20.41 (17.2%) stddev-sans-first:19.75 14:32:13 INFO - PROCESS | 1665 | Values: 145.0 109.0 104.0 161.0 106.0 105.0 129.0 109.0 137.0 107.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:182.60 Median:182.50 stddev:1.84 (1.0%) stddev-sans-first:1.94 14:32:13 INFO - PROCESS | 1665 | Values: 182.0 185.0 182.0 181.0 182.0 185.0 180.0 181.0 185.0 183.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:74.30 Median:75.50 stddev:15.52 (20.6%) stddev-sans-first:16.40 14:32:13 INFO - PROCESS | 1665 | Values: 78.0 73.0 57.0 107.0 82.0 82.0 63.0 64.0 82.0 55.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:86.00 stddev:19.48 (22.6%) stddev-sans-first:20.59 14:32:13 INFO - PROCESS | 1665 | Values: 84.0 87.0 93.0 71.0 70.0 68.0 96.0 85.0 97.0 135.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:3.24 (3.7%) stddev-sans-first:3.43 14:32:13 INFO - PROCESS | 1665 | Values: 87.0 83.0 88.0 88.0 87.0 84.0 87.0 85.0 94.0 83.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:93.00 stddev:2.72 (2.9%) stddev-sans-first:0.83 14:32:13 INFO - PROCESS | 1665 | Values: 101.0 93.0 92.0 94.0 92.0 94.0 93.0 92.0 93.0 92.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:1.52 (1.8%) stddev-sans-first:1.62 14:32:13 INFO - PROCESS | 1665 | Values: 84.0 87.0 84.0 85.0 82.0 84.0 83.0 86.0 83.0 83.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.58 (3.1%) stddev-sans-first:1.05 14:32:13 INFO - PROCESS | 1665 | Values: 55.0 51.0 50.0 52.0 53.0 52.0 51.0 50.0 50.0 51.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:73.00 stddev:4.46 (6.1%) stddev-sans-first:4.15 14:32:13 INFO - PROCESS | 1665 | Values: 67.0 72.0 84.0 76.0 73.0 73.0 71.0 71.0 71.0 73.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:2.62 (3.1%) stddev-sans-first:2.76 14:32:13 INFO - PROCESS | 1665 | Values: 84.0 81.0 86.0 84.0 84.0 83.0 77.0 84.0 83.0 86.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:146.50 stddev:33.87 (23.1%) stddev-sans-first:35.88 14:32:13 INFO - PROCESS | 1665 | Values: 147.0 146.0 148.0 136.0 137.0 151.0 129.0 140.0 246.0 136.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.50 stddev:1.75 (1.1%) stddev-sans-first:1.86 14:32:13 INFO - PROCESS | 1665 | Values: 163.0 163.0 162.0 164.0 165.0 166.0 162.0 161.0 165.0 161.0 14:32:13 INFO - PROCESS | 1665 | 14:32:13 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.44 14:32:13 INFO - PROCESS | 1665 | Values: 65.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 14:32:13 INFO - PROCESS | 1665 | -------- Summary: end -------- 14:32:13 INFO - PROCESS | 1665 | 14:32:14 INFO - TEST-INFO | 1665: exit 0 14:32:14 INFO - TEST-OK | kraken | took 58833ms 14:32:14 INFO - SUITE-END | took 1175s 14:32:14 INFO - Completed test suite (00:19:36) 14:32:14 INFO - javascript benchmark 14:32:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.2037721135534, 3401.5067815166803, 3415.231572896098, 3418.0, 3474.2704032153247, 5683.886322273563, 5739.397363276858, 5747.195392645022, 5814.389489103647, 5834.533237341007, 5786.189933409316, 5794.855128621786, 5892.08672655738, 5919.408059194078, 5923.526117910567, 5157.638965272433, 5218.739063046852, 5232.110541207985, 5245.816396426126, 5361.5978801589845, 5360.624756267063, 5375.569954403658, 5382.8923421531545, 5393.379761327439, 5419.864503387407, 4131.917361652765, 5165.7158856262895, 5204.271402003685, 5216.895662086737, 5250.8687282817855, 5183.092958732244, 5247.23915032322, 5267.47325267474, 5268.973655131738, 5273.789048438058, 5213.921791173136, 5216.165413533854, 5232.607554433433, 5291.391489978663, 5347.0, 5791.913121303184, 5876.08920617305, 5888.5289176865745, 5894.764209431618, 5900.704964751788, 6105.035213715971, 6354.2692590352235, 6361.3638636136475, 6368.745250190033, 6374.012028135647, 6273.309935907047, 6275.7175927082935, 6298.937010629881, 6369.8407539811415, 6375.968120159416, 5991.970040149771, 5994.550408719363, 5997.0404735242155, 5998.670073146019, 6000.279966404059, 6254.405831446005, 6262.624242545462, 6277.027060805583, 6351.55539112267, 6370.1718776558755, 6176.629402235881, 6219.191505104308, 6225.097360882737, 6226.6575338355915, 6226.906596401058, 6336.461400780985, 6352.333005034498, 6364.872702546016, 6369.044643303541, 6376.29860715321, 6112.442689633878, 6179.84550386235, 6255.280642726145, 6280.466160376328, 6310.5267104967315, 6139.995903338765, 6201.596896201732, 6279.591826531261, 6282.654454005074, 6287.622742635456, 5021.874453138701, 5029.321041659402, 5037.0, 5037.974810125926, 5075.289459475676, 4513.255312873404, 4531.478879928784, 4533.682642215079, 4549.226631472658, 4574.702644328175, 5718.714064296852, 5759.539236861041, 5763.88472230553, 5771.220885180531, 5845.824625261249, 6291.622502649856, 6306.148669929593, 6317.684115794192, 6320.652364119926, 6321.778737744249, 5777.6822274775295, 5848.619839710405, 5854.560907931922, 5871.383504732027, 5904.0553511437965, 5338.145896656516, 5442.755076021588, 5444.237806707064, 5494.120940649477, 5498.697571633518, 6289.905651415233, 6375.553711240169, 6376.93623063782, 6383.010633351838, 6389.7763578274535, 5293.258943747801, 6316.968415157895, 6327.683615819283, 6335.90496142549, 6348.746050158126, 4920.40955085392, 5384.326959130109, 6293.622382657055, 6312.968435157794, 6348.873022539431, 6153.692315384303, 6206.441420272016, 6215.347388524321, 6221.0, 6241.563090583615, 6134.325224225421, 6297.1813664223355, 6297.4647154992335, 6309.779157729457, 6311.905321420274, 6078.908816367846, 6173.444390004921, 6200.286966998853, 6218.595791273553, 6222.502199824094, 6137.622145770902, 6142.600730952474, 6144.324124346408, 6162.568620196544, 6195.566310358232, 6140.662263575547, 6144.201253836973, 6149.385061493815, 6169.0, 6177.2587289525545, 6102.809952059306, 6135.049067394561, 6151.292601350902, 6154.0, 6161.260648722182, 5927.31835838884, 6006.0, 6006.879862402815, 6014.849628759316, 6092.299385570716], "value": 5760.591720504584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.7958040493019, 508.7837668990679, 517.5161224255321, 540.2085944091905, 541.3233458177278, 30877.073687789376, 42637.57362426379, 44037.11925761491, 44042.559574404244, 44162.0, 45440.091198176015, 45749.0, 45806.31290530645, 45819.0, 46199.53800461994, 8761.912380876205, 9833.60665573378, 10030.297879148462, 10038.949805250964, 10048.698539043804, 8735.301175905912, 12049.397530123502, 12244.204126731735, 12270.263784172934, 12499.187552809084, 12281.570145044925, 12353.567625133122, 12360.690982725413, 12367.938160309186, 12386.256824590508, 8881.422707524054, 11956.983656389217, 12268.07989400794, 12314.81527777084, 12353.258804471716, 11952.223105498115, 12251.448684809206, 12254.326012069332, 12259.203151795105, 12364.56724014655, 42414.57585424137, 42691.78654106709, 42722.145557088996, 42751.35872961908, 42778.35832462516, 3780.584135745093, 3789.9242015159543, 3811.5807261201244, 4073.307537718595, 4285.357196420562, 32811.50782738261, 33948.49077263843, 34141.829290853384, 34185.14537136567, 34228.82885585581, 3235.7411407087375, 3410.641882602316, 3419.760616756828, 3447.896563103111, 3451.4822776583715, 343762.0, 344464.0, 344786.0, 344917.0, 348012.0, 65114.67442662851, 65476.67261663661, 65507.0, 65622.0, 65635.0, 67747.66126169337, 67970.32029679739, 68544.0, 68777.0, 68874.3112568868, 14391.424343026161, 16199.919000404923, 17189.0, 17225.913870430566, 17265.0, 12015.939920300518, 12262.019038476901, 13062.738745225042, 13251.66870828237, 13330.066895317428, 16896.915515422592, 17422.738658920127, 17441.91279043622, 17465.650686986442, 17496.0, 6671.266160722316, 6734.797956061326, 6816.931830681729, 6841.3842754152365, 6853.211880633791, 854.3976496570027, 942.6276620734772, 1005.7636455432968, 1014.2950649298814, 1091.7325255312498, 30665.0, 31225.21936951549, 31265.687343126734, 31879.0, 32021.039368818972, 1050.3960222871726, 1073.2755390111643, 1116.9609063682733, 1133.920625556203, 1170.9355985420714, 15993.36026558948, 16302.266398011881, 16366.018038917702, 16366.836331636769, 16648.500544983668, 699741.0, 704204.0, 706580.0, 712054.0, 712481.0, 63095.36904630895, 63186.684066580296, 63237.36762632407, 63333.36666633367, 63343.366566333745, 1261.829652996852, 1398.5594537720585, 1411.498917884157, 1434.7058852935331, 1434.9139051656934, 31472.0, 32408.35183296368, 32636.0, 32996.34007319888, 33252.83373583117, 48650.270245945634, 53400.198997015854, 53740.462595373545, 53913.460865392415, 53950.73024634852, 516214.0, 586632.0, 595547.0, 595627.2405017766, 597012.0, 29989.250268743457, 36967.075823104635, 41822.0, 42472.36291455692, 46139.30791038204, 50380.0, 50417.74791126168, 50768.23847642362, 51480.0, 51922.0, 39780.20439591134, 40880.0, 41326.79336603298, 42047.789761051, 43199.784001079795, 41763.7911810439, 41804.372934406616, 41909.371359430246, 42313.519026833914, 43111.84440778011, 39665.0, 40349.39475907922, 40942.567010154504, 41046.79476602598, 41067.383989239584, 34780.82609586936, 35845.28309433744, 36592.45111323279, 36620.81689591535, 36912.630873692, 21671.783282166976, 25894.223173304832, 26211.868940655175, 26783.196504104908, 27013.729862701122], "value": 21290.185852810682, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7538398505033, 374.6366024955794, 377.8771899132782, 388.8877809464931, 410.42335518596366, 14721.926390368046, 15551.688966220669, 20758.0, 21147.682784758243, 21185.258515951944, 20400.89799551004, 20508.69236961443, 20819.375418737425, 20861.47846303843, 20866.165353385848, 5829.533637309016, 5859.501942334907, 6081.179040829497, 6089.360617135203, 6089.573729838913, 6002.0, 6153.692315384235, 6154.876902461948, 6160.2915664698685, 6168.907466388007, 6063.6361818290825, 6148.600340977844, 6163.7226324815265, 6733.461323094165, 6794.626295553742, 6576.835579110512, 6829.863402731968, 6833.794986150423, 6835.726570937181, 6843.692033858513, 4970.353853998993, 5930.673812940287, 5935.080062590306, 5943.078822782432, 5957.225560677128, 13294.0, 13331.933340333333, 13370.0, 13524.120932139478, 13565.932170339183, 2193.890305484719, 2485.0, 2972.4055188962293, 2981.5378616314506, 3060.693930606944, 9954.153896918771, 10047.899521004769, 10433.16534677224, 10452.216083793746, 10470.371777693363, 1804.7563578916809, 1834.4129878438905, 1862.8602854785809, 1901.5531350132708, 1964.312490628283, 117392.0, 130730.0, 131812.0, 132123.0, 132946.335268324, 11344.886551134548, 11377.431128443544, 11558.422078896021, 11569.0, 11798.233114847679, 14588.635284117981, 14617.634559136106, 14621.415143394357, 14631.341589628491, 14646.194459304841, 8406.117357677478, 8542.658293668308, 8553.23020928107, 8575.914240857512, 8682.652693892174, 8562.0, 8581.313494920392, 8591.269742071994, 8738.86891696625, 8741.0, 4500.729956202638, 4507.752073635981, 4514.977425112854, 4515.841945531956, 4589.2886602576655, 1877.6338613970418, 1923.2307077168964, 1926.2391355414813, 1926.8651194416257, 1934.4970307719814, 888.2583043158905, 894.7852515396258, 940.4780346907532, 979.7256768104942, 998.4708104704519, 19899.900500497406, 21159.471013224793, 21254.78745212528, 21389.037493312528, 21506.677399839016, 827.6027506796771, 891.7859713668803, 905.2757793764962, 954.8281309364243, 966.5698764050071, 9001.63993440255, 9953.552090155961, 11154.274972126786, 11202.831957520644, 11250.0, 625015.0, 635306.0, 635848.0, 642071.0, 644688.0, 94805.0, 125190.0, 132833.0, 135076.0, 141188.0, 965.4689920543673, 996.7657600463886, 1018.9439580823274, 1045.095991966943, 1047.319242492371, 18469.53826154357, 18948.810511894706, 19017.714734279274, 19021.90489047546, 19138.598615658488, 52638.73680631573, 58370.4162958365, 58753.4124658748, 60611.0, 61315.693421532604, 76485.0, 87364.1263587356, 89407.55296223477, 91777.62333565135, 91821.54089229512, 7955.562444065632, 8008.171603677175, 8131.227533384319, 8136.349092072502, 8345.499270043816, 11376.653960524649, 12645.936770316457, 13113.606591802261, 13130.015248856183, 13142.474301027853, 10966.506507207354, 11247.906825622691, 11272.66182014541, 11400.600978965696, 11421.857814218512, 10003.699889003341, 10937.56249750001, 11231.775364492827, 11269.985701286923, 11356.0, 9968.0, 11067.335959842436, 11109.944450277697, 11420.371879546705, 11490.425478726198, 6612.335064779972, 7786.0, 8044.83910321802, 8182.099969003524, 8268.545230012407, 9955.701328960144, 10832.079273261546, 11136.832947505956, 11197.0, 11263.436828158723], "value": 9605.116523883122, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.468538354268, 1574.1499590221279, 1758.4021432712882, 1871.93448229312, 1895.327158858606, 8604.784880377985, 9050.27597792176, 9051.0, 9051.63793448263, 9055.547222638857, 7930.643121059552, 8110.026796784379, 8638.352123590741, 8847.690330838406, 8877.0, 2390.3426557696644, 2411.1560953666253, 2414.167112346238, 2415.9516809663796, 2425.563398588253, 2378.47673511828, 2382.9761702383016, 2423.218934083456, 2423.51529694061, 2428.9271321860374, 2100.8109270165683, 2333.9066437342485, 2388.4028992751814, 2397.6643269942224, 2398.37642213025, 2288.3135059482174, 2302.2977991712687, 2307.757685443038, 2313.086330899302, 2314.722233331994, 2361.8700971446565, 2390.952180956371, 2395.3053614451787, 2397.5924092904247, 2402.6756387887585, 9120.179183873417, 9162.770930726718, 9176.128267814614, 9180.632774689004, 9198.770030749218, 4683.765811709401, 5186.5850731941355, 5391.892162156735, 5396.244525766396, 5405.054115529767, 3148.763842711806, 3446.4141096013486, 3511.490833829106, 3652.4156135018534, 3663.5420572428447, 1092.2627226621998, 1097.6663354024818, 1100.4772732951865, 1115.4813011949482, 1120.5685810962839, 11618.128640352008, 11829.112816538795, 11841.23032002917, 11853.703657408547, 11894.345810980392, 4604.815807367735, 4646.4191976003, 4802.087603355351, 4820.855374338776, 4822.758862056883, 10006.049425304584, 10007.749806254902, 10024.699259022242, 10040.849387259197, 10045.79908401828, 5372.221027950925, 5373.811916582901, 5379.865503362369, 5382.757775900016, 5396.217548455452, 3917.804109794556, 4398.802053907518, 4565.246734288805, 4876.634252431082, 4916.8770780730765, 3347.6317605063423, 3918.7648741075627, 4037.7779222142476, 4076.490438695163, 4090.877273681794, 1295.6242689619905, 1304.6673098360047, 1307.607717684691, 1323.232525135419, 1324.3576865220361, 815.983680326402, 824.8474032304043, 927.1284992107397, 942.9203561921698, 991.2466525440573, 5841.0, 5852.0, 5986.221791167208, 6004.399560044048, 6178.938210617926, 453.4830293465452, 461.9630429565627, 474.810075969608, 475.10917030567686, 475.9428868535729, 3873.8063096845044, 4041.777702226406, 4073.279287871572, 4089.2434899543678, 4115.814788334532, 10555.10281626055, 10789.946050269855, 10925.235233533735, 10940.070094042096, 10943.398113103696, 10861.1854110942, 10870.94564527188, 10871.347719136877, 10879.891201088047, 10888.455577221108, 8091.676332946734, 8176.46852954556, 8356.665733370719, 8392.28665563434, 8407.873881891654, 5783.363829978614, 5814.825555233349, 5866.911996319973, 5922.585419020627, 5943.910841337297, 9941.0, 10121.645742398981, 10205.285630005828, 10240.078392944672, 10259.435731034864, 9824.754381140528, 10187.13409360183, 10203.897961020592, 10349.74125646865, 10369.325993810378, 7035.226125126334, 7283.963580182065, 7449.664765085476, 7690.154083050748, 7888.408369372435, 8320.916790832256, 8640.524771137396, 8650.740477785677, 8654.22112009922, 8656.26421754158, 6367.42693157618, 7594.430417718803, 7601.239876012354, 7692.807679808049, 7717.2668596483245, 7423.703051877865, 7458.328750412489, 7467.029286192977, 7578.166401695698, 7669.386449083949, 6998.895016574654, 7171.49799514029, 7178.282171782989, 7180.281971802778, 7183.712651493882, 4950.421381058461, 5074.695518268915, 5133.666311689728, 5148.742562871917, 5162.741862906764, 5027.899442011212, 5027.974860125676, 5152.330197074356, 5180.792768289226, 5327.227552005015], "value": 4554.690943447839, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.30847630117785, 305.33894119231866, 318.1426056776986, 324.9951250731238, 328.367891808269, 5380.192971054339, 5408.783648654054, 5431.343440250722, 5478.397376288605, 5479.53423958964, 5042.697438153713, 5148.0, 5329.786808527664, 5374.516293533581, 5455.208994695767, 3658.9817050914708, 3876.341022026262, 4099.0, 4104.21466662003, 4167.916641667165, 3475.582930048398, 4075.6535694466006, 4118.299889018874, 4167.791610419466, 4171.979140104295, 3234.3181545596276, 4041.009952561612, 4121.773302468363, 4133.0, 4137.13120244749, 4072.9389059164137, 4089.5092588889224, 4092.386142078682, 4097.221527909687, 4117.94992276969, 3092.721655051034, 3536.6286539913194, 3537.6816086552076, 3541.6281290464644, 3564.697000754939, 4371.759553224571, 5311.867203319909, 5343.332083489564, 5346.732663366816, 5374.408815030382, 4368.170047690928, 4654.348391225231, 4676.953230467686, 4695.929561056552, 4699.365585645928, 4588.466880501995, 4879.414470263591, 5703.771849126071, 5728.914066289009, 5729.942700572982, 3425.520427140202, 3870.9225815483533, 3872.206197729459, 3882.4758657581147, 3905.7265991380614, 4831.396075490564, 5161.974190129063, 5955.52355811534, 5956.0, 5965.642061476326, 3460.1522626956557, 3902.3561112416132, 3917.4515567820526, 3921.3529767588598, 3922.9800251934703, 3940.408938659224, 3951.9012024699036, 3956.9802150989062, 3972.212504373044, 4010.7192496524963, 3950.802459877052, 4212.978935105305, 4329.956700433018, 4654.697444666086, 4670.9766451167525, 5728.169415434739, 5728.341240757283, 5729.656220626775, 5732.512736417451, 5754.625949313281, 1279.8272233248392, 1338.2505796753849, 1359.6872719274622, 1360.911540749868, 1368.438940034601, 718.7664009197032, 757.4167890724111, 846.8679800409537, 877.9517126557973, 880.0143838900473, 4286.764227967492, 4291.527931927485, 4383.627391671744, 4385.802638881258, 4398.328635118634, 4430.556944305544, 4888.802243450377, 4904.8773780655765, 4922.0, 4924.9507504925205, 4168.416421700964, 4177.767558570229, 4298.591633794785, 4520.784815440411, 4525.615322697542, 2229.4983628683417, 2566.268613445159, 2587.301428614301, 3052.138195700621, 3107.704768047032, 5380.166074258496, 5602.327720673464, 6017.398260173947, 6024.759009639653, 6070.3929607038945, 4953.826616068421, 5136.101182293084, 5159.742012899415, 5474.153440211147, 5997.850053748692, 6002.309734380602, 6030.0, 6035.336113027563, 6045.939540604538, 6064.878702425926, 5847.356790753099, 5854.214464588342, 5924.289085309791, 5936.643801371932, 5940.188447357654, 4857.551138691569, 5543.972280138573, 5811.0, 5840.386759390372, 5844.327902291291, 5329.081530648886, 6037.09443583466, 6045.727942242522, 6056.273247210363, 6058.84852878664, 3947.565767765601, 3971.3447281199433, 3984.322665146874, 3986.6412022918075, 3995.380715989026, 5592.440755924537, 5646.548276137982, 5842.0, 5858.853528661817, 5888.0, 4668.719876807402, 4765.928511072406, 5560.944390556043, 5581.358143813513, 5738.512226460798, 5724.255846739898, 5759.568032397503, 5761.983305842921, 5809.186713859978, 5818.418158184317, 5296.523312901703, 5338.839834804962, 5535.612507124462, 5575.804846830341, 5605.5515558756015, 5234.005538947587, 5708.571857110816, 5731.595759039062, 5733.512651424676, 5744.4829965303325, 4657.0, 5541.722913854372, 5587.664740115606, 5599.748011339581, 5650.519705825051], "value": 4076.6132217023037, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.2375553180223, 741.5624781378986, 746.3357611725564, 788.9842203155937, 833.9457935234209, 15002.174880381588, 16115.516534503955, 16150.75773863393, 16154.273057712402, 16173.19134043296, 13606.863931360684, 13689.247091409969, 13701.246431446267, 13709.314534273271, 14086.859131408683, 726.1612837173047, 749.4828568287891, 895.0020726889504, 917.7200953709133, 920.5765347939956, 917.8485549884294, 927.188709878856, 931.6599441203946, 933.1834644685899, 933.6358820060182, 985.871836661233, 987.3384832162468, 987.9506024698736, 988.332875309167, 991.9702408927744, 979.0796651147898, 980.789130336981, 981.9263555233315, 984.3798407003578, 985.1626117799849, 582.1006544888158, 724.1129616220088, 738.6712912753827, 743.8177646476648, 744.888266759985, 15042.172680502568, 15084.39662413502, 15084.39662413502, 15114.168720720467, 15121.546353609408, 13846.792298115537, 14106.85893141076, 14187.645308867257, 14231.715365692731, 14285.428582856674, 11306.660800176009, 11719.472623731952, 11733.354665493394, 12778.680532986657, 13381.330933453288, 3843.404272337792, 4561.612262957653, 4646.303054541812, 4759.643026772971, 4799.544043315879, 99488.50255748675, 101553.98446015519, 102553.48723256336, 108860.36709449365, 109131.0, 11003.779924401468, 11158.107351411867, 11162.888371116185, 11238.38188899602, 11622.94188529052, 22334.0, 22423.77576224217, 22466.550668986856, 22473.55052898933, 22703.432414189778, 8120.228578285053, 8127.2279133482225, 8151.429399941947, 8213.79465513367, 8400.579971001425, 4523.660725445605, 4661.95338046622, 4710.3405523226775, 4797.736124513185, 4802.447718512346, 3482.564679415073, 3578.4453409721013, 3580.445031020196, 3582.0686621478603, 3584.1039740064984, 633.4932054356497, 645.2998496631208, 651.133991790917, 661.0744957060155, 661.1834384535096, 603.7584966013629, 677.9254282028973, 699.860027994393, 708.1537562612629, 718.3678363040596, 8239.299659529008, 9254.537273136451, 9932.553035113437, 10006.899931000742, 10052.798944021224, 593.2021431175062, 604.4529700620946, 624.687656171914, 675.0427477510888, 694.6804469943781, 4512.661550383735, 4566.566176213254, 4628.837990670378, 4637.0, 4718.952810471851, 89714.55142724376, 91664.0, 92427.0, 154227.0, 154952.22523887534, 130959.34520327338, 133863.0, 135290.0, 137028.31485842506, 138274.0, 74939.0, 101321.0, 110307.44846275878, 114815.0, 115970.42014789872, 8543.188397102265, 8552.444091134057, 8903.73288801337, 8956.529084124657, 9174.0, 57196.0, 58463.12305315339, 60390.69804650949, 60451.09323360065, 61400.0, 87752.1224787744, 93448.53275733578, 93804.53097734468, 94244.52877735568, 94533.75887087335, 11847.348395838311, 12195.634130976085, 12501.374931253218, 12673.493060277486, 12714.237145771283, 13511.932440337736, 13547.458101675822, 13637.24995125238, 13931.373088210852, 14009.579712608638, 12704.682382940131, 12799.680007999874, 12831.422585983466, 12849.550265740654, 13224.206547607175, 11100.888991110309, 13861.514846980308, 14211.786823197453, 14219.360128794022, 14637.560873173821, 13601.115927464683, 14215.0, 14236.217008064656, 14253.216073116078, 14411.495597654452, 10712.035286704524, 11115.88884111181, 11354.205205635526, 11469.254498457574, 11471.713207169887, 8613.612387442456, 8644.481331120152, 9436.197923176607, 10753.0, 11270.83093753578], "value": 7865.664108324558, "unit": "score"}], "name": "dromaeo_css", "value": 7457.878139367779, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 112.0, 112.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 104.0, 161.0, 106.0, 105.0, 129.0, 109.0, 137.0, 107.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 182.0, 181.0, 182.0, 185.0, 180.0, 181.0, 185.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 57.0, 107.0, 82.0, 82.0, 63.0, 64.0, 82.0, 55.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 93.0, 71.0, 70.0, 68.0, 96.0, 85.0, 97.0, 135.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 88.0, 88.0, 87.0, 84.0, 87.0, 85.0, 94.0, 83.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 93.0, 92.0, 94.0, 92.0, 94.0, 93.0, 92.0, 93.0, 92.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 84.0, 85.0, 82.0, 84.0, 83.0, 86.0, 83.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 50.0, 52.0, 53.0, 52.0, 51.0, 50.0, 50.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 84.0, 76.0, 73.0, 73.0, 71.0, 71.0, 71.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 86.0, 84.0, 84.0, 83.0, 77.0, 84.0, 83.0, 86.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 136.0, 137.0, 151.0, 129.0, 140.0, 246.0, 136.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 164.0, 165.0, 166.0, 162.0, 161.0, 165.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1431.8999999999999, "alertThreshold": 2.0}]} 14:32:15 INFO - Return code: 0 14:32:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:32:15 INFO - # TBPL SUCCESS # 14:32:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:32:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:32:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:32:15 INFO - 2016-07-20 14:32:15.166 screenresolution[1669:10020] starting screenresolution argv=screenresolution get 14:32:15 INFO - 2016-07-20 14:32:15.169 screenresolution[1669:10020] Display 0: 1600x1200x32@60 14:32:15 INFO - 2016-07-20 14:32:15.175 screenresolution[1670:10023] starting screenresolution argv=screenresolution list 14:32:15 INFO - Available Modes on Display 0 14:32:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:32:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:32:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:32:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:32:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:32:15 INFO - Intel Iris: 14:32:15 INFO - Chipset Model: Intel Iris 14:32:15 INFO - Type: GPU 14:32:15 INFO - Bus: Built-In 14:32:15 INFO - VRAM (Dynamic, Max): 1536 MB 14:32:15 INFO - Vendor: Intel (0x8086) 14:32:15 INFO - Device ID: 0x0a2e 14:32:15 INFO - Revision ID: 0x0009 14:32:15 INFO - Displays: 14:32:15 INFO - Display: 14:32:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:32:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:32:15 INFO - Display Serial Number: 1600x1200 60 14:32:15 INFO - Main Display: Yes 14:32:15 INFO - Mirror: Off 14:32:15 INFO - Online: Yes 14:32:15 INFO - Rotation: Supported 14:32:15 INFO - Return code: 0 14:32:15 INFO - Running post-action listener: _resource_record_post_action 14:32:15 INFO - [mozharness: 2016-07-20 21:32:15.409348Z] Finished run-tests step (success) 14:32:15 INFO - Running post-run listener: _resource_record_post_run 14:32:15 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38183936; Write bytes: 706390016; Read time: 385; Write time: 1956 14:32:15 INFO - TinderboxPrint: CPU usage
53.6% 14:32:15 INFO - TinderboxPrint: I/O read bytes / time
38,183,936 / 385 14:32:15 INFO - TinderboxPrint: I/O write bytes / time
706,390,016 / 1,956 14:32:15 INFO - TinderboxPrint: CPU idle
2,248.9 (46.4%) 14:32:15 INFO - TinderboxPrint: CPU system
964.4 (19.9%) 14:32:15 INFO - TinderboxPrint: CPU user
1,628.4 (33.6%) 14:32:15 INFO - TinderboxPrint: Swap in / out
446,144,512 / 0 14:32:15 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401715712; Write bytes: 396768768; Read time: 29581; Write time: 749 14:32:15 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36086784; Write bytes: 293872128; Read time: 362; Write time: 1172 14:32:15 INFO - Running post-run listener: _upload_blobber_files 14:32:15 INFO - Blob upload gear active. 14:32:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:15 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 14:32:15 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:32:15 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:32:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:16 INFO - (blobuploader) - INFO - Done attempting. 14:32:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:17 INFO - (blobuploader) - INFO - Done attempting. 14:32:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:21 INFO - (blobuploader) - INFO - Done attempting. 14:32:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:21 INFO - Return code: 0 14:32:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/caffdddba158d3226d4dec1dba7b0be14d4bf314c43e303a9ffd45b1d44e38fa86218bd9f4237b90d295e0d148b860f15ad8aa641ba1c5a3f5fe697ef7254314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a2153d0aeb821963544ca16f92a49153ebd0dd67e1d6477fa5cbd05e35cbad6990638be76bb6ac2ab06d1c1eef39571d79171d083f114d8f86ccf10f5992aa2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/50b298d3ffa7c01ec83488a2dbe3ecf089849548b58088540be4dc4353c471b8a67a4ae7beea218d6bf5536121af405f6beb652c9c95b2bda7d59b5f2b5d7924"} 14:32:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:21 INFO - Contents: 14:32:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/caffdddba158d3226d4dec1dba7b0be14d4bf314c43e303a9ffd45b1d44e38fa86218bd9f4237b90d295e0d148b860f15ad8aa641ba1c5a3f5fe697ef7254314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a2153d0aeb821963544ca16f92a49153ebd0dd67e1d6477fa5cbd05e35cbad6990638be76bb6ac2ab06d1c1eef39571d79171d083f114d8f86ccf10f5992aa2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/50b298d3ffa7c01ec83488a2dbe3ecf089849548b58088540be4dc4353c471b8a67a4ae7beea218d6bf5536121af405f6beb652c9c95b2bda7d59b5f2b5d7924"} 14:32:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:21 INFO - Copying logs to upload dir... 14:32:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.159729 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-20 14:32:21.119259) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:32:21.123544) ========= 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.zCtrALtKLL/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.6HGMr6sbp2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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/Autoland/sha512/caffdddba158d3226d4dec1dba7b0be14d4bf314c43e303a9ffd45b1d44e38fa86218bd9f4237b90d295e0d148b860f15ad8aa641ba1c5a3f5fe697ef7254314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a2153d0aeb821963544ca16f92a49153ebd0dd67e1d6477fa5cbd05e35cbad6990638be76bb6ac2ab06d1c1eef39571d79171d083f114d8f86ccf10f5992aa2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/50b298d3ffa7c01ec83488a2dbe3ecf089849548b58088540be4dc4353c471b8a67a4ae7beea218d6bf5536121af405f6beb652c9c95b2bda7d59b5f2b5d7924"} build_url:https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010978 build_url: 'https://queue.taskcluster.net/v1/task/LyRDJ_BRR2qLpg7uK0MZ0g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/caffdddba158d3226d4dec1dba7b0be14d4bf314c43e303a9ffd45b1d44e38fa86218bd9f4237b90d295e0d148b860f15ad8aa641ba1c5a3f5fe697ef7254314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a2153d0aeb821963544ca16f92a49153ebd0dd67e1d6477fa5cbd05e35cbad6990638be76bb6ac2ab06d1c1eef39571d79171d083f114d8f86ccf10f5992aa2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/50b298d3ffa7c01ec83488a2dbe3ecf089849548b58088540be4dc4353c471b8a67a4ae7beea218d6bf5536121af405f6beb652c9c95b2bda7d59b5f2b5d7924"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:32:21.157196) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:32:21.157544) ========= 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.zCtrALtKLL/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.6HGMr6sbp2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.005112 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:32:21.207313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:32:21.207625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:32:21.208013) ========= ========= Total master_lag: 0.17 =========