builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0292 starttime: 1474668912.0 results: success (0) buildid: 20160923131224 builduid: ca9f2d706c9b4d1ebac51fe26f81313c revision: a8254e91e0fed9395c238d5b60867c7907fa261a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.004985) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.005403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.005677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.056756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.057186) ========= 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.TRoHYpYqkA/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.BayZ1M26l9/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-09-23 15:15:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 207M=0s 2016-09-23 15:15:12 (207 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.471620 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.580783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.581206) ========= 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.TRoHYpYqkA/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.BayZ1M26l9/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.026018 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:12.659895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 15:15:12.660255) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a8254e91e0fed9395c238d5b60867c7907fa261a --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 a8254e91e0fed9395c238d5b60867c7907fa261a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TRoHYpYqkA/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.BayZ1M26l9/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-09-23 15:15:12,748 truncating revision to first 12 chars 2016-09-23 15:15:12,749 Setting DEBUG logging. 2016-09-23 15:15:12,749 attempt 1/10 2016-09-23 15:15:12,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a8254e91e0fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 15:15:13,925 unpacking tar archive at: autoland-a8254e91e0fe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.440210 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 15:15:14.123700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:14.125978) ========= script_repo_revision: a8254e91e0fed9395c238d5b60867c7907fa261a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:14.126390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:14.126658) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 15:15:14.146344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-23 15:15:14.146719) ========= /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.TRoHYpYqkA/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.BayZ1M26l9/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:14 INFO - MultiFileLogger online at 20160923 15:15:14 in /builds/slave/test 15:15:14 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 15:15:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:14 INFO - {'append_to_log': False, 15:15:14 INFO - 'base_work_dir': '/builds/slave/test', 15:15:14 INFO - 'blob_upload_branch': 'Autoland', 15:15:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:14 INFO - 'branch': 'Autoland', 15:15:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:14 INFO - 'config_files': ('talos/mac_config.py',), 15:15:14 INFO - 'default_actions': ('clobber', 15:15:14 INFO - 'read-buildbot-config', 15:15:14 INFO - 'download-and-extract', 15:15:14 INFO - 'populate-webroot', 15:15:14 INFO - 'create-virtualenv', 15:15:14 INFO - 'install', 15:15:14 INFO - 'run-tests'), 15:15:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:14 INFO - 'download_minidump_stackwalk': True, 15:15:14 INFO - 'download_symbols': 'ondemand', 15:15:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:14 INFO - 'installer_path': 'installer.exe', 15:15:14 INFO - 'log_level': 'info', 15:15:14 INFO - 'log_name': 'talos', 15:15:14 INFO - 'log_to_console': True, 15:15:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:15:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:15:14 INFO - 'opt_config_files': (), 15:15:14 INFO - 'pip_index': False, 15:15:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:14 INFO - 'cmd': ('bash', 15:15:14 INFO - '-c', 15:15:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:14 INFO - 'enabled': True, 15:15:14 INFO - 'halt_on_failure': False, 15:15:14 INFO - 'name': 'check_screen_resolution'},), 15:15:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:14 INFO - 'cmd': ('bash', 15:15:14 INFO - '-c', 15:15:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:14 INFO - 'enabled': True, 15:15:14 INFO - 'halt_on_failure': False, 15:15:14 INFO - 'name': 'check_screen_resolution'},), 15:15:14 INFO - 'run_cmd_checks_enabled': True, 15:15:14 INFO - 'sps_profile': False, 15:15:14 INFO - 'sps_profile_interval': 0, 15:15:14 INFO - 'suite': 'dromaeojs', 15:15:14 INFO - 'system_bits': '32', 15:15:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:14 INFO - 'title': 't-yosemite-r7-0292', 15:15:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:14 INFO - 'use_talos_json': True, 15:15:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:14 INFO - 'work_dir': 'build'} 15:15:14 INFO - [mozharness: 2016-09-23 22:15:14.368555Z] Running clobber step. 15:15:14 INFO - Running pre-action listener: _resource_record_pre_action 15:15:14 INFO - Running main action method: clobber 15:15:14 INFO - rmtree: /builds/slave/test/build 15:15:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:16 INFO - Running post-action listener: _resource_record_post_action 15:15:16 INFO - [mozharness: 2016-09-23 22:15:16.456773Z] Finished clobber step (success) 15:15:16 INFO - [mozharness: 2016-09-23 22:15:16.456894Z] Running read-buildbot-config step. 15:15:16 INFO - Running pre-action listener: _resource_record_pre_action 15:15:16 INFO - Running main action method: read_buildbot_config 15:15:16 INFO - Using buildbot properties: 15:15:16 INFO - { 15:15:16 INFO - "project": "", 15:15:16 INFO - "product": "firefox", 15:15:16 INFO - "script_repo_revision": "production", 15:15:16 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 15:15:16 INFO - "repository": "", 15:15:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 15:15:16 INFO - "buildid": "20160923131224", 15:15:16 INFO - "pgo_build": "False", 15:15:16 INFO - "basedir": "/builds/slave/test", 15:15:16 INFO - "buildnumber": 279, 15:15:16 INFO - "slavename": "t-yosemite-r7-0292", 15:15:16 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:15:16 INFO - "platform": "yosemite_r7", 15:15:16 INFO - "scheduler": "tests-autoland-macosx64-talos", 15:15:16 INFO - "branch": "autoland", 15:15:16 INFO - "repo_path": "integration/autoland", 15:15:16 INFO - "revision": "a8254e91e0fed9395c238d5b60867c7907fa261a", 15:15:16 INFO - "stage_platform": "macosx64", 15:15:16 INFO - "builduid": "ca9f2d706c9b4d1ebac51fe26f81313c", 15:15:16 INFO - "slavebuilddir": "test" 15:15:16 INFO - } 15:15:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:15:16 INFO - Running post-action listener: _resource_record_post_action 15:15:16 INFO - [mozharness: 2016-09-23 22:15:16.460184Z] Finished read-buildbot-config step (success) 15:15:16 INFO - [mozharness: 2016-09-23 22:15:16.460292Z] Running download-and-extract step. 15:15:16 INFO - Running pre-action listener: _resource_record_pre_action 15:15:16 INFO - Running main action method: download_and_extract 15:15:16 INFO - mkdir: /builds/slave/test/build/tests 15:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:16 INFO - trying https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:15:16 INFO - Downloading https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 15:15:17 INFO - Downloaded 1199 bytes. 15:15:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:15:17 INFO - Using the following test package requirements: 15:15:17 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:15:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:15:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:15:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'jsshell-mac.zip'], 15:15:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:15:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:15:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:15:17 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:15:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:15:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:17 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:15:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:15:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:15:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:15:17 INFO - Fetch https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:15:18 INFO - Expected file size: 16438923 15:15:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:15:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:15:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:15:25 INFO - Fetch https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:15:25 INFO - Expected file size: 16438923 15:15:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:15:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:15:32 INFO - Fetch https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:15:33 INFO - Expected file size: 14414059 15:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:33 INFO - trying https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:15:33 INFO - Downloading https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 15:15:36 INFO - Downloaded 111580872 bytes. 15:15:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:15:36 INFO - mkdir: /builds/slave/test/properties 15:15:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:36 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:36 INFO - Contents: 15:15:36 INFO - build_url:https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:15:37 INFO - Running post-action listener: _resource_record_post_action 15:15:37 INFO - Running post-action listener: set_extra_try_arguments 15:15:37 INFO - [mozharness: 2016-09-23 22:15:37.396967Z] Finished download-and-extract step (success) 15:15:37 INFO - [mozharness: 2016-09-23 22:15:37.397098Z] Running populate-webroot step. 15:15:37 INFO - Running pre-action listener: _resource_record_pre_action 15:15:37 INFO - Running main action method: populate_webroot 15:15:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:15:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:15:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:15:37 INFO - '--tppagecycles', 15:15:37 INFO - '7'], 15:15:37 INFO - 'tests': ['tsvgm']}}, 15:15:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:15:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:15:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:15:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:15:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['damp', 'tps']}, 15:15:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'tests': ['damp', 'tps']}, 15:15:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['dromaeo_dom']}, 15:15:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['basic_compositor_video']}, 15:15:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:15:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['a11yr', 15:15:37 INFO - 'ts_paint', 15:15:37 INFO - 'tpaint', 15:15:37 INFO - 'sessionrestore', 15:15:37 INFO - 'sessionrestore_no_auto_restore', 15:15:37 INFO - 'tabpaint']}, 15:15:37 INFO - 'other-e10s': {'tests': ['a11yr', 15:15:37 INFO - 'ts_paint', 15:15:37 INFO - 'tpaint', 15:15:37 INFO - 'sessionrestore', 15:15:37 INFO - 'sessionrestore_no_auto_restore', 15:15:37 INFO - 'tabpaint']}, 15:15:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:15:37 INFO - 'ts_paint', 15:15:37 INFO - 'tpaint', 15:15:37 INFO - 'sessionrestore', 15:15:37 INFO - 'sessionrestore_no_auto_restore', 15:15:37 INFO - 'tabpaint']}, 15:15:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:15:37 INFO - 'ts_paint', 15:15:37 INFO - 'tpaint', 15:15:37 INFO - 'sessionrestore', 15:15:37 INFO - 'sessionrestore_no_auto_restore', 15:15:37 INFO - 'tabpaint']}, 15:15:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['a11yr', 15:15:37 INFO - 'ts_paint', 15:15:37 INFO - 'tpaint', 15:15:37 INFO - 'sessionrestore', 15:15:37 INFO - 'sessionrestore_no_auto_restore', 15:15:37 INFO - 'tabpaint']}, 15:15:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['a11yr', 15:15:37 INFO - 'ts_paint', 15:15:37 INFO - 'tpaint', 15:15:37 INFO - 'sessionrestore', 15:15:37 INFO - 'sessionrestore_no_auto_restore', 15:15:37 INFO - 'tabpaint']}, 15:15:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['tsvgx', 15:15:37 INFO - 'tsvgr_opacity', 15:15:37 INFO - 'tart', 15:15:37 INFO - 'tscrollx', 15:15:37 INFO - 'cart']}, 15:15:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:15:37 INFO - 'tsvgr_opacity', 15:15:37 INFO - 'tart', 15:15:37 INFO - 'tscrollx', 15:15:37 INFO - 'cart']}, 15:15:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'talos_options': ['--disable-e10s'], 15:15:37 INFO - 'tests': ['tp5o']}, 15:15:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'tests': ['tp5o']}, 15:15:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'talos_options': ['--disable-e10s', 15:15:37 INFO - '--xperf_path', 15:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:37 INFO - 'tests': ['tp5n']}, 15:15:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:37 INFO - 'talos_options': ['--xperf_path', 15:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:37 INFO - 'tests': ['tp5n']}}, 15:15:37 INFO - 'talos.zip': {'path': '', 15:15:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:15:37 INFO - Running post-action listener: _resource_record_post_action 15:15:37 INFO - [mozharness: 2016-09-23 22:15:37.416018Z] Finished populate-webroot step (success) 15:15:37 INFO - [mozharness: 2016-09-23 22:15:37.416149Z] Running create-virtualenv step. 15:15:37 INFO - Running pre-action listener: _resource_record_pre_action 15:15:37 INFO - Running main action method: create_virtualenv 15:15:37 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:15:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:37 INFO - Using real prefix '/tools/python27' 15:15:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:41 INFO - Installing pip.................done. 15:15:41 INFO - Return code: 0 15:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:15:41 INFO - Reading from file tmpfile_stdout 15:15:41 INFO - Output received: 15:15:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:15:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:41 INFO - 'HOME': '/Users/cltbld', 15:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:41 INFO - 'LOGNAME': 'cltbld', 15:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:41 INFO - 'MOZ_NO_REMOTE': '1', 15:15:41 INFO - 'NO_EM_RESTART': '1', 15:15:41 INFO - 'PAGER': '/bin/cat', 15:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:41 INFO - 'PWD': '/builds/slave/test', 15:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:41 INFO - 'SHELL': '/bin/bash', 15:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:15:41 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:41 INFO - 'USER': 'cltbld', 15:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:41 INFO - 'XPC_FLAGS': '0x0', 15:15:41 INFO - 'XPC_SERVICE_NAME': '0', 15:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:15:41 INFO - Cleaning up... 15:15:41 INFO - Return code: 0 15:15:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:41 INFO - 'HOME': '/Users/cltbld', 15:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:41 INFO - 'LOGNAME': 'cltbld', 15:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:41 INFO - 'MOZ_NO_REMOTE': '1', 15:15:41 INFO - 'NO_EM_RESTART': '1', 15:15:41 INFO - 'PAGER': '/bin/cat', 15:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:41 INFO - 'PWD': '/builds/slave/test', 15:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:41 INFO - 'SHELL': '/bin/bash', 15:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:15:41 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:41 INFO - 'USER': 'cltbld', 15:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:41 INFO - 'XPC_FLAGS': '0x0', 15:15:41 INFO - 'XPC_SERVICE_NAME': '0', 15:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:41 INFO - Downloading/unpacking psutil>=3.1.1 15:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:44 INFO - Installing collected packages: psutil 15:15:44 INFO - Running setup.py install for psutil 15:15:45 INFO - building 'psutil._psutil_osx' extension 15:15:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:15:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:15:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:15:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:15:45 INFO - building 'psutil._psutil_posix' extension 15:15:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:15:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:15:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:15:45 INFO - ^ 15:15:45 INFO - 1 warning generated. 15:15:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:46 INFO - Successfully installed psutil 15:15:46 INFO - Cleaning up... 15:15:46 INFO - Return code: 0 15:15:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:46 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 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:46 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 15:15:46 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 15:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:46 INFO - 'HOME': '/Users/cltbld', 15:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:46 INFO - 'LOGNAME': 'cltbld', 15:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:46 INFO - 'MOZ_NO_REMOTE': '1', 15:15:46 INFO - 'NO_EM_RESTART': '1', 15:15:46 INFO - 'PAGER': '/bin/cat', 15:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:46 INFO - 'PWD': '/builds/slave/test', 15:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:46 INFO - 'SHELL': '/bin/bash', 15:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:15:46 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:46 INFO - 'USER': 'cltbld', 15:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:46 INFO - 'XPC_FLAGS': '0x0', 15:15:46 INFO - 'XPC_SERVICE_NAME': '0', 15:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:15:46 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 15:15:46 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 15:15:46 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 15:15:46 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 15:15:46 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 15:15:46 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 15:15:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:15:48 INFO - Installing collected packages: mozsystemmonitor 15:15:48 INFO - Running setup.py install for mozsystemmonitor 15:15:49 INFO - Successfully installed mozsystemmonitor 15:15:49 INFO - Cleaning up... 15:15:49 INFO - Return code: 0 15:15:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:49 INFO - 'HOME': '/Users/cltbld', 15:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:49 INFO - 'LOGNAME': 'cltbld', 15:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:49 INFO - 'MOZ_NO_REMOTE': '1', 15:15:49 INFO - 'NO_EM_RESTART': '1', 15:15:49 INFO - 'PAGER': '/bin/cat', 15:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:49 INFO - 'PWD': '/builds/slave/test', 15:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:49 INFO - 'SHELL': '/bin/bash', 15:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:15:49 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:49 INFO - 'USER': 'cltbld', 15:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:49 INFO - 'XPC_FLAGS': '0x0', 15:15:49 INFO - 'XPC_SERVICE_NAME': '0', 15:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:49 INFO - Downloading/unpacking jsonschema==2.5.1 15:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:15:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:15: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 15:15: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 15:15: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 15:15: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 15:15: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 15:15: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 15:15:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:15:52 INFO - warning: no files found matching '*.txt' 15:15:52 INFO - no previously-included directories found matching 'build' 15:15:52 INFO - no previously-included directories found matching 'dist' 15:15:52 INFO - no previously-included directories found matching '.git*' 15:15:52 INFO - Installing collected packages: jsonschema, functools32 15:15:52 INFO - Running setup.py install for functools32 15:15:52 INFO - warning: no files found matching '*.txt' 15:15:52 INFO - no previously-included directories found matching 'build' 15:15:52 INFO - no previously-included directories found matching 'dist' 15:15:52 INFO - no previously-included directories found matching '.git*' 15:15:52 INFO - Successfully installed jsonschema functools32 15:15:52 INFO - Cleaning up... 15:15:52 INFO - Return code: 0 15:15:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:15:52 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:52 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:52 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:52 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:15:52 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 functools32==3.2.3-2 15:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:52 INFO - 'HOME': '/Users/cltbld', 15:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:52 INFO - 'LOGNAME': 'cltbld', 15:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:52 INFO - 'MOZ_NO_REMOTE': '1', 15:15:52 INFO - 'NO_EM_RESTART': '1', 15:15:52 INFO - 'PAGER': '/bin/cat', 15:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:52 INFO - 'PWD': '/builds/slave/test', 15:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:52 INFO - 'SHELL': '/bin/bash', 15:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:15:52 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:52 INFO - 'USER': 'cltbld', 15:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:52 INFO - 'XPC_FLAGS': '0x0', 15:15:52 INFO - 'XPC_SERVICE_NAME': '0', 15:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:15:53 INFO - Cleaning up... 15:15:53 INFO - Return code: 0 15:15:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:53 INFO - 'HOME': '/Users/cltbld', 15:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:53 INFO - 'LOGNAME': 'cltbld', 15:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:53 INFO - 'MOZ_NO_REMOTE': '1', 15:15:53 INFO - 'NO_EM_RESTART': '1', 15:15:53 INFO - 'PAGER': '/bin/cat', 15:15:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:53 INFO - 'PWD': '/builds/slave/test', 15:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:53 INFO - 'SHELL': '/bin/bash', 15:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:15:53 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:53 INFO - 'USER': 'cltbld', 15:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:53 INFO - 'XPC_FLAGS': '0x0', 15:15:53 INFO - 'XPC_SERVICE_NAME': '0', 15:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:15:53 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 15:15:53 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 15:15:53 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 15:15:53 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 15:15:53 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 15:15:53 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 15:15:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:56 INFO - Downloading docopt-0.6.1.tar.gz 15:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:57 INFO - Running setup.py install for blobuploader 15:15:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:57 INFO - Running setup.py install for requests 15:15:57 INFO - Running setup.py install for docopt 15:15:57 INFO - Successfully installed blobuploader requests docopt 15:15:57 INFO - Cleaning up... 15:15:57 INFO - Return code: 0 15:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:57 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 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:15:57 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 15:15:57 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 15:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:57 INFO - 'HOME': '/Users/cltbld', 15:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:57 INFO - 'LOGNAME': 'cltbld', 15:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:57 INFO - 'MOZ_NO_REMOTE': '1', 15:15:57 INFO - 'NO_EM_RESTART': '1', 15:15:57 INFO - 'PAGER': '/bin/cat', 15:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:57 INFO - 'PWD': '/builds/slave/test', 15:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:57 INFO - 'SHELL': '/bin/bash', 15:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:15:57 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:57 INFO - 'USER': 'cltbld', 15:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:57 INFO - 'XPC_FLAGS': '0x0', 15:15:57 INFO - 'XPC_SERVICE_NAME': '0', 15:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-e9ff5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-b6uixI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-88HQw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-PUoZG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-tipVMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-tq5NsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-lLoCQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-zcvnUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:58 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-NQGu0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-gij7DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-uivK13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-QLytb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-rPz850-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-OKGASf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-KqSW2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-YCC3PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:59 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-qwWWfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:59 INFO - Running setup.py install for manifestparser 15:16:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:00 INFO - Running setup.py install for mozcrash 15:16:00 INFO - Running setup.py install for mozdebug 15:16:00 INFO - Running setup.py install for mozdevice 15:16:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:16:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:00 INFO - Running setup.py install for mozfile 15:16:00 INFO - Running setup.py install for mozhttpd 15:16:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:00 INFO - Running setup.py install for mozinfo 15:16:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:00 INFO - Running setup.py install for mozInstall 15:16:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Running setup.py install for mozleak 15:16:01 INFO - Running setup.py install for mozlog 15:16:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Running setup.py install for moznetwork 15:16:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Running setup.py install for mozprocess 15:16:01 INFO - Running setup.py install for mozprofile 15:16:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:01 INFO - Running setup.py install for mozrunner 15:16:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:02 INFO - Running setup.py install for mozscreenshot 15:16:02 INFO - Running setup.py install for moztest 15:16:02 INFO - Running setup.py install for mozversion 15:16:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:02 INFO - Cleaning up... 15:16:02 INFO - Return code: 0 15:16:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:02 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 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:16:02 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 15:16:02 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 15:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:02 INFO - 'HOME': '/Users/cltbld', 15:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:02 INFO - 'LOGNAME': 'cltbld', 15:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:02 INFO - 'MOZ_NO_REMOTE': '1', 15:16:02 INFO - 'NO_EM_RESTART': '1', 15:16:02 INFO - 'PAGER': '/bin/cat', 15:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:02 INFO - 'PWD': '/builds/slave/test', 15:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:02 INFO - 'SHELL': '/bin/bash', 15:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:16:02 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:02 INFO - 'USER': 'cltbld', 15:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:02 INFO - 'XPC_FLAGS': '0x0', 15:16:02 INFO - 'XPC_SERVICE_NAME': '0', 15:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:02 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-K0ZM_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:02 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)) 15:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:02 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-CmZsa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:02 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)) 15:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:02 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-3UE6qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Fe01Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-xxqW9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-cZlMr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-koKywx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-P5cdUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-OC38KJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-7OyGYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-OdcKLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:03 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)) 15:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:03 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-AeoR9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:04 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)) 15:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-OMHelA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:04 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)) 15:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-JdlQqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:04 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)) 15:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-E52iLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:04 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)) 15:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-XET1Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:04 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)) 15:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-BBPfhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:04 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)) 15:16:04 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)) 15:16:04 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)) 15:16:04 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)) 15:16:04 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)) 15:16:04 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)) 15:16:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16:04 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 15:16:04 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 15:16:04 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 15:16:04 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 15:16:04 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 15:16:04 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 15:16:07 INFO - Downloading blessings-1.6.tar.gz 15:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:07 INFO - Installing collected packages: blessings 15:16:07 INFO - Running setup.py install for blessings 15:16:07 INFO - Successfully installed blessings 15:16:07 INFO - Cleaning up... 15:16:07 INFO - Return code: 0 15:16:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:07 INFO - Reading from file tmpfile_stdout 15:16:07 INFO - Current package versions: 15:16:07 INFO - blessings == 1.6 15:16:07 INFO - blobuploader == 1.2.4 15:16:07 INFO - docopt == 0.6.1 15:16:07 INFO - functools32 == 3.2.3-2 15:16:07 INFO - jsonschema == 2.5.1 15:16:07 INFO - manifestparser == 1.1 15:16:07 INFO - mozInstall == 1.12 15:16:07 INFO - mozcrash == 0.17 15:16:07 INFO - mozdebug == 0.1 15:16:07 INFO - mozdevice == 0.48 15:16:07 INFO - mozfile == 1.2 15:16:07 INFO - mozhttpd == 0.7 15:16:07 INFO - mozinfo == 0.9 15:16:07 INFO - mozleak == 0.1 15:16:07 INFO - mozlog == 3.4 15:16:07 INFO - moznetwork == 0.27 15:16:07 INFO - mozprocess == 0.23 15:16:07 INFO - mozprofile == 0.28 15:16:07 INFO - mozrunner == 6.12 15:16:07 INFO - mozscreenshot == 0.1 15:16:07 INFO - mozsystemmonitor == 0.3 15:16:07 INFO - moztest == 0.7 15:16:07 INFO - mozversion == 1.4 15:16:07 INFO - psutil == 3.1.1 15:16:07 INFO - requests == 1.2.3 15:16:07 INFO - wsgiref == 0.1.2 15:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:07 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 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:16:07 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 15:16:07 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 15:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:07 INFO - 'HOME': '/Users/cltbld', 15:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:07 INFO - 'LOGNAME': 'cltbld', 15:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:07 INFO - 'MOZ_NO_REMOTE': '1', 15:16:07 INFO - 'NO_EM_RESTART': '1', 15:16:07 INFO - 'PAGER': '/bin/cat', 15:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:07 INFO - 'PWD': '/builds/slave/test', 15:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:07 INFO - 'SHELL': '/bin/bash', 15:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:16:07 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:07 INFO - 'USER': 'cltbld', 15:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:07 INFO - 'XPC_FLAGS': '0x0', 15:16:07 INFO - 'XPC_SERVICE_NAME': '0', 15:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 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)) 15:16:07 INFO - Cleaning up... 15:16:07 INFO - Return code: 0 15:16:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103567490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5b6b53f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, '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.TRoHYpYqkA/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.BayZ1M26l9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 15:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:07 INFO - 'HOME': '/Users/cltbld', 15:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:07 INFO - 'LOGNAME': 'cltbld', 15:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:07 INFO - 'MOZ_NO_REMOTE': '1', 15:16:07 INFO - 'NO_EM_RESTART': '1', 15:16:07 INFO - 'PAGER': '/bin/cat', 15:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:07 INFO - 'PWD': '/builds/slave/test', 15:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:07 INFO - 'SHELL': '/bin/bash', 15:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:16:07 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:07 INFO - 'USER': 'cltbld', 15:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:07 INFO - 'XPC_FLAGS': '0x0', 15:16:07 INFO - 'XPC_SERVICE_NAME': '0', 15:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:16:08 INFO - Cleaning up... 15:16:08 INFO - Return code: 0 15:16:08 INFO - Running post-action listener: _resource_record_post_action 15:16:08 INFO - Running post-action listener: _start_resource_monitoring 15:16:08 INFO - Starting resource monitoring. 15:16:08 INFO - [mozharness: 2016-09-23 22:16:08.274283Z] Finished create-virtualenv step (success) 15:16:08 INFO - [mozharness: 2016-09-23 22:16:08.275341Z] Running install step. 15:16:08 INFO - Running pre-action listener: _resource_record_pre_action 15:16:08 INFO - Running main action method: install 15:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:08 INFO - Reading from file tmpfile_stdout 15:16:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:08 INFO - Reading from file tmpfile_stdout 15:16:08 INFO - Output received: 15:16:08 INFO - Usage: mozinstall [options] installer 15:16:08 INFO - Options: 15:16:08 INFO - -h, --help show this help message and exit 15:16:08 INFO - -d DEST, --destination=DEST 15:16:08 INFO - Directory to install application into. [default: 15:16:08 INFO - "/builds/slave/test"] 15:16:08 INFO - --app=APP Application being installed. [default: firefox] 15:16:08 INFO - mkdir: /builds/slave/test/build/application 15:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:16:42 INFO - Reading from file tmpfile_stdout 15:16:42 INFO - Output received: 15:16:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:16:42 INFO - Running post-action listener: _resource_record_post_action 15:16:42 INFO - [mozharness: 2016-09-23 22:16:42.686672Z] Finished install step (success) 15:16:42 INFO - [mozharness: 2016-09-23 22:16:42.686803Z] Running run-tests step. 15:16:42 INFO - Running pre-action listener: _resource_record_pre_action 15:16:42 INFO - Running main action method: run_tests 15:16:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:42 INFO - 2016-09-23 15:16:42.701 screenresolution[1649:8228] starting screenresolution argv=screenresolution get 15:16:42 INFO - 2016-09-23 15:16:42.703 screenresolution[1649:8228] Display 0: 1600x1200x32@60 15:16:42 INFO - 2016-09-23 15:16:42.709 screenresolution[1650:8230] starting screenresolution argv=screenresolution list 15:16:42 INFO - Available Modes on Display 0 15:16:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:16:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:16:42 INFO - Intel Iris: 15:16:42 INFO - Chipset Model: Intel Iris 15:16:42 INFO - Type: GPU 15:16:42 INFO - Bus: Built-In 15:16:42 INFO - VRAM (Dynamic, Max): 1536 MB 15:16:42 INFO - Vendor: Intel (0x8086) 15:16:42 INFO - Device ID: 0x0a2e 15:16:42 INFO - Revision ID: 0x0009 15:16:42 INFO - Displays: 15:16:42 INFO - Display: 15:16:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:16:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:16:42 INFO - Display Serial Number: 1600x1200 60 15:16:42 INFO - Main Display: Yes 15:16:42 INFO - Mirror: Off 15:16:42 INFO - Online: Yes 15:16:42 INFO - Rotation: Supported 15:16:42 INFO - Return code: 0 15:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:42 INFO - Python 2.7.3 15:16:42 INFO - Return code: 0 15:16:42 INFO - grabbing minidump binary from tooltool 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 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 0x10337bd30>, '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 0x1031a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103373b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:42 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 15:16:42 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 15:16:42 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 15:16:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:16:43 INFO - Return code: 0 15:16:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:16:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:16:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:16:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:16:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:16:43 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/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 15:16:43 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/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0292 --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 15:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TRoHYpYqkA/Render', 15:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:43 INFO - 'HOME': '/Users/cltbld', 15:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:43 INFO - 'LOGNAME': 'cltbld', 15:16:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:43 INFO - 'MOZ_NO_REMOTE': '1', 15:16:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:43 INFO - 'NO_EM_RESTART': '1', 15:16:43 INFO - 'PAGER': '/bin/cat', 15:16:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:43 INFO - 'PWD': '/builds/slave/test', 15:16:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:43 INFO - 'SHELL': '/bin/bash', 15:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BayZ1M26l9/Listeners', 15:16:43 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 15:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:43 INFO - 'USER': 'cltbld', 15:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:43 INFO - 'XPC_FLAGS': '0x0', 15:16:43 INFO - 'XPC_SERVICE_NAME': '0', 15:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:43 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/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 15:16:43 INFO - mozversion application_buildid: 20160923131224 15:16:43 INFO - mozversion application_changeset: a8254e91e0fed9395c238d5b60867c7907fa261a 15:16:43 INFO - mozversion application_display_name: Nightly 15:16:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:16:43 INFO - mozversion application_name: Firefox 15:16:43 INFO - mozversion application_remotingname: firefox 15:16:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:16:43 INFO - mozversion application_vendor: Mozilla 15:16:43 INFO - mozversion application_version: 52.0a1 15:16:43 INFO - mozversion platform_buildid: 20160923131224 15:16:43 INFO - mozversion platform_changeset: a8254e91e0fed9395c238d5b60867c7907fa261a 15:16:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:16:43 INFO - mozversion platform_version: 52.0a1 15:16:43 INFO - using testdate: 1474669003 15:16:43 INFO - actual date: 1474669003 15:16:43 INFO - starting webserver on 'localhost:49274' 15:16:43 INFO - SUITE-START | Running 2 tests 15:16:43 INFO - TEST-START | dromaeo_css 15:16:43 INFO - operating with platform_type : mac_ 15:16:43 INFO - Initialising browser for dromaeo_css test... 15:16:43 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp8_NlPy/profile http://localhost:49274/getInfo.html) 15:16:45 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 15:16:45 INFO - PROCESS | 1660 | colorDepth:24 15:16:45 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 15:16:45 INFO - PROCESS | 1660 | __metrics 15:16:45 INFO - PROCESS | 1660 | 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" 15:16:45 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:16:46 INFO - TEST-INFO | 1660: exit 0 15:16:46 INFO - Browser initialized. 15:16:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:16:46 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp8_NlPy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:58 INFO - PROCESS | 1663 | RSS: Main: 244101120 15:16:58 INFO - PROCESS | 1663 | 15:17:49 INFO - PROCESS | 1663 | 1474669069657 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] 15:20:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 15:20:03 INFO - PROCESS | 1663 | RSS: Main: 384598016 15:20:03 INFO - PROCESS | 1663 | 15:23:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 15:23:06 INFO - PROCESS | 1663 | RSS: Main: 373813248 15:23:06 INFO - PROCESS | 1663 | 15:26:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 15:26:09 INFO - PROCESS | 1663 | RSS: Main: 332705792 15:26:09 INFO - PROCESS | 1663 | 15:29:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 15:29:12 INFO - PROCESS | 1663 | RSS: Main: 337600512 15:29:12 INFO - PROCESS | 1663 | 15:32:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 15:32:16 INFO - PROCESS | 1663 | RSS: Main: 331415552 15:32:16 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 15:35:20 INFO - PROCESS | 1663 | RSS: Main: 484954112 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | __start_tp_report 15:35:20 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 15:35:20 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 15:35:20 INFO - PROCESS | 1663 | |i|pagename|runs| 15:35:20 INFO - PROCESS | 1663 | |0;dojo.html;3326.2848487575175;3337.0989832745154;3347.397468455677;3387.5088112223743;3418.965810341896;5569.331680198372;5589.832305030851;5618.325800903892;5618.634788738729;5659.009673307175;5496.5053145216925;5634.0703783875615;5658.462446067627;5680.289963754531;5716.371199168088;5122.692638441706;5135.768890399922;5185.637005409604;5186.507281808223;5199.6360254782185;5125.487451254882;5239.816606418757;5240.082985477546;5242.711650859202;5246.396664383587;5262.079136151177;5278.392984806739;5333.599980001496;5335.813246536372;5343.064963631368;5210.218467229945;5217.556507696831;5233.816816411445;5235.659682120688;5240.659357141773;5011;5073.985202959423;5083.034223497523;5115.667481613683;5143.177091665353;5644.74598643062;5678.517326027292;5703.230063941398;5715.771369145229;5733.913991290134;6233.501319894398;6242.344553821828;6243.2508099027955;6246.406591373812;6255.593386429868;6094.276261290963;6144.262688477412;6240.188775459162;6303.023031430135;6307.148534947815;5688.744006519716;5703.372629010805;5756.884862302731;5767.480926716616;5831.650100993869;6315.684215789192;6316.336784637547;6316.4315211630255;6331.651759153291;6338.239411270585;6040.848978775478;6049.637021778707;6105.664188469676;6112.816615501542;6121.602095863755;6106.301130207485;6115.357887421846;6131.197444918514;6220.813375598739;6251.874962500725;6131.601445906002;6141.578063794151;6157.199564056644;6199.783007594712;6232.25212974446;6230.906536401958;6231.844203894939;6239.594426362272;6240.594361366588;6247.00047992319;4790.976045119752;4851.248056551241;4886.60907127429;4905.656604037755;4916.950830491721;3665.193657395369;4342.023044814891;4345.022369966732;4389.253826849444;4389.275769498061;4806.591439727662;5739.540836733051;5772.769089236467;5776.508996735324;5811.535077193815;6269.341719119518;6284.528660350492;6286.9056964145575;6290.622562646256;6308.369163083747;5332.093544097513;5638.548916086703;5695.743691533891;5761.88476230473;5776.5089967352405;5327.067763141435;5327.9733601331745;5365.651232669864;5369.167778994262;5391.3799913009725;6241.469475094577;6272.8118156455375;6277.435030847246;6278.30938596754;6287.654179020198;6247.31279559239;6285.842853928689;6291.96854015727;6304.621722696653;6323.304436512072;6222.844428889133;6228.190335256388;6264.59280146789;6268.686565671607;6302.558820882494;6134.079888016833;6175.166352542349;6185.752569897154;6200.689965501617;6209.751609935552;6232.127502149793;6266.216722909637;6269.31037585856;6285;6288.591241569284;5203.609729270244;5734.598578099493;5791.160281759206;6084.939150608438;6085.117657939485;5826.359100498857;5916.201312822714;5980.970095149671;6015.789447369321;6067.120267561268;5870.618409803349;5873.471387575139;5875.588708790344;5889.293284805851;5909.113632955091;6008.669523176267;6017.428344307284;6039.849003774941;6055.424734650202;6057.121717351048;5747.339056008613;5784.942150578609;5816.389279125631;5821.883562328645;5878.2358293421585 15:35:20 INFO - PROCESS | 1663 | |1;ext.html;476.08116335472545;510.1124044163156;520.4483247757378;522.5479959834739;524.9291345668335;29314.267143321427;40329.79835100824;41448.54930077452;41463.96340091499;43950;42894.571054289445;43278.783606082005;43302.13395732083;43319.35020974688;43371.78314108433;8641.567921603895;9686.46724430156;9837.458939758311;9846.803063938716;9850.310478266525;8690.652373905035;11784.646460606196;12085.516579336816;12096.516139354415;12309.569165079223;11991.460384282727;12029.759404811899;12038.277703337784;12051;12078.577249796259;11977;12018.939905300418;12024.51901923922;12034.33811140387;12044.939775301154;11897.762044759143;11966.34185119818;11971.162018658697;11972.10209234311;11994.940025299906;39328.80335598332;39631.009224769325;39647.20705585872;39664.80167599172;39682.60317396818;3258.218027673365;3266.852991615383;3462.567179102612;3529.4705794130828;3942.6057394260633;30164;30299.545506817416;30653.386932261452;30963.84518077395;31505.891751547788;2967.55486676998;3066.110827859918;3068.2942923127807;3120.375924815046;3180.3321302526497;475937;478838;480345;482178;485974.5701271506;61138.08292875611;61881.69059154765;61918.76162476815;62020.689896550226;62153.37846621566;33556;34070.318593628486;34130.31739365199;35550.93347199588;64799.70400592056;15967.840321596635;15994.120323382092;16165.515034548982;16188.190590470665;16189.676206475804;11204.439778011067;11386.032187264009;12261.509539618315;12357.876421235853;12362;18199.63600727978;18365.173567189508;18584.25662973493;18781.7182742259;18882.716759248622;6445.677716114175;7139.2503787101605;7555.244475552401;7654.8086297843;7769.417293702882;834.870595057767;847.4449235750593;896.4755617963434;975.6195083917278;1041.2919214933765;26590.6011409829;29434.84890144216;29639;30166;30176.568217721022;831.0816547714809;1020.6631811502186;1031.510032734445;1054.2409465185056;1209.8911098001047;14949.551513454613;15348.923255383652;15382.538523844303;15465.14941678196;15841.049537027815;610296;618823;620010;620486;620801;57022;57382.713086435135;57396.42603573994;57532.71233643889;57633.423665762806;1313.258009224785;1354.052163485564;1364.2019418640207;1369.4659082957455;1370.7395594836948;25081.749182508673;27227.72772272252;29094.563581546718;29320.413591727618;29830.105096847128;50040.49959500504;50353.74823126008;50366.49633503618;50515.49484505255;50560.494395055575;413071;415303;417313;417697;420375;22941.311760647208;23395.883020584788;23424.648630270218;26111.477770444864;26519.86740066287;39257;43777.12445751131;46644.833879153295;48832.267515988;49282.50717492779;38746;38898.6385476507;39130.60869391383;39902.40146397865;40480;38127.80936095302;38188;38543.088588423845;39228.803855980535;39801.40297895592;37874;38401;38480.615193847705;38573;38717.806410967765;31973.520397194527;33343.83328083344;33958.83020584881;34206.65793342035;34313.48529772006;23115.452291450267;24942.879855211784;25036.62445063362;25154.24537263885;25803.354916126496 15:35:20 INFO - PROCESS | 1663 | |2;jquery.html;343.8263676843194;348.6043340808185;372.4580735030529;374.3056629951441;396;14895.776563351545;15019.32413041413;15783.763243551328;20440.89779551104;20939;19428.708569371473;19879.304224352152;20459.48851278719;20562.794372056276;20762.584748305024;5549.139883318092;5972.6715030673295;6016.157737916695;6016.969915150418;6019.849503762419;4922.483139270379;6500.382463665967;6580.967095164518;6640.56836305641;6644.800655980304;5751.56863235257;6082;6579.605223686594;6600;6611.074449577063;6100.298465676437;6138.508919286446;6140.017597184429;6146.016637338027;6147.2008638877105;5762.193292938992;5846.678432686201;5849.7660093596205;5917.674527900964;5928.614640048426;12654;12874.742505149938;12884.54904078362;21577.67633485499;23748.881255593613;2144.9356519304447;2169.240765731997;2196.9011394487125;2292.7707229277107;2645.285772841322;9800.705978820646;10304.793904121876;11631.76736465266;12431.75136497274;14531.12813231199;1523.9847601523954;1577.5661693034392;1896.7344571759966;1908.8186622270862;1927.5373910261576;114716.8528314723;121816;123092;124228;125597;10919.071878890383;11198.552057917592;11277.605283815026;11316.038136758467;11442.452839619744;13951.930240348733;13963;14001.929990349983;14004.369803358873;14006.929965350311;7974.7670652217475;8187.058488273806;8189;8364.330853531703;8403.033651130076;6719.966400168066;8118.918810811934;8136.918630813734;8147.226013528823;8293.875591866126;4245.172191422643;4372.693911426233;4375.890602734957;4380.364847097217;4426.84506042287;1864.34331078213;1906.9141888615045;1913.933012344589;1944.2391803638866;1957.6182644384207;725.9745908893163;780.9921900781034;830.5722552885269;848.719922425598;887.6138879587401;17184;17681.646367072586;17949.282028718706;17997.121814949445;18277.26890924348;820.9179082091744;833.3208882782568;835.7701632051113;846.1073567386467;872.1452976083347;8734.301255899512;9271.953640231755;9409.90590094104;9433.811323773487;9649.614015439443;465190.6740466276;570320;577846;582352;582927;98680.51979220318;113410.43294783638;120542.397288013;140076;141485;913.5067063785614;972.1687956796978;1003.0922015576061;1019.8368261078192;1022.1516141602452;17341.306347745947;18403.17185726619;18699.906500467412;18853.717194241824;19008.42974710761;38122.809385952896;50026.74986625044;50104.747381315756;50150.49849501458;55857;55294.72352638211;79590.6020469894;79673.80489292782;81562.59218703868;83400.58299708462;6020.307664618625;6839.931600684128;7104.360607545345;7746.4190185737425;7780.3386712130105;11926.642200733992;12375.876241237473;12576.434060467118;12762.68093297675;12960.027997900006;10570.312929659854;10887;10962.451877405938;11183;11214.719632009264;10474.476276186313;10646.041856232976;10792.946035269773;11037.227394082338;11146.832797508207;10915.290506117077;10949.452527373758;11017.173711971474;11242.55029798799;11411.201215914807;6889.138857642794;7134.072570565793;7204.56772593646;7244.384227340524;7349.191588925107;9143.679971200976;10853.457327133454;10935.851735567969;11029.944850275697;11076.723081923017 15:35:20 INFO - PROCESS | 1663 | |3;mootools.html;1397.7274431485857;1528.4192007037325;1717.3903264341159;1820.5357633803378;1910.6751852185128;8330.79173020674;8846.248068914141;8859.5570221489;8861.46831190129;8869.157430044135;7707.961460192705;7971.202879712026;7995.800104997378;8346.332293416528;8618.00892897317;2350.0247397330086;2382.940426489334;2386.248331775485;2387.5344307859973;2388.164142550111;2348.0725113580124;2369;2374.845635033726;2378.7502312257225;2399.3761621978324;2357.257463898875;2380.143148466551;2387.152560840894;2390.0798192695765;2392.95214095718;2358.9410264743346;2365.9171928982405;2366.7988221001237;2371.893264803088;2375.2992867104244;2297.5519773643978;2365.9290221293218;2367.905283788664;2380.6310021946624;2381.2618088392655;8651.437656552303;8743.169398907094;8753.511902976446;8766.60550275239;8771.079036701181;4284.892877678052;4431.711938723973;5273.2617433559335;5282;5289;3373.900000486989;3447.2588393495266;3565.0552603560077;3577.338192434408;3578.320119177374;858.4505916213628;1033.405791669793;1044.8537204791335;1053.2048303530862;1054.7890421915647;11459.312441253469;11460.71348216293;11476.598319058876;11484.770304593945;11538.538458461568;4528.660350473728;4593.816247350135;4683.320918466803;4746.2168742157155;4755.95244047562;8288.709895153761;9830.361026533252;9854.852177217348;9858.605655773688;9886.209103271722;5279.868003299948;5284.969430960926;5293.073712100367;5302.814401495929;5311.814086507031;4717.315989181549;4834.854954351375;4841.467438581823;4844.224924012141;4896.657233993657;3221.597300337458;3804.7336686431686;3919.412088186795;3942.1721438498234;3993.3211354069877;1267.7337759070515;1271.7392934448417;1276.3490619783977;1286.601153642374;1295.352323838081;855.9657613695382;865.3726048614704;906.3383729877227;908.2688435809237;945.8108378324363;5654.97172514143;5705.486506214461;5714.628549144292;5966.970165149147;6067.059605761114;936.824285521666;949.8812648418948;949.9192568631605;966.7438128895848;990.2325697584286;3779.8677046303246;3848.3265428549894;3861.575226725058;4010;4017.8593749218635;10040.447775372424;10297.691069267934;10429.113525350278;10537.315074520131;10626.256162068736;10513.001264879824;10521.947390263;10522.421266830244;10534.947325263325;10550.366977981346;7677.270659287359;7941.324987376022;8011.839763204704;8020.877077209196;8021.117677055403;5531.585131115263;5538.473844984881;5616;5658.490735833795;5794.942050579441;9237.937637171543;9416.293777966543;9618.134367906921;9713.46575938302;9749.707508774749;9055.728328150166;9601.279904007088;9868.259880508847;9908.25688073383;9975.45135017581;6513.120728701565;6712.798616041527;6768.120144381199;6968.860622787617;6989.510734248757;7782;8080.87878681832;8137.75586732399;8177.6320065596;8181.754547363588;7428.554286742813;7460.142083660231;7526.736564220226;7554.357879580078;7572.432067594842;7063.187733410724;7226.602536860313;7280.0535930328715;7366.594837284001;7379.667914943733;6800.761973330909;6850.6574671267235;6904.792856214322;6939.653017349214;6941.47938904574;4765.73788441639;4839.443464001685;4862.294967229661;4905.681130726492;5114.539691427789;4757.215059515142;4906.754662266943;4947.40631124253;5029.145045342228;5040.269160971712 15:35:20 INFO - PROCESS | 1663 | |4;prototype.html;300.5071682440796;303.21921053287787;311.64005573562537;313.2622673603663;316.8859210684155;4388;4699.812007519704;5439.510444060039;5505.752241149148;5518;4512.345709872066;5021.744563859035;5027.798888044483;5234.953009398117;5342.679439233649;3322.1030321813096;3412.65873412658;3474.7567670263093;3882.2623701496627;3990.740601860877;3383.374075795973;4070.247004304213;4080.7551546907134;4094.529129150156;4157.272477316473;3961.663258623006;4039.939400908989;4081.4490043844;4091;4103.363978583309;3458.2046129390255;3746.250749850041;4081.9591804081874;4093.1813637272367;4136.317507611256;2928.4728748825205;3198.232424218194;3332.150301673058;3567.23304489536;3572.071261472036;4498.775061246924;5209.609279304067;5278.577713782926;5286.101362768339;5329.173978033411;4139.751614903085;4407.933880991788;4719;4789.760511974422;4791.880202994918;5773.538116950634;5777.942220577783;5785.6528608283215;5796.797112101056;5805.477507024346;3598.1004748812798;3614.042278796121;3934.4688467056867;3961.771850726284;3986.720929534934;5614.326280846284;5858.209141765849;5861.17943487912;5951;6050.42520960508;3993.6038376973584;4006.779627120478;4008.614874149876;4010.7794071326357;4017.296973029708;4066.6136717011836;4111.876643700693;4122.6083522065355;4123;4129.463169787909;3941.6452519273403;4495.901965465105;4640.262245275304;4783.976080119647;4799.616030717534;4630.513796051433;4910.8772280693265;5583.162525621189;5613.607047506717;5614.606977511617;1212.7453234820787;1303.4395210059765;1329.9002574806734;1373.6909195430949;1404.3189053309136;766.6243540665146;779.5400713578903;885.2121611765534;892.4110087342452;918.6646873891116;4987.80048798044;5260.500252476008;5270.604704647167;5291.523762861361;5393.325834270716;4562.634989200856;4908.969116485578;5576.609637325349;5801.187833703285;6041.124037014608;4335.609795118455;5195.636305458657;5199.740012999335;5245.632805703564;5260.316158899395;2524.255344673289;2649.4833507466246;2781.332480204777;2808.4523517913813;3023.9848800755854;5619.775208991595;5881.41185881417;5886.499647530008;5894.557908156906;5920.703964801743;5618.747156377973;5813.180607405405;5821.27234095738;5942.504148257742;5961.612495187799;5171.974140129275;5883.264591926009;5895.759611347747;5929.851753706105;5953.880922381615;4250.513449632;5493.423190564933;5694.487496125369;5895.793647222498;5940.821775346746;5555.555555555627;5818.970905145447;5819.563532734977;5821.476067153976;5833.258368566767;5651.4348565143155;5734.627249228787;5750.773181711523;6063.181470501602;6073.453389194994;3866;3874.457575939314;3907.452956586137;3919.0594257378593;3952.9407058893567;4793.880152996203;4919.803207871645;5778.306603207474;5794.927938331422;5982.88034239304;4764.737939413227;4852.708837469763;5271.761136132929;5487.945120548743;5794.855128621818;5635.0702134147405;5675.8864822704145;5687.402822703722;5700;5714.457126572969;5282.366116066097;5537.723113844372;5544.22380866687;5568.582356323211;5622.690752008679;5300.337457817773;5402.729863506887;5579.972100139474;5596.132599447093;5640.4488765589795;4971.403431588233;5239.397469290928;5553.250311207935;5574.693391863487;5601.383847776823 15:35:20 INFO - PROCESS | 1663 | |5;yui.html;712.9536580122292;722.0396872160024;770.9383249340053;810.8216192437669;821.0844907927662;15595.454159104434;15887.44393946212;15923.92038039811;15944.123073230981;15965.962212456183;14344.56966291013;14437.855621443783;14443.638909027279;14444.711105777878;14448;677.2753154125088;696.2550071423578;696.853660731247;838.0111468467206;845.2984023260694;863.2791618998144;877.929765618749;878.2710350409177;878.964841406343;879.327314604325;908.6592527802075;932.4917919733762;932.5244125495979;933.5892207428743;934.7709811096291;920.1488623023744;924.4129977464324;927.475976073523;928.03020843219;928.7492377058156;525.4351572060051;544.3957207499673;544.6269305525727;686.9107016087877;687.3916583823352;11514;12510.687232819253;12558.560450384193;14482;14606.050606710636;14009.159450433006;14520;14629.561113166623;14682.412703491847;14736.926315368462;11697.3566453845;11830.704232394259;11888.346140962243;11917.10621703367;12356.814647780291;3772.2832661794173;3801.1637439763485;3813.9618603813883;3849.6727778138893;3933.8229779659982;78646.21353786446;96399.0360096397;110864.9999999992;113355;113772;11039.613613523488;11171;11182.384968826793;11227.607033753779;11578.42107894602;21780.128794848344;21973.560528789334;22047.559048818934;22089.558208835733;22152.2246721364;7978.042634883735;8065.475744076616;8078.192180781993;8085.595720213966;8147.551884646401;4328.394024836525;4340.088581397942;4444.355568442557;4551.931721024121;4583.839565615188;3286.244163842282;3458.7233021358734;3489.8778542750883;3624.655657712513;3626.730644274483;652.7389044382285;663.5056882622478;666.6999351265052;676.4791110844623;681.2097966359099;524.7664789168783;586.8826234753067;599.7870755881686;610.767908194892;630.4861537846732;8674.956625216833;8865.335099867407;8905;9157.682916477328;9182.449053056838;591.6006695480534;605.8273392083236;620.8292719502083;626.2015929689682;627.9622624583257;3438.2951494943477;3865.4781604483037;4063.776492292893;4399.802008909607;4419.40338054365;96550.55174172393;133924.33037834748;144788;155719;159855;119442;129295.70704293025;132413;134327;136740.31629841786;81604.59197704212;92460.53769731108;92842.53578732198;108644;110304.351303791;9387.249020078241;9835.557399916877;9897.455639939872;9917.900820991697;9972.750681233027;54645.45354546563;56523.630255125696;58219.70890145522;58776.70611646914;59205;79971.80042299487;86115.13884861322;87905.12094879225;88431.11568884228;89545.10454895628;13345.999050071478;13348.466061357825;13352.599422017354;13371.331433428095;13463.461461541821;13475.51769305356;14707.191104489355;14889.702205956037;14913.122588126947;15009.924950375178;13571.321433928462;13976.231307278198;14071.226082565558;14072.437102516194;14180.290985450893;13896.444142234197;13949.16305021702;14016.439342426189;14056.929715351767;14536.345864436338;13414.329283535979;13550.796738049134;13580.185188888698;14261.714765704835;14298.213598252196;10620;11393.373364465035;11454.94272528632;11494.540218391505;11722.648320550397;9212.216961558343;10741.946290268499;11256.493457794255;11582.247153934968;11592.942035289769 15:35:20 INFO - PROCESS | 1663 | __end_tp_report 15:35:20 INFO - PROCESS | 1663 | __start_cc_report 15:35:20 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1370 15:35:20 INFO - PROCESS | 1663 | __end_cc_report 15:35:20 INFO - PROCESS | 1663 | __startTimestamp1474670120275__endTimestamp 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | ------- Summary: start ------- 15:35:20 INFO - PROCESS | 1663 | Number of tests: 6 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5703.47 Median:5831.65 stddev:655.56 (11.2%) stddev-sans-first:630.49 15:35:20 INFO - PROCESS | 1663 | Values: 3326.3 3337.1 3347.4 3387.5 3419.0 5569.3 5589.8 5618.3 5618.6 5659.0 5496.5 5634.1 5658.5 5680.3 5716.4 5122.7 5135.8 5185.6 5186.5 5199.6 5125.5 5239.8 5240.1 5242.7 5246.4 5262.1 5278.4 5333.6 5335.8 5343.1 5210.2 5217.6 5233.8 5235.7 5240.7 5011.0 5074.0 5083.0 5115.7 5143.2 5644.7 5678.5 5703.2 5715.8 5733.9 6233.5 6242.3 6243.3 6246.4 6255.6 6094.3 6144.3 6240.2 6303.0 6307.1 5688.7 5703.4 5756.9 5767.5 5831.7 6315.7 6316.3 6316.4 6331.7 6338.2 6040.8 6049.6 6105.7 6112.8 6121.6 6106.3 6115.4 6131.2 6220.8 6251.9 6131.6 6141.6 6157.2 6199.8 6232.3 6230.9 6231.8 6239.6 6240.6 6247.0 4791.0 4851.2 4886.6 4905.7 4917.0 3665.2 4342.0 4345.0 4389.3 4389.3 4806.6 5739.5 5772.8 5776.5 5811.5 6269.3 6284.5 6286.9 6290.6 6308.4 5332.1 5638.5 5695.7 5761.9 5776.5 5327.1 5328.0 5365.7 5369.2 5391.4 6241.5 6272.8 6277.4 6278.3 6287.7 6247.3 6285.8 6292.0 6304.6 6323.3 6222.8 6228.2 6264.6 6268.7 6302.6 6134.1 6175.2 6185.8 6200.7 6209.8 6232.1 6266.2 6269.3 6285.0 6288.6 5203.6 5734.6 5791.2 6084.9 6085.1 5826.4 5916.2 5981.0 6015.8 6067.1 5870.6 5873.5 5875.6 5889.3 5909.1 6008.7 6017.4 6039.8 6055.4 6057.1 5747.3 5784.9 5816.4 5821.9 5878.2 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64370.39 Median:3496.02 stddev:136529.78 (3905.3%) stddev-sans-first:136828.50 15:35:20 INFO - PROCESS | 1663 | Values: 476.1 510.1 520.4 522.5 524.9 29314.3 40329.8 41448.5 41464.0 43950.0 42894.6 43278.8 43302.1 43319.4 43371.8 8641.6 9686.5 9837.5 9846.8 9850.3 8690.7 11784.6 12085.5 12096.5 12309.6 11991.5 12029.8 12038.3 12051.0 12078.6 11977.0 12018.9 12024.5 12034.3 12044.9 11897.8 11966.3 11971.2 11972.1 11994.9 39328.8 39631.0 39647.2 39664.8 39682.6 3258.2 3266.9 3462.6 3529.5 3942.6 30164.0 30299.5 30653.4 30963.8 31505.9 2967.6 3066.1 3068.3 3120.4 3180.3 475937.0 478838.0 480345.0 482178.0 485974.6 61138.1 61881.7 61918.8 62020.7 62153.4 33556.0 34070.3 34130.3 35550.9 64799.7 15967.8 15994.1 16165.5 16188.2 16189.7 11204.4 11386.0 12261.5 12357.9 12362.0 18199.6 18365.2 18584.3 18781.7 18882.7 6445.7 7139.3 7555.2 7654.8 7769.4 834.9 847.4 896.5 975.6 1041.3 26590.6 29434.8 29639.0 30166.0 30176.6 831.1 1020.7 1031.5 1054.2 1209.9 14949.6 15348.9 15382.5 15465.1 15841.0 610296.0 618823.0 620010.0 620486.0 620801.0 57022.0 57382.7 57396.4 57532.7 57633.4 1313.3 1354.1 1364.2 1369.5 1370.7 25081.7 27227.7 29094.6 29320.4 29830.1 50040.5 50353.7 50366.5 50515.5 50560.5 413071.0 415303.0 417313.0 417697.0 420375.0 22941.3 23395.9 23424.6 26111.5 26519.9 39257.0 43777.1 46644.8 48832.3 49282.5 38746.0 38898.6 39130.6 39902.4 40480.0 38127.8 38188.0 38543.1 39228.8 39801.4 37874.0 38401.0 38480.6 38573.0 38717.8 31973.5 33343.8 33958.8 34206.7 34313.5 23115.5 24942.9 25036.6 25154.2 25803.4 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33120.99 Median:346.22 stddev:93540.05 (27017.9%) stddev-sans-first:93770.08 15:35:20 INFO - PROCESS | 1663 | Values: 343.8 348.6 372.5 374.3 396.0 14895.8 15019.3 15783.8 20440.9 20939.0 19428.7 19879.3 20459.5 20562.8 20762.6 5549.1 5972.7 6016.2 6017.0 6019.8 4922.5 6500.4 6581.0 6640.6 6644.8 5751.6 6082.0 6579.6 6600.0 6611.1 6100.3 6138.5 6140.0 6146.0 6147.2 5762.2 5846.7 5849.8 5917.7 5928.6 12654.0 12874.7 12884.5 21577.7 23748.9 2144.9 2169.2 2196.9 2292.8 2645.3 9800.7 10304.8 11631.8 12431.8 14531.1 1524.0 1577.6 1896.7 1908.8 1927.5 114716.9 121816.0 123092.0 124228.0 125597.0 10919.1 11198.6 11277.6 11316.0 11442.5 13951.9 13963.0 14001.9 14004.4 14006.9 7974.8 8187.1 8189.0 8364.3 8403.0 6720.0 8118.9 8136.9 8147.2 8293.9 4245.2 4372.7 4375.9 4380.4 4426.8 1864.3 1906.9 1913.9 1944.2 1957.6 726.0 781.0 830.6 848.7 887.6 17184.0 17681.6 17949.3 17997.1 18277.3 820.9 833.3 835.8 846.1 872.1 8734.3 9272.0 9409.9 9433.8 9649.6 465190.7 570320.0 577846.0 582352.0 582927.0 98680.5 113410.4 120542.4 140076.0 141485.0 913.5 972.2 1003.1 1019.8 1022.2 17341.3 18403.2 18699.9 18853.7 19008.4 38122.8 50026.7 50104.7 50150.5 55857.0 55294.7 79590.6 79673.8 81562.6 83400.6 6020.3 6839.9 7104.4 7746.4 7780.3 11926.6 12375.9 12576.4 12762.7 12960.0 10570.3 10887.0 10962.5 11183.0 11214.7 10474.5 10646.0 10792.9 11037.2 11146.8 10915.3 10949.5 11017.2 11242.6 11411.2 6889.1 7134.1 7204.6 7244.4 7349.2 9143.7 10853.5 10935.9 11029.9 11076.7 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5585.89 Median:5193.90 stddev:3093.47 (59.6%) stddev-sans-first:3086.13 15:35:20 INFO - PROCESS | 1663 | Values: 1397.7 1528.4 1717.4 1820.5 1910.7 8330.8 8846.2 8859.6 8861.5 8869.2 7708.0 7971.2 7995.8 8346.3 8618.0 2350.0 2382.9 2386.2 2387.5 2388.2 2348.1 2369.0 2374.8 2378.8 2399.4 2357.3 2380.1 2387.2 2390.1 2393.0 2358.9 2365.9 2366.8 2371.9 2375.3 2297.6 2365.9 2367.9 2380.6 2381.3 8651.4 8743.2 8753.5 8766.6 8771.1 4284.9 4431.7 5273.3 5282.0 5289.0 3373.9 3447.3 3565.1 3577.3 3578.3 858.5 1033.4 1044.9 1053.2 1054.8 11459.3 11460.7 11476.6 11484.8 11538.5 4528.7 4593.8 4683.3 4746.2 4756.0 8288.7 9830.4 9854.9 9858.6 9886.2 5279.9 5285.0 5293.1 5302.8 5311.8 4717.3 4834.9 4841.5 4844.2 4896.7 3221.6 3804.7 3919.4 3942.2 3993.3 1267.7 1271.7 1276.3 1286.6 1295.4 856.0 865.4 906.3 908.3 945.8 5655.0 5705.5 5714.6 5967.0 6067.1 936.8 949.9 949.9 966.7 990.2 3779.9 3848.3 3861.6 4010.0 4017.9 10040.4 10297.7 10429.1 10537.3 10626.3 10513.0 10521.9 10522.4 10534.9 10550.4 7677.3 7941.3 8011.8 8020.9 8021.1 5531.6 5538.5 5616.0 5658.5 5794.9 9237.9 9416.3 9618.1 9713.5 9749.7 9055.7 9601.3 9868.3 9908.3 9975.5 6513.1 6712.8 6768.1 6968.9 6989.5 7782.0 8080.9 8137.8 8177.6 8181.8 7428.6 7460.1 7526.7 7554.4 7572.4 7063.2 7226.6 7280.1 7366.6 7379.7 6800.8 6850.7 6904.8 6939.7 6941.5 4765.7 4839.4 4862.3 4905.7 5114.5 4757.2 4906.8 4947.4 5029.1 5040.3 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4560.49 Median:5204.67 stddev:1425.12 (27.4%) stddev-sans-first:1392.79 15:35:20 INFO - PROCESS | 1663 | Values: 300.5 303.2 311.6 313.3 316.9 4388.0 4699.8 5439.5 5505.8 5518.0 4512.3 5021.7 5027.8 5235.0 5342.7 3322.1 3412.7 3474.8 3882.3 3990.7 3383.4 4070.2 4080.8 4094.5 4157.3 3961.7 4039.9 4081.4 4091.0 4103.4 3458.2 3746.3 4082.0 4093.2 4136.3 2928.5 3198.2 3332.2 3567.2 3572.1 4498.8 5209.6 5278.6 5286.1 5329.2 4139.8 4407.9 4719.0 4789.8 4791.9 5773.5 5777.9 5785.7 5796.8 5805.5 3598.1 3614.0 3934.5 3961.8 3986.7 5614.3 5858.2 5861.2 5951.0 6050.4 3993.6 4006.8 4008.6 4010.8 4017.3 4066.6 4111.9 4122.6 4123.0 4129.5 3941.6 4495.9 4640.3 4784.0 4799.6 4630.5 4910.9 5583.2 5613.6 5614.6 1212.7 1303.4 1329.9 1373.7 1404.3 766.6 779.5 885.2 892.4 918.7 4987.8 5260.5 5270.6 5291.5 5393.3 4562.6 4909.0 5576.6 5801.2 6041.1 4335.6 5195.6 5199.7 5245.6 5260.3 2524.3 2649.5 2781.3 2808.5 3024.0 5619.8 5881.4 5886.5 5894.6 5920.7 5618.7 5813.2 5821.3 5942.5 5961.6 5172.0 5883.3 5895.8 5929.9 5953.9 4250.5 5493.4 5694.5 5895.8 5940.8 5555.6 5819.0 5819.6 5821.5 5833.3 5651.4 5734.6 5750.8 6063.2 6073.5 3866.0 3874.5 3907.5 3919.1 3952.9 4793.9 4919.8 5778.3 5794.9 5982.9 4764.7 4852.7 5271.8 5487.9 5794.9 5635.1 5675.9 5687.4 5700.0 5714.5 5282.4 5537.7 5544.2 5568.6 5622.7 5300.3 5402.7 5580.0 5596.1 5640.4 4971.4 5239.4 5553.3 5574.7 5601.4 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:23800.69 Median:3807.56 stddev:37539.57 (985.9%) stddev-sans-first:37604.85 15:35:20 INFO - PROCESS | 1663 | Values: 713.0 722.0 770.9 810.8 821.1 15595.5 15887.4 15923.9 15944.1 15966.0 14344.6 14437.9 14443.6 14444.7 14448.0 677.3 696.3 696.9 838.0 845.3 863.3 877.9 878.3 879.0 879.3 908.7 932.5 932.5 933.6 934.8 920.1 924.4 927.5 928.0 928.7 525.4 544.4 544.6 686.9 687.4 11514.0 12510.7 12558.6 14482.0 14606.1 14009.2 14520.0 14629.6 14682.4 14736.9 11697.4 11830.7 11888.3 11917.1 12356.8 3772.3 3801.2 3814.0 3849.7 3933.8 78646.2 96399.0 110865.0 113355.0 113772.0 11039.6 11171.0 11182.4 11227.6 11578.4 21780.1 21973.6 22047.6 22089.6 22152.2 7978.0 8065.5 8078.2 8085.6 8147.6 4328.4 4340.1 4444.4 4551.9 4583.8 3286.2 3458.7 3489.9 3624.7 3626.7 652.7 663.5 666.7 676.5 681.2 524.8 586.9 599.8 610.8 630.5 8675.0 8865.3 8905.0 9157.7 9182.4 591.6 605.8 620.8 626.2 628.0 3438.3 3865.5 4063.8 4399.8 4419.4 96550.6 133924.3 144788.0 155719.0 159855.0 119442.0 129295.7 132413.0 134327.0 136740.3 81604.6 92460.5 92842.5 108644.0 110304.4 9387.2 9835.6 9897.5 9917.9 9972.8 54645.5 56523.6 58219.7 58776.7 59205.0 79971.8 86115.1 87905.1 88431.1 89545.1 13346.0 13348.5 13352.6 13371.3 13463.5 13475.5 14707.2 14889.7 14913.1 15009.9 13571.3 13976.2 14071.2 14072.4 14180.3 13896.4 13949.2 14016.4 14056.9 14536.3 13414.3 13550.8 13580.2 14261.7 14298.2 10620.0 11393.4 11454.9 11494.5 11722.6 9212.2 10741.9 11256.5 11582.2 11592.9 15:35:20 INFO - PROCESS | 1663 | -------- Summary: end -------- 15:35:20 INFO - PROCESS | 1663 | 15:35:20 INFO - TEST-INFO | 1663: exit 0 15:35:20 INFO - TEST-OK | dromaeo_css | took 1117624ms 15:35:20 INFO - TEST-START | kraken 15:35:20 INFO - operating with platform_type : mac_ 15:35:20 INFO - Initialising browser for kraken test... 15:35:20 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpJfikJY/profile http://localhost:49274/getInfo.html) 15:35:23 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 15:35:23 INFO - PROCESS | 1670 | colorDepth:24 15:35:23 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 15:35:23 INFO - PROCESS | 1670 | __metrics 15:35:23 INFO - PROCESS | 1670 | 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" 15:35:23 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:24 INFO - TEST-INFO | 1670: exit 0 15:35:24 INFO - Browser initialized. 15:35:24 INFO - Running cycle 1/1 for kraken test... 15:35:24 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpJfikJY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:36 INFO - PROCESS | 1671 | RSS: Main: 235737088 15:35:36 INFO - PROCESS | 1671 | 15:35:38 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:39 INFO - PROCESS | 1671 | RSS: Main: 294166528 15:35:39 INFO - PROCESS | 1671 | 15:35:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 15:35:43 INFO - PROCESS | 1671 | RSS: Main: 292982784 15:35:43 INFO - PROCESS | 1671 | 15:35:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 15:35:47 INFO - PROCESS | 1671 | RSS: Main: 383963136 15:35:47 INFO - PROCESS | 1671 | 15:35:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 15:35:49 INFO - PROCESS | 1671 | RSS: Main: 283574272 15:35:49 INFO - PROCESS | 1671 | 15:35:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:35:52 INFO - PROCESS | 1671 | RSS: Main: 289054720 15:35:52 INFO - PROCESS | 1671 | 15:35:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 15:35:55 INFO - PROCESS | 1671 | RSS: Main: 326643712 15:35:55 INFO - PROCESS | 1671 | 15:35:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 15:35:59 INFO - PROCESS | 1671 | RSS: Main: 328208384 15:35:59 INFO - PROCESS | 1671 | 15:36:01 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 15:36:02 INFO - PROCESS | 1671 | RSS: Main: 327487488 15:36:02 INFO - PROCESS | 1671 | 15:36:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:04 INFO - PROCESS | 1671 | RSS: Main: 300257280 15:36:04 INFO - PROCESS | 1671 | 15:36:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:07 INFO - PROCESS | 1671 | RSS: Main: 306159616 15:36:07 INFO - PROCESS | 1671 | 15:36:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:10 INFO - PROCESS | 1671 | RSS: Main: 304128000 15:36:10 INFO - PROCESS | 1671 | 15:36:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:13 INFO - PROCESS | 1671 | RSS: Main: 321290240 15:36:13 INFO - PROCESS | 1671 | 15:36:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:17 INFO - PROCESS | 1671 | RSS: Main: 317595648 15:36:17 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 15:36:19 INFO - PROCESS | 1671 | RSS: Main: 361000960 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | __start_tp_report 15:36:19 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 15:36:19 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 15:36:19 INFO - PROCESS | 1671 | |i|pagename|runs| 15:36:19 INFO - PROCESS | 1671 | |0;ai-astar;111;112;111;114;113;114;112;112;112;113 15:36:19 INFO - PROCESS | 1671 | |1;audio-beat-detection;144;116;138;178;142;108;109;108;139;113 15:36:19 INFO - PROCESS | 1671 | |2;audio-dft;183;184;182;186;184;183;183;183;180;182 15:36:19 INFO - PROCESS | 1671 | |3;audio-fft;80;60;59;87;62;56;58;58;81;57 15:36:19 INFO - PROCESS | 1671 | |4;audio-oscillator;85;71;91;70;67;69;90;68;69;89 15:36:19 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;86;135;85;87;84;88;131;87;84 15:36:19 INFO - PROCESS | 1671 | |6;imaging-darkroom;94;94;92;93;92;93;93;93;92;93 15:36:19 INFO - PROCESS | 1671 | |7;imaging-desaturate;84;85;84;87;86;83;86;86;84;85 15:36:19 INFO - PROCESS | 1671 | |8;json-parse-financial;57;56;55;55;57;53;53;54;54;55 15:36:19 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;64;73;77;75;71;68;69;69;74;104 15:36:19 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;85;86;85;83;86;87;85;86;84;87 15:36:19 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;141;142;127;146;146;154;152;130;161;156 15:36:19 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;167;171;168;169;165;168;166;168;169;167 15:36:19 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;69;69;69;67;70;84;86;84;80;67 15:36:19 INFO - PROCESS | 1671 | __end_tp_report 15:36:19 INFO - PROCESS | 1671 | __start_cc_report 15:36:19 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2077 15:36:19 INFO - PROCESS | 1671 | __end_cc_report 15:36:19 INFO - PROCESS | 1671 | __startTimestamp1474670179252__endTimestamp 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | ------- Summary: start ------- 15:36:19 INFO - PROCESS | 1671 | Number of tests: 14 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:1.07 (1.0%) stddev-sans-first:1.01 15:36:19 INFO - PROCESS | 1671 | Values: 111.0 112.0 111.0 114.0 113.0 114.0 112.0 112.0 112.0 113.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:138.50 stddev:22.80 (16.5%) stddev-sans-first:23.58 15:36:19 INFO - PROCESS | 1671 | Values: 144.0 116.0 138.0 178.0 142.0 108.0 109.0 108.0 139.0 113.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.56 (0.9%) stddev-sans-first:1.66 15:36:19 INFO - PROCESS | 1671 | Values: 183.0 184.0 182.0 186.0 184.0 183.0 183.0 183.0 180.0 182.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:65.80 Median:61.00 stddev:11.89 (19.5%) stddev-sans-first:11.44 15:36:19 INFO - PROCESS | 1671 | Values: 80.0 60.0 59.0 87.0 62.0 56.0 58.0 58.0 81.0 57.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.00 stddev:10.37 (13.3%) stddev-sans-first:10.57 15:36:19 INFO - PROCESS | 1671 | Values: 85.0 71.0 91.0 70.0 67.0 69.0 90.0 68.0 69.0 89.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:86.50 stddev:19.84 (22.9%) stddev-sans-first:20.86 15:36:19 INFO - PROCESS | 1671 | Values: 88.0 86.0 135.0 85.0 87.0 84.0 88.0 131.0 87.0 84.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 15:36:19 INFO - PROCESS | 1671 | Values: 94.0 94.0 92.0 93.0 92.0 93.0 93.0 93.0 92.0 93.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.27 15:36:19 INFO - PROCESS | 1671 | Values: 84.0 85.0 84.0 87.0 86.0 83.0 86.0 86.0 84.0 85.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.45 (2.6%) stddev-sans-first:1.32 15:36:19 INFO - PROCESS | 1671 | Values: 57.0 56.0 55.0 55.0 57.0 53.0 53.0 54.0 54.0 55.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:72.00 stddev:11.08 (15.4%) stddev-sans-first:11.09 15:36:19 INFO - PROCESS | 1671 | Values: 64.0 73.0 77.0 75.0 71.0 68.0 69.0 69.0 74.0 104.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 15:36:19 INFO - PROCESS | 1671 | Values: 85.0 86.0 85.0 83.0 86.0 87.0 85.0 86.0 84.0 87.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:149.00 stddev:10.96 (7.4%) stddev-sans-first:11.50 15:36:19 INFO - PROCESS | 1671 | Values: 141.0 142.0 127.0 146.0 146.0 154.0 152.0 130.0 161.0 156.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:1.69 (1.0%) stddev-sans-first:1.76 15:36:19 INFO - PROCESS | 1671 | Values: 167.0 171.0 168.0 169.0 165.0 168.0 166.0 168.0 169.0 167.0 15:36:19 INFO - PROCESS | 1671 | 15:36:19 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:75.00 stddev:7.93 (10.6%) stddev-sans-first:8.16 15:36:19 INFO - PROCESS | 1671 | Values: 69.0 69.0 69.0 67.0 70.0 84.0 86.0 84.0 80.0 67.0 15:36:19 INFO - PROCESS | 1671 | -------- Summary: end -------- 15:36:19 INFO - PROCESS | 1671 | 15:36:20 INFO - TEST-INFO | 1671: exit 0 15:36:20 INFO - TEST-OK | kraken | took 59191ms 15:36:20 INFO - SUITE-END | took 1176s 15:36:20 INFO - Completed test suite (00:19:37) 15:36:20 INFO - javascript benchmark 15:36:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.2848487575175, 3337.0989832745154, 3347.397468455677, 3387.5088112223743, 3418.965810341896, 5569.331680198372, 5589.832305030851, 5618.325800903892, 5618.634788738729, 5659.009673307175, 5496.5053145216925, 5634.0703783875615, 5658.462446067627, 5680.289963754531, 5716.371199168088, 5122.692638441706, 5135.768890399922, 5185.637005409604, 5186.507281808223, 5199.6360254782185, 5125.487451254882, 5239.816606418757, 5240.082985477546, 5242.711650859202, 5246.396664383587, 5262.079136151177, 5278.392984806739, 5333.599980001496, 5335.813246536372, 5343.064963631368, 5210.218467229945, 5217.556507696831, 5233.816816411445, 5235.659682120688, 5240.659357141773, 5011.0, 5073.985202959423, 5083.034223497523, 5115.667481613683, 5143.177091665353, 5644.74598643062, 5678.517326027292, 5703.230063941398, 5715.771369145229, 5733.913991290134, 6233.501319894398, 6242.344553821828, 6243.2508099027955, 6246.406591373812, 6255.593386429868, 6094.276261290963, 6144.262688477412, 6240.188775459162, 6303.023031430135, 6307.148534947815, 5688.744006519716, 5703.372629010805, 5756.884862302731, 5767.480926716616, 5831.650100993869, 6315.684215789192, 6316.336784637547, 6316.4315211630255, 6331.651759153291, 6338.239411270585, 6040.848978775478, 6049.637021778707, 6105.664188469676, 6112.816615501542, 6121.602095863755, 6106.301130207485, 6115.357887421846, 6131.197444918514, 6220.813375598739, 6251.874962500725, 6131.601445906002, 6141.578063794151, 6157.199564056644, 6199.783007594712, 6232.25212974446, 6230.906536401958, 6231.844203894939, 6239.594426362272, 6240.594361366588, 6247.00047992319, 4790.976045119752, 4851.248056551241, 4886.60907127429, 4905.656604037755, 4916.950830491721, 3665.193657395369, 4342.023044814891, 4345.022369966732, 4389.253826849444, 4389.275769498061, 4806.591439727662, 5739.540836733051, 5772.769089236467, 5776.508996735324, 5811.535077193815, 6269.341719119518, 6284.528660350492, 6286.9056964145575, 6290.622562646256, 6308.369163083747, 5332.093544097513, 5638.548916086703, 5695.743691533891, 5761.88476230473, 5776.5089967352405, 5327.067763141435, 5327.9733601331745, 5365.651232669864, 5369.167778994262, 5391.3799913009725, 6241.469475094577, 6272.8118156455375, 6277.435030847246, 6278.30938596754, 6287.654179020198, 6247.31279559239, 6285.842853928689, 6291.96854015727, 6304.621722696653, 6323.304436512072, 6222.844428889133, 6228.190335256388, 6264.59280146789, 6268.686565671607, 6302.558820882494, 6134.079888016833, 6175.166352542349, 6185.752569897154, 6200.689965501617, 6209.751609935552, 6232.127502149793, 6266.216722909637, 6269.31037585856, 6285.0, 6288.591241569284, 5203.609729270244, 5734.598578099493, 5791.160281759206, 6084.939150608438, 6085.117657939485, 5826.359100498857, 5916.201312822714, 5980.970095149671, 6015.789447369321, 6067.120267561268, 5870.618409803349, 5873.471387575139, 5875.588708790344, 5889.293284805851, 5909.113632955091, 6008.669523176267, 6017.428344307284, 6039.849003774941, 6055.424734650202, 6057.121717351048, 5747.339056008613, 5784.942150578609, 5816.389279125631, 5821.883562328645, 5878.2358293421585], "value": 5660.361282980149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.08116335472545, 510.1124044163156, 520.4483247757378, 522.5479959834739, 524.9291345668335, 29314.267143321427, 40329.79835100824, 41448.54930077452, 41463.96340091499, 43950.0, 42894.571054289445, 43278.783606082005, 43302.13395732083, 43319.35020974688, 43371.78314108433, 8641.567921603895, 9686.46724430156, 9837.458939758311, 9846.803063938716, 9850.310478266525, 8690.652373905035, 11784.646460606196, 12085.516579336816, 12096.516139354415, 12309.569165079223, 11991.460384282727, 12029.759404811899, 12038.277703337784, 12051.0, 12078.577249796259, 11977.0, 12018.939905300418, 12024.51901923922, 12034.33811140387, 12044.939775301154, 11897.762044759143, 11966.34185119818, 11971.162018658697, 11972.10209234311, 11994.940025299906, 39328.80335598332, 39631.009224769325, 39647.20705585872, 39664.80167599172, 39682.60317396818, 3258.218027673365, 3266.852991615383, 3462.567179102612, 3529.4705794130828, 3942.6057394260633, 30164.0, 30299.545506817416, 30653.386932261452, 30963.84518077395, 31505.891751547788, 2967.55486676998, 3066.110827859918, 3068.2942923127807, 3120.375924815046, 3180.3321302526497, 475937.0, 478838.0, 480345.0, 482178.0, 485974.5701271506, 61138.08292875611, 61881.69059154765, 61918.76162476815, 62020.689896550226, 62153.37846621566, 33556.0, 34070.318593628486, 34130.31739365199, 35550.93347199588, 64799.70400592056, 15967.840321596635, 15994.120323382092, 16165.515034548982, 16188.190590470665, 16189.676206475804, 11204.439778011067, 11386.032187264009, 12261.509539618315, 12357.876421235853, 12362.0, 18199.63600727978, 18365.173567189508, 18584.25662973493, 18781.7182742259, 18882.716759248622, 6445.677716114175, 7139.2503787101605, 7555.244475552401, 7654.8086297843, 7769.417293702882, 834.870595057767, 847.4449235750593, 896.4755617963434, 975.6195083917278, 1041.2919214933765, 26590.6011409829, 29434.84890144216, 29639.0, 30166.0, 30176.568217721022, 831.0816547714809, 1020.6631811502186, 1031.510032734445, 1054.2409465185056, 1209.8911098001047, 14949.551513454613, 15348.923255383652, 15382.538523844303, 15465.14941678196, 15841.049537027815, 610296.0, 618823.0, 620010.0, 620486.0, 620801.0, 57022.0, 57382.713086435135, 57396.42603573994, 57532.71233643889, 57633.423665762806, 1313.258009224785, 1354.052163485564, 1364.2019418640207, 1369.4659082957455, 1370.7395594836948, 25081.749182508673, 27227.72772272252, 29094.563581546718, 29320.413591727618, 29830.105096847128, 50040.49959500504, 50353.74823126008, 50366.49633503618, 50515.49484505255, 50560.494395055575, 413071.0, 415303.0, 417313.0, 417697.0, 420375.0, 22941.311760647208, 23395.883020584788, 23424.648630270218, 26111.477770444864, 26519.86740066287, 39257.0, 43777.12445751131, 46644.833879153295, 48832.267515988, 49282.50717492779, 38746.0, 38898.6385476507, 39130.60869391383, 39902.40146397865, 40480.0, 38127.80936095302, 38188.0, 38543.088588423845, 39228.803855980535, 39801.40297895592, 37874.0, 38401.0, 38480.615193847705, 38573.0, 38717.806410967765, 31973.520397194527, 33343.83328083344, 33958.83020584881, 34206.65793342035, 34313.48529772006, 23115.452291450267, 24942.879855211784, 25036.62445063362, 25154.24537263885, 25803.354916126496], "value": 19757.640101039477, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.8263676843194, 348.6043340808185, 372.4580735030529, 374.3056629951441, 396.0, 14895.776563351545, 15019.32413041413, 15783.763243551328, 20440.89779551104, 20939.0, 19428.708569371473, 19879.304224352152, 20459.48851278719, 20562.794372056276, 20762.584748305024, 5549.139883318092, 5972.6715030673295, 6016.157737916695, 6016.969915150418, 6019.849503762419, 4922.483139270379, 6500.382463665967, 6580.967095164518, 6640.56836305641, 6644.800655980304, 5751.56863235257, 6082.0, 6579.605223686594, 6600.0, 6611.074449577063, 6100.298465676437, 6138.508919286446, 6140.017597184429, 6146.016637338027, 6147.2008638877105, 5762.193292938992, 5846.678432686201, 5849.7660093596205, 5917.674527900964, 5928.614640048426, 12654.0, 12874.742505149938, 12884.54904078362, 21577.67633485499, 23748.881255593613, 2144.9356519304447, 2169.240765731997, 2196.9011394487125, 2292.7707229277107, 2645.285772841322, 9800.705978820646, 10304.793904121876, 11631.76736465266, 12431.75136497274, 14531.12813231199, 1523.9847601523954, 1577.5661693034392, 1896.7344571759966, 1908.8186622270862, 1927.5373910261576, 114716.8528314723, 121816.0, 123092.0, 124228.0, 125597.0, 10919.071878890383, 11198.552057917592, 11277.605283815026, 11316.038136758467, 11442.452839619744, 13951.930240348733, 13963.0, 14001.929990349983, 14004.369803358873, 14006.929965350311, 7974.7670652217475, 8187.058488273806, 8189.0, 8364.330853531703, 8403.033651130076, 6719.966400168066, 8118.918810811934, 8136.918630813734, 8147.226013528823, 8293.875591866126, 4245.172191422643, 4372.693911426233, 4375.890602734957, 4380.364847097217, 4426.84506042287, 1864.34331078213, 1906.9141888615045, 1913.933012344589, 1944.2391803638866, 1957.6182644384207, 725.9745908893163, 780.9921900781034, 830.5722552885269, 848.719922425598, 887.6138879587401, 17184.0, 17681.646367072586, 17949.282028718706, 17997.121814949445, 18277.26890924348, 820.9179082091744, 833.3208882782568, 835.7701632051113, 846.1073567386467, 872.1452976083347, 8734.301255899512, 9271.953640231755, 9409.90590094104, 9433.811323773487, 9649.614015439443, 465190.6740466276, 570320.0, 577846.0, 582352.0, 582927.0, 98680.51979220318, 113410.43294783638, 120542.397288013, 140076.0, 141485.0, 913.5067063785614, 972.1687956796978, 1003.0922015576061, 1019.8368261078192, 1022.1516141602452, 17341.306347745947, 18403.17185726619, 18699.906500467412, 18853.717194241824, 19008.42974710761, 38122.809385952896, 50026.74986625044, 50104.747381315756, 50150.49849501458, 55857.0, 55294.72352638211, 79590.6020469894, 79673.80489292782, 81562.59218703868, 83400.58299708462, 6020.307664618625, 6839.931600684128, 7104.360607545345, 7746.4190185737425, 7780.3386712130105, 11926.642200733992, 12375.876241237473, 12576.434060467118, 12762.68093297675, 12960.027997900006, 10570.312929659854, 10887.0, 10962.451877405938, 11183.0, 11214.719632009264, 10474.476276186313, 10646.041856232976, 10792.946035269773, 11037.227394082338, 11146.832797508207, 10915.290506117077, 10949.452527373758, 11017.173711971474, 11242.55029798799, 11411.201215914807, 6889.138857642794, 7134.072570565793, 7204.56772593646, 7244.384227340524, 7349.191588925107, 9143.679971200976, 10853.457327133454, 10935.851735567969, 11029.944850275697, 11076.723081923017], "value": 9157.796192689617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.7274431485857, 1528.4192007037325, 1717.3903264341159, 1820.5357633803378, 1910.6751852185128, 8330.79173020674, 8846.248068914141, 8859.5570221489, 8861.46831190129, 8869.157430044135, 7707.961460192705, 7971.202879712026, 7995.800104997378, 8346.332293416528, 8618.00892897317, 2350.0247397330086, 2382.940426489334, 2386.248331775485, 2387.5344307859973, 2388.164142550111, 2348.0725113580124, 2369.0, 2374.845635033726, 2378.7502312257225, 2399.3761621978324, 2357.257463898875, 2380.143148466551, 2387.152560840894, 2390.0798192695765, 2392.95214095718, 2358.9410264743346, 2365.9171928982405, 2366.7988221001237, 2371.893264803088, 2375.2992867104244, 2297.5519773643978, 2365.9290221293218, 2367.905283788664, 2380.6310021946624, 2381.2618088392655, 8651.437656552303, 8743.169398907094, 8753.511902976446, 8766.60550275239, 8771.079036701181, 4284.892877678052, 4431.711938723973, 5273.2617433559335, 5282.0, 5289.0, 3373.900000486989, 3447.2588393495266, 3565.0552603560077, 3577.338192434408, 3578.320119177374, 858.4505916213628, 1033.405791669793, 1044.8537204791335, 1053.2048303530862, 1054.7890421915647, 11459.312441253469, 11460.71348216293, 11476.598319058876, 11484.770304593945, 11538.538458461568, 4528.660350473728, 4593.816247350135, 4683.320918466803, 4746.2168742157155, 4755.95244047562, 8288.709895153761, 9830.361026533252, 9854.852177217348, 9858.605655773688, 9886.209103271722, 5279.868003299948, 5284.969430960926, 5293.073712100367, 5302.814401495929, 5311.814086507031, 4717.315989181549, 4834.854954351375, 4841.467438581823, 4844.224924012141, 4896.657233993657, 3221.597300337458, 3804.7336686431686, 3919.412088186795, 3942.1721438498234, 3993.3211354069877, 1267.7337759070515, 1271.7392934448417, 1276.3490619783977, 1286.601153642374, 1295.352323838081, 855.9657613695382, 865.3726048614704, 906.3383729877227, 908.2688435809237, 945.8108378324363, 5654.97172514143, 5705.486506214461, 5714.628549144292, 5966.970165149147, 6067.059605761114, 936.824285521666, 949.8812648418948, 949.9192568631605, 966.7438128895848, 990.2325697584286, 3779.8677046303246, 3848.3265428549894, 3861.575226725058, 4010.0, 4017.8593749218635, 10040.447775372424, 10297.691069267934, 10429.113525350278, 10537.315074520131, 10626.256162068736, 10513.001264879824, 10521.947390263, 10522.421266830244, 10534.947325263325, 10550.366977981346, 7677.270659287359, 7941.324987376022, 8011.839763204704, 8020.877077209196, 8021.117677055403, 5531.585131115263, 5538.473844984881, 5616.0, 5658.490735833795, 5794.942050579441, 9237.937637171543, 9416.293777966543, 9618.134367906921, 9713.46575938302, 9749.707508774749, 9055.728328150166, 9601.279904007088, 9868.259880508847, 9908.25688073383, 9975.45135017581, 6513.120728701565, 6712.798616041527, 6768.120144381199, 6968.860622787617, 6989.510734248757, 7782.0, 8080.87878681832, 8137.75586732399, 8177.6320065596, 8181.754547363588, 7428.554286742813, 7460.142083660231, 7526.736564220226, 7554.357879580078, 7572.432067594842, 7063.187733410724, 7226.602536860313, 7280.0535930328715, 7366.594837284001, 7379.667914943733, 6800.761973330909, 6850.6574671267235, 6904.792856214322, 6939.653017349214, 6941.47938904574, 4765.73788441639, 4839.443464001685, 4862.294967229661, 4905.681130726492, 5114.539691427789, 4757.215059515142, 4906.754662266943, 4947.40631124253, 5029.145045342228, 5040.269160971712], "value": 4517.654608336419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.5071682440796, 303.21921053287787, 311.64005573562537, 313.2622673603663, 316.8859210684155, 4388.0, 4699.812007519704, 5439.510444060039, 5505.752241149148, 5518.0, 4512.345709872066, 5021.744563859035, 5027.798888044483, 5234.953009398117, 5342.679439233649, 3322.1030321813096, 3412.65873412658, 3474.7567670263093, 3882.2623701496627, 3990.740601860877, 3383.374075795973, 4070.247004304213, 4080.7551546907134, 4094.529129150156, 4157.272477316473, 3961.663258623006, 4039.939400908989, 4081.4490043844, 4091.0, 4103.363978583309, 3458.2046129390255, 3746.250749850041, 4081.9591804081874, 4093.1813637272367, 4136.317507611256, 2928.4728748825205, 3198.232424218194, 3332.150301673058, 3567.23304489536, 3572.071261472036, 4498.775061246924, 5209.609279304067, 5278.577713782926, 5286.101362768339, 5329.173978033411, 4139.751614903085, 4407.933880991788, 4719.0, 4789.760511974422, 4791.880202994918, 5773.538116950634, 5777.942220577783, 5785.6528608283215, 5796.797112101056, 5805.477507024346, 3598.1004748812798, 3614.042278796121, 3934.4688467056867, 3961.771850726284, 3986.720929534934, 5614.326280846284, 5858.209141765849, 5861.17943487912, 5951.0, 6050.42520960508, 3993.6038376973584, 4006.779627120478, 4008.614874149876, 4010.7794071326357, 4017.296973029708, 4066.6136717011836, 4111.876643700693, 4122.6083522065355, 4123.0, 4129.463169787909, 3941.6452519273403, 4495.901965465105, 4640.262245275304, 4783.976080119647, 4799.616030717534, 4630.513796051433, 4910.8772280693265, 5583.162525621189, 5613.607047506717, 5614.606977511617, 1212.7453234820787, 1303.4395210059765, 1329.9002574806734, 1373.6909195430949, 1404.3189053309136, 766.6243540665146, 779.5400713578903, 885.2121611765534, 892.4110087342452, 918.6646873891116, 4987.80048798044, 5260.500252476008, 5270.604704647167, 5291.523762861361, 5393.325834270716, 4562.634989200856, 4908.969116485578, 5576.609637325349, 5801.187833703285, 6041.124037014608, 4335.609795118455, 5195.636305458657, 5199.740012999335, 5245.632805703564, 5260.316158899395, 2524.255344673289, 2649.4833507466246, 2781.332480204777, 2808.4523517913813, 3023.9848800755854, 5619.775208991595, 5881.41185881417, 5886.499647530008, 5894.557908156906, 5920.703964801743, 5618.747156377973, 5813.180607405405, 5821.27234095738, 5942.504148257742, 5961.612495187799, 5171.974140129275, 5883.264591926009, 5895.759611347747, 5929.851753706105, 5953.880922381615, 4250.513449632, 5493.423190564933, 5694.487496125369, 5895.793647222498, 5940.821775346746, 5555.555555555627, 5818.970905145447, 5819.563532734977, 5821.476067153976, 5833.258368566767, 5651.4348565143155, 5734.627249228787, 5750.773181711523, 6063.181470501602, 6073.453389194994, 3866.0, 3874.457575939314, 3907.452956586137, 3919.0594257378593, 3952.9407058893567, 4793.880152996203, 4919.803207871645, 5778.306603207474, 5794.927938331422, 5982.88034239304, 4764.737939413227, 4852.708837469763, 5271.761136132929, 5487.945120548743, 5794.855128621818, 5635.0702134147405, 5675.8864822704145, 5687.402822703722, 5700.0, 5714.457126572969, 5282.366116066097, 5537.723113844372, 5544.22380866687, 5568.582356323211, 5622.690752008679, 5300.337457817773, 5402.729863506887, 5579.972100139474, 5596.132599447093, 5640.4488765589795, 4971.403431588233, 5239.397469290928, 5553.250311207935, 5574.693391863487, 5601.383847776823], "value": 4103.27002926496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.9536580122292, 722.0396872160024, 770.9383249340053, 810.8216192437669, 821.0844907927662, 15595.454159104434, 15887.44393946212, 15923.92038039811, 15944.123073230981, 15965.962212456183, 14344.56966291013, 14437.855621443783, 14443.638909027279, 14444.711105777878, 14448.0, 677.2753154125088, 696.2550071423578, 696.853660731247, 838.0111468467206, 845.2984023260694, 863.2791618998144, 877.929765618749, 878.2710350409177, 878.964841406343, 879.327314604325, 908.6592527802075, 932.4917919733762, 932.5244125495979, 933.5892207428743, 934.7709811096291, 920.1488623023744, 924.4129977464324, 927.475976073523, 928.03020843219, 928.7492377058156, 525.4351572060051, 544.3957207499673, 544.6269305525727, 686.9107016087877, 687.3916583823352, 11514.0, 12510.687232819253, 12558.560450384193, 14482.0, 14606.050606710636, 14009.159450433006, 14520.0, 14629.561113166623, 14682.412703491847, 14736.926315368462, 11697.3566453845, 11830.704232394259, 11888.346140962243, 11917.10621703367, 12356.814647780291, 3772.2832661794173, 3801.1637439763485, 3813.9618603813883, 3849.6727778138893, 3933.8229779659982, 78646.21353786446, 96399.0360096397, 110864.9999999992, 113355.0, 113772.0, 11039.613613523488, 11171.0, 11182.384968826793, 11227.607033753779, 11578.42107894602, 21780.128794848344, 21973.560528789334, 22047.559048818934, 22089.558208835733, 22152.2246721364, 7978.042634883735, 8065.475744076616, 8078.192180781993, 8085.595720213966, 8147.551884646401, 4328.394024836525, 4340.088581397942, 4444.355568442557, 4551.931721024121, 4583.839565615188, 3286.244163842282, 3458.7233021358734, 3489.8778542750883, 3624.655657712513, 3626.730644274483, 652.7389044382285, 663.5056882622478, 666.6999351265052, 676.4791110844623, 681.2097966359099, 524.7664789168783, 586.8826234753067, 599.7870755881686, 610.767908194892, 630.4861537846732, 8674.956625216833, 8865.335099867407, 8905.0, 9157.682916477328, 9182.449053056838, 591.6006695480534, 605.8273392083236, 620.8292719502083, 626.2015929689682, 627.9622624583257, 3438.2951494943477, 3865.4781604483037, 4063.776492292893, 4399.802008909607, 4419.40338054365, 96550.55174172393, 133924.33037834748, 144788.0, 155719.0, 159855.0, 119442.0, 129295.70704293025, 132413.0, 134327.0, 136740.31629841786, 81604.59197704212, 92460.53769731108, 92842.53578732198, 108644.0, 110304.351303791, 9387.249020078241, 9835.557399916877, 9897.455639939872, 9917.900820991697, 9972.750681233027, 54645.45354546563, 56523.630255125696, 58219.70890145522, 58776.70611646914, 59205.0, 79971.80042299487, 86115.13884861322, 87905.12094879225, 88431.11568884228, 89545.10454895628, 13345.999050071478, 13348.466061357825, 13352.599422017354, 13371.331433428095, 13463.461461541821, 13475.51769305356, 14707.191104489355, 14889.702205956037, 14913.122588126947, 15009.924950375178, 13571.321433928462, 13976.231307278198, 14071.226082565558, 14072.437102516194, 14180.290985450893, 13896.444142234197, 13949.16305021702, 14016.439342426189, 14056.929715351767, 14536.345864436338, 13414.329283535979, 13550.796738049134, 13580.185188888698, 14261.714765704835, 14298.213598252196, 10620.0, 11393.373364465035, 11454.94272528632, 11494.540218391505, 11722.648320550397, 9212.216961558343, 10741.946290268499, 11256.493457794255, 11582.247153934968, 11592.942035289769], "value": 7699.146305053681, "unit": "score"}], "name": "dromaeo_css", "value": 7257.998850889222, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 114.0, 113.0, 114.0, 112.0, 112.0, 112.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 138.0, 178.0, 142.0, 108.0, 109.0, 108.0, 139.0, 113.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 182.0, 186.0, 184.0, 183.0, 183.0, 183.0, 180.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 87.0, 62.0, 56.0, 58.0, 58.0, 81.0, 57.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 91.0, 70.0, 67.0, 69.0, 90.0, 68.0, 69.0, 89.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 135.0, 85.0, 87.0, 84.0, 88.0, 131.0, 87.0, 84.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 92.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 87.0, 86.0, 83.0, 86.0, 86.0, 84.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 55.0, 57.0, 53.0, 53.0, 54.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 77.0, 75.0, 71.0, 68.0, 69.0, 69.0, 74.0, 104.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 83.0, 86.0, 87.0, 85.0, 86.0, 84.0, 87.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 127.0, 146.0, 146.0, 154.0, 152.0, 130.0, 161.0, 156.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 168.0, 169.0, 165.0, 168.0, 166.0, 168.0, 169.0, 167.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 67.0, 70.0, 84.0, 86.0, 84.0, 80.0, 67.0], "value": 74.5, "unit": "score"}], "name": "kraken", "value": 1443.5, "alertThreshold": 2.0}]} 15:36:20 INFO - Return code: 0 15:36:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:36:20 INFO - # TBPL SUCCESS # 15:36:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:36:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:36:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:36:20 INFO - 2016-09-23 15:36:20.595 screenresolution[1675:10544] starting screenresolution argv=screenresolution get 15:36:20 INFO - 2016-09-23 15:36:20.598 screenresolution[1675:10544] Display 0: 1600x1200x32@60 15:36:20 INFO - 2016-09-23 15:36:20.604 screenresolution[1676:10547] starting screenresolution argv=screenresolution list 15:36:20 INFO - Available Modes on Display 0 15:36:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:36:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:36:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:36:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:36:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:36:20 INFO - Intel Iris: 15:36:20 INFO - Chipset Model: Intel Iris 15:36:20 INFO - Type: GPU 15:36:20 INFO - Bus: Built-In 15:36:20 INFO - VRAM (Dynamic, Max): 1536 MB 15:36:20 INFO - Vendor: Intel (0x8086) 15:36:20 INFO - Device ID: 0x0a2e 15:36:20 INFO - Revision ID: 0x0009 15:36:20 INFO - Displays: 15:36:20 INFO - Display: 15:36:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:36:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:36:20 INFO - Display Serial Number: 1600x1200 60 15:36:20 INFO - Main Display: Yes 15:36:20 INFO - Mirror: Off 15:36:20 INFO - Online: Yes 15:36:20 INFO - Rotation: Supported 15:36:20 INFO - Return code: 0 15:36:20 INFO - Running post-action listener: _resource_record_post_action 15:36:20 INFO - [mozharness: 2016-09-23 22:36:20.845674Z] Finished run-tests step (success) 15:36:20 INFO - Running post-run listener: _resource_record_post_run 15:36:20 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32082944; Write bytes: 708072448; Read time: 200; Write time: 2012 15:36:20 INFO - TinderboxPrint: CPU usage
53.5% 15:36:20 INFO - TinderboxPrint: I/O read bytes / time
32,082,944 / 200 15:36:20 INFO - TinderboxPrint: I/O write bytes / time
708,072,448 / 2,012 15:36:20 INFO - TinderboxPrint: CPU idle
2,255.3 (46.5%) 15:36:20 INFO - TinderboxPrint: CPU system
967.9 (20.0%) 15:36:20 INFO - TinderboxPrint: CPU user
1,626.4 (33.5%) 15:36:20 INFO - TinderboxPrint: Swap in / out
435,154,944 / 0 15:36:20 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401332736; Write bytes: 396967424; Read time: 29880; Write time: 857 15:36:20 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30051328; Write bytes: 296244736; Read time: 181; Write time: 1113 15:36:21 INFO - Running post-run listener: _upload_blobber_files 15:36:21 INFO - Blob upload gear active. 15:36:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:21 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 15:36:21 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'] 15:36:21 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 15:36:21 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:23 INFO - (blobuploader) - INFO - Done attempting. 15:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:24 INFO - (blobuploader) - INFO - Done attempting. 15:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:26 INFO - (blobuploader) - INFO - Done attempting. 15:36:26 INFO - (blobuploader) - INFO - Iteration through files over. 15:36:26 INFO - Return code: 0 15:36:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:36:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:36:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/32ddde789a19174c21c997f95b330ccb734c9ae167375d8ff0825a5ab7aa098f83a0ddc02467f92612992250995e91e11286d224587f29b4e5f66d6835cadac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f894a4b464e93ec031e713307744c1f2791c27aff687fa8f9fd94b73323548c949f7b428e9ec460bc92c6247a70afeff92a5cff5e989fadd7cc26b9c075472bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd488e1d5c34eb65310e8316363fc80c590b222d24e3ed1be7813b15ea592ac19b4cf7e51478ad41e77692049913b97a7a2b160c7d6f4a4d13ab5a278e8d7769"} 15:36:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:36:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:36:26 INFO - Contents: 15:36:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/32ddde789a19174c21c997f95b330ccb734c9ae167375d8ff0825a5ab7aa098f83a0ddc02467f92612992250995e91e11286d224587f29b4e5f66d6835cadac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f894a4b464e93ec031e713307744c1f2791c27aff687fa8f9fd94b73323548c949f7b428e9ec460bc92c6247a70afeff92a5cff5e989fadd7cc26b9c075472bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd488e1d5c34eb65310e8316363fc80c590b222d24e3ed1be7813b15ea592ac19b4cf7e51478ad41e77692049913b97a7a2b160c7d6f4a4d13ab5a278e8d7769"} 15:36:26 INFO - Running post-run listener: copy_logs_to_upload_dir 15:36:26 INFO - Copying logs to upload dir... 15:36:26 INFO - mkdir: /builds/slave/test/build/upload/logs 15:36:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.511719 ========= master_lag: 3.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-23 15:36:29.995365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 15:36:30.003248) ========= 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.TRoHYpYqkA/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.BayZ1M26l9/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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/32ddde789a19174c21c997f95b330ccb734c9ae167375d8ff0825a5ab7aa098f83a0ddc02467f92612992250995e91e11286d224587f29b4e5f66d6835cadac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f894a4b464e93ec031e713307744c1f2791c27aff687fa8f9fd94b73323548c949f7b428e9ec460bc92c6247a70afeff92a5cff5e989fadd7cc26b9c075472bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd488e1d5c34eb65310e8316363fc80c590b222d24e3ed1be7813b15ea592ac19b4cf7e51478ad41e77692049913b97a7a2b160c7d6f4a4d13ab5a278e8d7769"} build_url:https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/cCRVym40SUuuMEuoN5TEBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/32ddde789a19174c21c997f95b330ccb734c9ae167375d8ff0825a5ab7aa098f83a0ddc02467f92612992250995e91e11286d224587f29b4e5f66d6835cadac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f894a4b464e93ec031e713307744c1f2791c27aff687fa8f9fd94b73323548c949f7b428e9ec460bc92c6247a70afeff92a5cff5e989fadd7cc26b9c075472bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd488e1d5c34eb65310e8316363fc80c590b222d24e3ed1be7813b15ea592ac19b4cf7e51478ad41e77692049913b97a7a2b160c7d6f4a4d13ab5a278e8d7769"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 15:36:30.059340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:36:30.059704) ========= 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.TRoHYpYqkA/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.BayZ1M26l9/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.005154 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:36:30.112417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 15:36:30.112721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 15:36:30.113028) ========= ========= Total master_lag: 3.56 =========