builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1481732028.93 results: success (0) buildid: 20161214064000 builduid: 37fba335eab44119a68e556670742965 revision: 2ff0593e62770ffecbf993063a9c0d271beaeb03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:48.932887) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:48.933327) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:48.933598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:48.959779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:48.960117) ========= 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.MiP033ofpJ/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.o8QjhxOUDv/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-12-14 08:13:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2016-12-14 08:13:49 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:49.114523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:49.114835) ========= 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.MiP033ofpJ/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.o8QjhxOUDv/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.028412 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:49.164818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 08:13:49.165213) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ff0593e62770ffecbf993063a9c0d271beaeb03 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2ff0593e62770ffecbf993063a9c0d271beaeb03 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MiP033ofpJ/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.o8QjhxOUDv/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-12-14 08:13:49,257 truncating revision to first 12 chars 2016-12-14 08:13:49,257 Setting DEBUG logging. 2016-12-14 08:13:49,257 attempt 1/10 2016-12-14 08:13:49,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ff0593e6277?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 08:13:50,618 unpacking tar archive at: mozilla-central-2ff0593e6277/testing/mozharness/ program finished with exit code 0 elapsedTime=1.640485 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 08:13:50.829046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:50.829366) ========= script_repo_revision: 2ff0593e62770ffecbf993063a9c0d271beaeb03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:50.829743) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:50.830020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:13:50.849747) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-14 08:13:50.850140) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MiP033ofpJ/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.o8QjhxOUDv/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:13:51 INFO - MultiFileLogger online at 20161214 08:13:51 in /builds/slave/test 08:13:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:13:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:51 INFO - {'append_to_log': False, 08:13:51 INFO - 'base_work_dir': '/builds/slave/test', 08:13:51 INFO - 'blob_upload_branch': 'Firefox', 08:13:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:51 INFO - 'branch': 'Firefox', 08:13:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:51 INFO - 'config_files': ('talos/mac_config.py',), 08:13:51 INFO - 'default_actions': ('clobber', 08:13:51 INFO - 'read-buildbot-config', 08:13:51 INFO - 'download-and-extract', 08:13:51 INFO - 'populate-webroot', 08:13:51 INFO - 'create-virtualenv', 08:13:51 INFO - 'install', 08:13:51 INFO - 'run-tests'), 08:13:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:51 INFO - 'download_minidump_stackwalk': True, 08:13:51 INFO - 'download_symbols': 'ondemand', 08:13:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:51 INFO - 'installer_path': 'installer.exe', 08:13:51 INFO - 'log_level': 'info', 08:13:51 INFO - 'log_name': 'talos', 08:13:51 INFO - 'log_to_console': True, 08:13:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:13:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:13:51 INFO - 'opt_config_files': (), 08:13:51 INFO - 'pip_index': False, 08:13:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:51 INFO - 'cmd': ('bash', 08:13:51 INFO - '-c', 08:13:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:51 INFO - 'enabled': True, 08:13:51 INFO - 'halt_on_failure': False, 08:13:51 INFO - 'name': 'check_screen_resolution'},), 08:13:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:51 INFO - 'cmd': ('bash', 08:13:51 INFO - '-c', 08:13:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:51 INFO - 'enabled': True, 08:13:51 INFO - 'halt_on_failure': False, 08:13:51 INFO - 'name': 'check_screen_resolution'},), 08:13:51 INFO - 'run_cmd_checks_enabled': True, 08:13:51 INFO - 'sps_profile': False, 08:13:51 INFO - 'sps_profile_interval': 0, 08:13:51 INFO - 'suite': 'dromaeojs', 08:13:51 INFO - 'system_bits': '32', 08:13:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:51 INFO - 'title': 't-yosemite-r7-0032', 08:13:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:51 INFO - 'use_talos_json': True, 08:13:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:51 INFO - 'work_dir': 'build'} 08:13:51 INFO - [mozharness: 2016-12-14 16:13:51.053955Z] Running clobber step. 08:13:51 INFO - Running pre-action listener: _resource_record_pre_action 08:13:51 INFO - Running main action method: clobber 08:13:51 INFO - rmtree: /builds/slave/test/build 08:13:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:53 INFO - Running post-action listener: _resource_record_post_action 08:13:53 INFO - [mozharness: 2016-12-14 16:13:53.316107Z] Finished clobber step (success) 08:13:53 INFO - [mozharness: 2016-12-14 16:13:53.316236Z] Running read-buildbot-config step. 08:13:53 INFO - Running pre-action listener: _resource_record_pre_action 08:13:53 INFO - Running main action method: read_buildbot_config 08:13:53 INFO - Using buildbot properties: 08:13:53 INFO - { 08:13:53 INFO - "project": "", 08:13:53 INFO - "product": "firefox", 08:13:53 INFO - "script_repo_revision": "production", 08:13:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:13:53 INFO - "repository": "", 08:13:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:13:53 INFO - "buildid": "20161214064000", 08:13:53 INFO - "pgo_build": "False", 08:13:53 INFO - "basedir": "/builds/slave/test", 08:13:53 INFO - "buildnumber": 49, 08:13:53 INFO - "slavename": "t-yosemite-r7-0032", 08:13:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:13:53 INFO - "platform": "yosemite_r7", 08:13:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:13:53 INFO - "branch": "mozilla-central", 08:13:53 INFO - "repo_path": "mozilla-central", 08:13:53 INFO - "revision": "2ff0593e62770ffecbf993063a9c0d271beaeb03", 08:13:53 INFO - "stage_platform": "macosx64", 08:13:53 INFO - "builduid": "37fba335eab44119a68e556670742965", 08:13:53 INFO - "slavebuilddir": "test" 08:13:53 INFO - } 08:13:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:13:53 INFO - Running post-action listener: _resource_record_post_action 08:13:53 INFO - [mozharness: 2016-12-14 16:13:53.319402Z] Finished read-buildbot-config step (success) 08:13:53 INFO - [mozharness: 2016-12-14 16:13:53.319509Z] Running download-and-extract step. 08:13:53 INFO - Running pre-action listener: _resource_record_pre_action 08:13:53 INFO - Running main action method: download_and_extract 08:13:53 INFO - mkdir: /builds/slave/test/build/tests 08:13: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')]} 08:13:53 INFO - trying https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:13:53 INFO - Downloading https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:13:54 INFO - Downloaded 1199 bytes. 08:13:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:13:54 INFO - Using the following test package requirements: 08:13:54 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:13:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:13:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:13:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'jsshell-mac.zip'], 08:13:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:13:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:13:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:13:54 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:13:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:13:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:54 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:13:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:13:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:13:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:13:54 INFO - Fetch https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:13:55 INFO - Expected file size: 16276119 08:13:55 INFO - Obtained file size: 16276119 08:14:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:14:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:14:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:14:02 INFO - Fetch https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:14:03 INFO - Expected file size: 16276119 08:14:03 INFO - Obtained file size: 16276119 08:14:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:14:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:14:09 INFO - Fetch https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:14:10 INFO - Expected file size: 14409734 08:14:10 INFO - Obtained file size: 14409734 08:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:10 INFO - trying https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:14:10 INFO - Downloading https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:14:12 INFO - Downloaded 69667664 bytes. 08:14:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:14:12 INFO - mkdir: /builds/slave/test/properties 08:14:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:12 INFO - Contents: 08:14:12 INFO - build_url:https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:14:13 INFO - Running post-action listener: _resource_record_post_action 08:14:13 INFO - Running post-action listener: set_extra_try_arguments 08:14:13 INFO - [mozharness: 2016-12-14 16:14:13.549941Z] Finished download-and-extract step (success) 08:14:13 INFO - [mozharness: 2016-12-14 16:14:13.550092Z] Running populate-webroot step. 08:14:13 INFO - Running pre-action listener: _resource_record_pre_action 08:14:13 INFO - Running main action method: populate_webroot 08:14:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:13 INFO - '--tppagecycles', 08:14:13 INFO - '7'], 08:14:13 INFO - 'tests': ['tsvgm']}}, 08:14:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:14:13 INFO - 'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:14:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:14:13 INFO - 'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['damp', 'tps']}, 08:14:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:14:13 INFO - 'tests': ['damp', 'tps']}, 08:14:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['dromaeo_dom']}, 08:14:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['basic_compositor_video']}, 08:14:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['a11yr', 08:14:13 INFO - 'ts_paint', 08:14:13 INFO - 'tpaint', 08:14:13 INFO - 'sessionrestore', 08:14:13 INFO - 'sessionrestore_no_auto_restore', 08:14:13 INFO - 'tabpaint']}, 08:14:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:13 INFO - 'ts_paint', 08:14:13 INFO - 'tpaint', 08:14:13 INFO - 'sessionrestore', 08:14:13 INFO - 'sessionrestore_no_auto_restore', 08:14:13 INFO - 'tabpaint']}, 08:14:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:13 INFO - 'ts_paint', 08:14:13 INFO - 'tpaint', 08:14:13 INFO - 'sessionrestore', 08:14:13 INFO - 'sessionrestore_no_auto_restore', 08:14:13 INFO - 'tabpaint']}, 08:14:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:13 INFO - 'ts_paint', 08:14:13 INFO - 'tpaint', 08:14:13 INFO - 'sessionrestore', 08:14:13 INFO - 'sessionrestore_no_auto_restore', 08:14:13 INFO - 'tabpaint']}, 08:14:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['a11yr', 08:14:13 INFO - 'ts_paint', 08:14:13 INFO - 'tpaint', 08:14:13 INFO - 'sessionrestore', 08:14:13 INFO - 'sessionrestore_no_auto_restore', 08:14:13 INFO - 'tabpaint']}, 08:14:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['a11yr', 08:14:13 INFO - 'ts_paint', 08:14:13 INFO - 'tpaint', 08:14:13 INFO - 'sessionrestore', 08:14:13 INFO - 'sessionrestore_no_auto_restore', 08:14:13 INFO - 'tabpaint']}, 08:14:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['tsvgx', 08:14:13 INFO - 'tsvgr_opacity', 08:14:13 INFO - 'tart', 08:14:13 INFO - 'tscrollx', 08:14:13 INFO - 'cart', 08:14:13 INFO - 'tsvg_static']}, 08:14:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:13 INFO - 'tsvgr_opacity', 08:14:13 INFO - 'tart', 08:14:13 INFO - 'tscrollx', 08:14:13 INFO - 'cart', 08:14:13 INFO - 'tsvg_static']}, 08:14:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:14:13 INFO - 'talos_options': ['--disable-e10s'], 08:14:13 INFO - 'tests': ['tp5o']}, 08:14:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:14:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:14:13 INFO - 'talos_options': ['--disable-e10s', 08:14:13 INFO - '--xperf_path', 08:14:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:13 INFO - 'tests': ['tp5n']}, 08:14:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:14:13 INFO - 'talos_options': ['--xperf_path', 08:14:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:13 INFO - 'tests': ['tp5n']}}, 08:14:13 INFO - 'talos.zip': {'path': '', 08:14:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:13 INFO - Running post-action listener: _resource_record_post_action 08:14:13 INFO - [mozharness: 2016-12-14 16:14:13.568144Z] Finished populate-webroot step (success) 08:14:13 INFO - [mozharness: 2016-12-14 16:14:13.568281Z] Running create-virtualenv step. 08:14:13 INFO - Running pre-action listener: _resource_record_pre_action 08:14:13 INFO - Running main action method: create_virtualenv 08:14:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:13 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 08:14:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:13 INFO - Using real prefix '/tools/python27' 08:14:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:17 INFO - Installing pip.................done. 08:14:17 INFO - Return code: 0 08:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:14:17 INFO - Reading from file tmpfile_stdout 08:14:17 INFO - Output received: 08:14:17 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) 08:14:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:17 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')]} 08:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:17 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')]} 08:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:17 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:17 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 08:14:17 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 08:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:17 INFO - 'HOME': '/Users/cltbld', 08:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:17 INFO - 'LOGNAME': 'cltbld', 08:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:17 INFO - 'MOZ_NO_REMOTE': '1', 08:14:17 INFO - 'NO_EM_RESTART': '1', 08:14:17 INFO - 'PAGER': '/bin/cat', 08:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:17 INFO - 'PWD': '/builds/slave/test', 08:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:17 INFO - 'SHELL': '/bin/bash', 08:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:17 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:17 INFO - 'USER': 'cltbld', 08:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:17 INFO - 'XPC_FLAGS': '0x0', 08:14:17 INFO - 'XPC_SERVICE_NAME': '0', 08:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:17 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 08:14:17 INFO - Cleaning up... 08:14:17 INFO - Return code: 0 08:14:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:17 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')]} 08:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:17 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')]} 08:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:17 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:17 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 08:14:17 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 08:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:17 INFO - 'HOME': '/Users/cltbld', 08:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:17 INFO - 'LOGNAME': 'cltbld', 08:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:17 INFO - 'MOZ_NO_REMOTE': '1', 08:14:17 INFO - 'NO_EM_RESTART': '1', 08:14:17 INFO - 'PAGER': '/bin/cat', 08:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:17 INFO - 'PWD': '/builds/slave/test', 08:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:17 INFO - 'SHELL': '/bin/bash', 08:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:17 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:17 INFO - 'USER': 'cltbld', 08:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:17 INFO - 'XPC_FLAGS': '0x0', 08:14:17 INFO - 'XPC_SERVICE_NAME': '0', 08:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 INFO - Downloading/unpacking psutil>=3.1.1 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:21 INFO - Installing collected packages: psutil 08:14:21 INFO - Running setup.py install for psutil 08:14:21 INFO - building 'psutil._psutil_osx' extension 08:14:21 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 08:14:22 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 08:14:22 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 08:14:22 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 08:14:22 INFO - building 'psutil._psutil_posix' extension 08:14:22 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 08:14:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:14:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:14:22 INFO - ^ 08:14:22 INFO - 1 warning generated. 08:14:22 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 08:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:22 INFO - Successfully installed psutil 08:14:22 INFO - Cleaning up... 08:14:22 INFO - Return code: 0 08:14:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:22 INFO - 'HOME': '/Users/cltbld', 08:14:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:22 INFO - 'LOGNAME': 'cltbld', 08:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:22 INFO - 'MOZ_NO_REMOTE': '1', 08:14:22 INFO - 'NO_EM_RESTART': '1', 08:14:22 INFO - 'PAGER': '/bin/cat', 08:14:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:22 INFO - 'PWD': '/builds/slave/test', 08:14:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:22 INFO - 'SHELL': '/bin/bash', 08:14:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:22 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:22 INFO - 'USER': 'cltbld', 08:14:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:22 INFO - 'XPC_FLAGS': '0x0', 08:14:22 INFO - 'XPC_SERVICE_NAME': '0', 08:14:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:23 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 08:14:23 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 08:14:23 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 08:14:23 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 08:14:23 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 08:14:23 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 08:14:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:25 INFO - Installing collected packages: mozsystemmonitor 08:14:25 INFO - Running setup.py install for mozsystemmonitor 08:14:25 INFO - Successfully installed mozsystemmonitor 08:14:25 INFO - Cleaning up... 08:14:25 INFO - Return code: 0 08:14:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:25 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')]} 08:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 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')]} 08:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:25 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 08:14:25 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 08:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:25 INFO - 'HOME': '/Users/cltbld', 08:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:25 INFO - 'LOGNAME': 'cltbld', 08:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:25 INFO - 'MOZ_NO_REMOTE': '1', 08:14:25 INFO - 'NO_EM_RESTART': '1', 08:14:25 INFO - 'PAGER': '/bin/cat', 08:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:25 INFO - 'PWD': '/builds/slave/test', 08:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:25 INFO - 'SHELL': '/bin/bash', 08:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:25 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:25 INFO - 'USER': 'cltbld', 08:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:25 INFO - 'XPC_FLAGS': '0x0', 08:14:25 INFO - 'XPC_SERVICE_NAME': '0', 08:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:26 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:29 INFO - warning: no files found matching '*.txt' 08:14:29 INFO - no previously-included directories found matching 'build' 08:14:29 INFO - no previously-included directories found matching 'dist' 08:14:29 INFO - no previously-included directories found matching '.git*' 08:14:29 INFO - Installing collected packages: jsonschema, functools32 08:14:29 INFO - Running setup.py install for functools32 08:14:29 INFO - warning: no files found matching '*.txt' 08:14:29 INFO - no previously-included directories found matching 'build' 08:14:29 INFO - no previously-included directories found matching 'dist' 08:14:29 INFO - no previously-included directories found matching '.git*' 08:14:29 INFO - Successfully installed jsonschema functools32 08:14:29 INFO - Cleaning up... 08:14:29 INFO - Return code: 0 08:14:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:29 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 08:14:29 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 08:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:29 INFO - 'HOME': '/Users/cltbld', 08:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:29 INFO - 'LOGNAME': 'cltbld', 08:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:29 INFO - 'MOZ_NO_REMOTE': '1', 08:14:29 INFO - 'NO_EM_RESTART': '1', 08:14:29 INFO - 'PAGER': '/bin/cat', 08:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:29 INFO - 'PWD': '/builds/slave/test', 08:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:29 INFO - 'SHELL': '/bin/bash', 08:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:29 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:29 INFO - 'USER': 'cltbld', 08:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:29 INFO - 'XPC_FLAGS': '0x0', 08:14:29 INFO - 'XPC_SERVICE_NAME': '0', 08:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:29 INFO - Cleaning up... 08:14:29 INFO - Return code: 0 08:14:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:29 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 08:14:29 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 08:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:29 INFO - 'HOME': '/Users/cltbld', 08:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:29 INFO - 'LOGNAME': 'cltbld', 08:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:29 INFO - 'MOZ_NO_REMOTE': '1', 08:14:29 INFO - 'NO_EM_RESTART': '1', 08:14:29 INFO - 'PAGER': '/bin/cat', 08:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:29 INFO - 'PWD': '/builds/slave/test', 08:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:29 INFO - 'SHELL': '/bin/bash', 08:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:29 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:29 INFO - 'USER': 'cltbld', 08:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:29 INFO - 'XPC_FLAGS': '0x0', 08:14:29 INFO - 'XPC_SERVICE_NAME': '0', 08:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:30 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 08:14:30 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 08:14:30 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 08:14:30 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 08:14:30 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 08:14:30 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 08:14:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:32 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 08:14:32 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 08:14:32 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 08:14:32 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 08:14:32 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 08:14:32 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 08:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:33 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 08:14:33 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 08:14:33 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 08:14:33 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 08:14:33 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 08:14:33 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 08:14:33 INFO - Downloading docopt-0.6.1.tar.gz 08:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:34 INFO - Running setup.py install for blobuploader 08:14:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:34 INFO - Running setup.py install for requests 08:14:34 INFO - Running setup.py install for docopt 08:14:34 INFO - Successfully installed blobuploader requests docopt 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:34 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')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:34 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 08:14:34 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 08:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:34 INFO - 'HOME': '/Users/cltbld', 08:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PAGER': '/bin/cat', 08:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - 'XPC_FLAGS': '0x0', 08:14:34 INFO - 'XPC_SERVICE_NAME': '0', 08:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ZtCKnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pQ0Bav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ZttLZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-jTDnTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-IJVmse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-oKYD0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Buoiyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-MqYiLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SwT90O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-u5MMOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-R0kIFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-dl1oLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-R40vm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lOZJcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-JYwKsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-E65fm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-K6mYMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:36 INFO - Running setup.py install for manifestparser 08:14:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:37 INFO - Running setup.py install for mozcrash 08:14:37 INFO - Running setup.py install for mozdebug 08:14:37 INFO - Running setup.py install for mozdevice 08:14:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:37 INFO - Running setup.py install for mozfile 08:14:37 INFO - Running setup.py install for mozhttpd 08:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:37 INFO - Running setup.py install for mozinfo 08:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:37 INFO - Running setup.py install for mozInstall 08:14:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Running setup.py install for mozleak 08:14:38 INFO - Running setup.py install for mozlog 08:14:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Running setup.py install for moznetwork 08:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Running setup.py install for mozprocess 08:14:38 INFO - Running setup.py install for mozprofile 08:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:38 INFO - Running setup.py install for mozrunner 08:14:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:39 INFO - Running setup.py install for mozscreenshot 08:14:39 INFO - Running setup.py install for moztest 08:14:39 INFO - Running setup.py install for mozversion 08:14:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:39 INFO - Cleaning up... 08:14:39 INFO - Return code: 0 08:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:39 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')]} 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:39 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')]} 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:39 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:39 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 08:14:39 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 08:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:39 INFO - 'HOME': '/Users/cltbld', 08:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:39 INFO - 'LOGNAME': 'cltbld', 08:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:39 INFO - 'MOZ_NO_REMOTE': '1', 08:14:39 INFO - 'NO_EM_RESTART': '1', 08:14:39 INFO - 'PAGER': '/bin/cat', 08:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:39 INFO - 'PWD': '/builds/slave/test', 08:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:39 INFO - 'SHELL': '/bin/bash', 08:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:39 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:39 INFO - 'USER': 'cltbld', 08:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:39 INFO - 'XPC_FLAGS': '0x0', 08:14:39 INFO - 'XPC_SERVICE_NAME': '0', 08:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-uiXk_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:39 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)) 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-r_w0XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-oIhTy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-TqL0ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-y5my_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-oofNUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_tkyVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-YlckSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-O7IfeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-tnZJbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-NfqJIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:40 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)) 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6A094j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:41 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)) 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-I1m_6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:41 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)) 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-TlEFsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wRjCzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:41 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)) 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kc1uNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:41 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)) 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qV7ipc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:41 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)) 08:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:41 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)) 08:14:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:44 INFO - Downloading blessings-1.6.tar.gz 08:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:44 INFO - Installing collected packages: blessings 08:14:44 INFO - Running setup.py install for blessings 08:14:44 INFO - Successfully installed blessings 08:14:44 INFO - Cleaning up... 08:14:44 INFO - Return code: 0 08:14:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:44 INFO - Reading from file tmpfile_stdout 08:14:44 INFO - Current package versions: 08:14:44 INFO - blessings == 1.6 08:14:44 INFO - blobuploader == 1.2.4 08:14:44 INFO - docopt == 0.6.1 08:14:44 INFO - functools32 == 3.2.3-2 08:14:44 INFO - jsonschema == 2.5.1 08:14:44 INFO - manifestparser == 1.1 08:14:44 INFO - mozInstall == 1.12 08:14:44 INFO - mozcrash == 1.0 08:14:44 INFO - mozdebug == 0.1 08:14:44 INFO - mozdevice == 0.49 08:14:44 INFO - mozfile == 1.2 08:14:44 INFO - mozhttpd == 0.7 08:14:44 INFO - mozinfo == 0.9 08:14:44 INFO - mozleak == 0.1 08:14:44 INFO - mozlog == 3.4 08:14:44 INFO - moznetwork == 0.27 08:14:44 INFO - mozprocess == 0.23 08:14:44 INFO - mozprofile == 0.28 08:14:44 INFO - mozrunner == 6.13 08:14:44 INFO - mozscreenshot == 0.1 08:14:44 INFO - mozsystemmonitor == 0.3 08:14:44 INFO - moztest == 0.7 08:14:44 INFO - mozversion == 1.4 08:14:44 INFO - psutil == 3.1.1 08:14:44 INFO - requests == 1.2.3 08:14:44 INFO - wsgiref == 0.1.2 08:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:45 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 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:45 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 08:14:45 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 08:14:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:45 INFO - 'HOME': '/Users/cltbld', 08:14:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PAGER': '/bin/cat', 08:14:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:45 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - 'XPC_FLAGS': '0x0', 08:14:45 INFO - 'XPC_SERVICE_NAME': '0', 08:14:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 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)) 08:14:45 INFO - Cleaning up... 08:14:45 INFO - Return code: 0 08:14:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105de73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342595f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, '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.MiP033ofpJ/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.o8QjhxOUDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:14:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:14:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:45 INFO - 'HOME': '/Users/cltbld', 08:14:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PAGER': '/bin/cat', 08:14:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:14:45 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:14:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - 'XPC_FLAGS': '0x0', 08:14:45 INFO - 'XPC_SERVICE_NAME': '0', 08:14:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:46 INFO - Cleaning up... 08:14:46 INFO - Return code: 0 08:14:46 INFO - Running post-action listener: _resource_record_post_action 08:14:46 INFO - Running post-action listener: _start_resource_monitoring 08:14:46 INFO - Starting resource monitoring. 08:14:46 INFO - [mozharness: 2016-12-14 16:14:46.201978Z] Finished create-virtualenv step (success) 08:14:46 INFO - [mozharness: 2016-12-14 16:14:46.202963Z] Running install step. 08:14:46 INFO - Running pre-action listener: _resource_record_pre_action 08:14:46 INFO - Running main action method: install 08:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:46 INFO - Reading from file tmpfile_stdout 08:14:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:46 INFO - Reading from file tmpfile_stdout 08:14:46 INFO - Output received: 08:14:46 INFO - Usage: mozinstall [options] installer 08:14:46 INFO - Options: 08:14:46 INFO - -h, --help show this help message and exit 08:14:46 INFO - -d DEST, --destination=DEST 08:14:46 INFO - Directory to install application into. [default: 08:14:46 INFO - "/builds/slave/test"] 08:14:46 INFO - --app=APP Application being installed. [default: firefox] 08:14:46 INFO - mkdir: /builds/slave/test/build/application 08:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:15:08 INFO - Reading from file tmpfile_stdout 08:15:08 INFO - Output received: 08:15:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:15:08 INFO - Running post-action listener: _resource_record_post_action 08:15:08 INFO - [mozharness: 2016-12-14 16:15:08.345734Z] Finished install step (success) 08:15:08 INFO - [mozharness: 2016-12-14 16:15:08.345839Z] Running run-tests step. 08:15:08 INFO - Running pre-action listener: _resource_record_pre_action 08:15:08 INFO - Running main action method: run_tests 08:15:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:08 INFO - 2016-12-14 08:15:08.360 screenresolution[1624:7257] starting screenresolution argv=screenresolution get 08:15:08 INFO - 2016-12-14 08:15:08.362 screenresolution[1624:7257] Display 0: 1600x1200x32@60 08:15:08 INFO - 2016-12-14 08:15:08.368 screenresolution[1625:7259] starting screenresolution argv=screenresolution list 08:15:08 INFO - Available Modes on Display 0 08:15:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:08 INFO - Intel Iris: 08:15:08 INFO - Chipset Model: Intel Iris 08:15:08 INFO - Type: GPU 08:15:08 INFO - Bus: Built-In 08:15:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:15:08 INFO - Vendor: Intel (0x8086) 08:15:08 INFO - Device ID: 0x0a2e 08:15:08 INFO - Revision ID: 0x0009 08:15:08 INFO - Displays: 08:15:08 INFO - Display: 08:15:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:08 INFO - Display Serial Number: 1600x1200 60 08:15:08 INFO - Main Display: Yes 08:15:08 INFO - Mirror: Off 08:15:08 INFO - Online: Yes 08:15:08 INFO - Rotation: Supported 08:15:08 INFO - Return code: 0 08:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:08 INFO - Python 2.7.3 08:15:08 INFO - Return code: 0 08:15:08 INFO - grabbing minidump binary from tooltool 08:15:08 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')]} 08:15:08 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 0x105bfcd30>, '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 0x105a63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bf4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:08 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 08:15:08 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 08:15:08 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 08:15:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:08 INFO - Return code: 0 08:15:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:15:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:15:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 08:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 08:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MiP033ofpJ/Render', 08:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:08 INFO - 'HOME': '/Users/cltbld', 08:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:08 INFO - 'LOGNAME': 'cltbld', 08:15:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:08 INFO - 'MOZ_NO_REMOTE': '1', 08:15:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:08 INFO - 'NO_EM_RESTART': '1', 08:15:08 INFO - 'PAGER': '/bin/cat', 08:15:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:08 INFO - 'PWD': '/builds/slave/test', 08:15:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:08 INFO - 'SHELL': '/bin/bash', 08:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8QjhxOUDv/Listeners', 08:15:08 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:08 INFO - 'USER': 'cltbld', 08:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:08 INFO - 'XPC_FLAGS': '0x0', 08:15:08 INFO - 'XPC_SERVICE_NAME': '0', 08:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 08:15:08 INFO - mozversion application_buildid: 20161214064000 08:15:08 INFO - mozversion application_changeset: 2ff0593e62770ffecbf993063a9c0d271beaeb03 08:15:08 INFO - mozversion application_display_name: Nightly 08:15:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:08 INFO - mozversion application_name: Firefox 08:15:08 INFO - mozversion application_remotingname: firefox 08:15:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:15:08 INFO - mozversion application_vendor: Mozilla 08:15:08 INFO - mozversion application_version: 53.0a1 08:15:08 INFO - mozversion platform_buildid: 20161214064000 08:15:08 INFO - mozversion platform_changeset: 2ff0593e62770ffecbf993063a9c0d271beaeb03 08:15:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:15:08 INFO - mozversion platform_version: 53.0a1 08:15:08 INFO - using testdate: 1481732108 08:15:08 INFO - actual date: 1481732108 08:15:08 INFO - starting webserver on 'localhost:49236' 08:15:08 INFO - SUITE-START | Running 2 tests 08:15:08 INFO - TEST-START | dromaeo_css 08:15:08 INFO - operating with platform_type : mac_ 08:15:08 INFO - Initialising browser for dromaeo_css test... 08:15:08 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpVE6DT8/profile http://localhost:49236/getInfo.html) 08:15:11 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 08:15:11 INFO - PROCESS | 1635 | colorDepth:24 08:15:11 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 08:15:11 INFO - PROCESS | 1635 | __metrics 08:15:11 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:15:11 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:12 INFO - TEST-INFO | 1635: exit 0 08:15:12 INFO - Browser initialized. 08:15:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:12 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpVE6DT8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:24 INFO - PROCESS | 1637 | RSS: Main: 236916736 08:15:24 INFO - PROCESS | 1637 | 08:16:15 INFO - PROCESS | 1637 | 1481732175076 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] 08:18:28 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:18:29 INFO - PROCESS | 1637 | RSS: Main: 370483200 08:18:29 INFO - PROCESS | 1637 | 08:21:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:21:33 INFO - PROCESS | 1637 | RSS: Main: 370794496 08:21:33 INFO - PROCESS | 1637 | 08:24:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 08:24:36 INFO - PROCESS | 1637 | RSS: Main: 339316736 08:24:36 INFO - PROCESS | 1637 | 08:27:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 08:27:39 INFO - PROCESS | 1637 | RSS: Main: 341364736 08:27:39 INFO - PROCESS | 1637 | 08:30:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:30:43 INFO - PROCESS | 1637 | RSS: Main: 332259328 08:30:43 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:33:46 INFO - PROCESS | 1637 | RSS: Main: 478142464 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | __start_tp_report 08:33:46 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 08:33:46 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 08:33:46 INFO - PROCESS | 1637 | |i|pagename|runs| 08:33:46 INFO - PROCESS | 1637 | |0;dojo.html;3117.4856148735457;3280.917977050575;3292.3250733599607;3322.053214833773;3325.2185736351953;5487.5609951203905;5526.06056970315;5587.60886737928;5602.299712535933;5621.0444224481835;4486.551344865512;5554.2779438673015;5644.294463192101;5650.011248031598;5693.231413759131;4172.916541669165;4319.913601727963;5094.898102037957;5138.460461651529;5158.148905430599;5062.949370506285;5130.38435387754;5148.304978827867;5157.871053223681;5163.896722065557;4280.4221430107;5000.899982000358;5183.714895680736;5183.766730497136;5190.740462976855;5069.695818250917;5097;5188.9881473112755;5189.66267192635;5221;4973.229149481836;4982.277569752402;5022;5070.264811602334;5129.179331306973;5404.83785486436;5440.646357986758;5478.178273259004;5478.233047373371;5484.478974497416;5922.58541902067;6011.57918945674;6027.819165425044;6031.668258245794;6047.334793172748;6055.939440605582;6064.727087281083;6129.601575897597;6144.494598823272;6205.410486003822;5763.85590360236;5768.625039372428;5795.275590551181;5808.099744539603;5812;6275.246970363494;6281.120643109968;6283;6298.590591611531;6317.210348706411;5790.478856902899;5876.265466816648;5964;6011.158437818709;6048.243969503812;6117.908231376533;6121.767890854219;6125.41859352575;6135.69203737716;6145.156453064153;6099.099188574522;6117.877642447215;6119.84700382494;6134.141220229171;6135.785247516315;5170.224466330081;6124.899720463051;6124.971343706056;6136.325004249529;6189.938100619026;4882.609391248691;4883.584895283941;4892.951070489321;4914.483979182206;4952.009598080326;4278.7004909656025;4299.290617048152;4327.285997810326;4330.350447432847;4348.5216626171095;5527.778888844482;5587.608867379326;5598.888022239614;5637.182608521742;5698.886022279531;5082.542571168613;6127.172831667757;6132.814448934737;6153.692315384213;6197.03945888388;5654.491095801398;5669.177969194444;5670.121131224667;5670.716464176775;5690.630109042899;5258.342707161605;5350.304460420199;5370.70461124634;5373.328333958255;5392.73036348181;6118.131909153847;6127.678242056309;6151.6001459904965;6151.630902145886;6154.753809847556;6119.258838873971;6119.663418512025;6151.231096112986;6152.077188421773;6160.507159427325;6209;6244.906326405016;6274.717637706223;6283.842903927439;6299.685015749103;5982.790602328898;6056.333803281724;6110.602810817282;6126.632402055891;6133.509319254538;6077.848053798691;6114.358196333866;6116.204893363834;6116.449519543263;6143.112737013596;5242.951409717995;5916.26046744157;5916.319623243382;6018.976773948527;6094.8171554853425;5987.461128498456;6039.939600604113;6043.879122417615;6055.878882422238;6066.211392518944;5689.203511508309;5746.425357464387;5782.959067367914;5812.854678633068;5846.386129456346;6053.122297266959;6072.1498990140535;6085.756569737161;6087.543434242361;6092.116643086816;5896.587238893237;5900.5574581907385;5909.6158749681135;5926.525877929842;5942.405759424023 08:33:46 INFO - PROCESS | 1637 | |1;ext.html;423.94064830923674;442.84057739213875;454.3729653078749;464.8256903661127;503.5694481218556;25549.744502554968;39374.01564960877;40646.39030414539;40707.79646101769;40806.79596602013;41642.7917860411;42116.789416052874;42144;42156.36765448513;42175.57824421755;9303.255739540837;9511.619535218582;9519.333646644738;9525.333226674136;9525.618975240983;8589.44168629037;8836.293096552261;11173.385463799488;11439.142064345166;11443.313401195956;11452.198346115776;11522.481488333045;11527.481263343128;11528.481218345152;11528.596499122532;11340.659780206566;11410.20128590999;11434.94282528582;11442.313461192354;11463.656090317261;8393.370497212672;8624.65501379944;11004.119670426348;11312.604058857984;11316.717082072932;39882;40252;40255.79232622997;40304.36499802502;40317.79841100776;3352.6814952579466;3380.622094387774;3420.26464310172;3948.506436695413;4004.8598299059395;29822.70177298221;29970.55044174339;30076.69923300761;31036.22409439782;31111.37777244465;3141.4816555268353;3141.4816555268353;3146.229173852421;3161.462551366273;3250.252441938344;339500;340151.29924350465;340550;340714.2964285188;349249;56242;57993;58409.70795146082;58480.4151958475;58489.4151058484;58323.70838145782;59167.70416147892;60358.698206508685;60433.39566604278;60587;15339.463118791013;15852.890297679282;15867.444639437565;15874.52376428709;15902.045877247403;10502.73743156412;11062.834057489144;12413.317267550372;12437.253764774143;12482.687932801753;14108.717825643635;15814.76277855833;16203.756943645854;16228.350865965465;16562.83437165613;5546.944530554723;6694.464442844561;6729.5625784323865;6743.595384276861;6744.865102697919;868.7914900423852;881.9514926678966;943.6932996776076;961.7355227312545;991.5884907763198;27604.44791104207;27933.022344217854;28216.71783282141;29399.412011760072;29712.58376768429;1023.3808545829814;1080.5623722392443;1081.2863510083464;1094.950727217277;1147.9024282936043;14500.85499144995;15046.75276697505;15278.923605381902;15388.615284617974;15406.460773872861;618005;619952;620171;620234;620524;57932.710336448894;58084;58114.4188558109;58290.54273643108;58326;1373.9931300343435;1392.735380277744;1402.5301523989579;1404.599689088605;1404.6067101211677;28388.85805570959;29332.85333573404;29434.558481622364;30065;30159.09522714322;49586.008279834925;49992;50004;50013.499865000886;50056.24915626342;570641;575500;575525;576448;576651;24112.397190069685;24952.625710613993;39228.215435691694;39626.801865990485;39727.814970176914;36051.098722532144;36393.72621958219;36834.71078512239;37053.629463705016;42321.78839105908;31465.685343146277;34797.30405391929;35545;36547.63452365442;36705.63294367129;33076.1730956728;34770.304593908484;34985.65014349824;35983;36052.639473604926;34574.48138277877;34664.826675867465;34717.65282347144;35045;35299.64700352964;30207.848960755055;31584.526232106076;31677.524837127;31700.5244921331;31704.524432133076;23431.531369372857;23656.30019854954;23874.40313992164;24021.759782402652;24215.394615134763 08:33:46 INFO - PROCESS | 1637 | |2;jquery.html;352.86943830782616;370.4591296706808;372.2406291166021;378.88633409977007;402.3421705511488;14353.497627583036;14834.629134271649;15131.083171379838;20037.09833057512;20060;18569.721454178198;18728.625427491443;19290.90354548225;19520.414387568395;20086.196552137935;5342.652727572715;5688.857778555549;5701.002324593201;5703.3441154267375;5705.4294570543025;4937.23472861707;5625.128105143689;5697.515711164535;5727.284089488814;5727.6563406195555;5653.632513886605;5681.289838770153;5687.090065589507;5690.118031705071;5694.316681998166;5320.973395133038;5533.584981126432;5601.131824567198;5601.3558440779425;5624.3250809902665;4679.74261415622;4909;4923.926141107886;4924.212126059813;4928.605711543068;23581.05675772967;23945.521089578284;24040.51918961611;24326.783660816887;24619.892104855324;2224.6996655451467;2278.943026424336;2293.5068960173476;2411.963820542693;2939.853007349624;11890.524379024915;14674.926625366805;14735.631609209748;15140.924295378452;15408;1650.5873531617096;1796.0882313409452;1816.8553811099055;1833.404143653318;1850.4826042645036;90259;111309.44345278303;112611.3108303376;113158;114144;9019.323550733721;9470.100340467645;9560.235181185488;9584.616615335308;9928.453935033642;10154.593816247416;11670.416479176007;12167.939160304319;12213.145079844504;12287.324197169062;7546.9245307546225;7755.961220193863;7813.648385822538;7962.3630109591095;7983.361331093499;7988.960055199803;8007.839843203104;8050.677972881019;8155.632996515171;8158.224968627971;3748.4189950557707;3753.9624603753614;3758.248350329945;3827.1197624545953;3837.827297771607;1650.39086890281;1834.4680042787443;1888.0937150167997;1897;1915.6743353629638;810.8905297784723;863.2748491267365;865.9263962563126;867.2844902955087;965.8840939087354;15038.624034399227;18865.622687546173;19127.043647817554;19276.397686312448;19523.609527809647;818.4925346285341;921.0042622527262;921.7326975177258;938.7512309238058;940.8682784410188;9244.7688807779;9344;10087.04173103554;10456.372617642966;10535.315204511682;541029;557778;567435;570294;574420;109845.35231971527;114088;126375.20874373784;127542.36228818797;131429.1136838109;941.5151197133482;994.2046362909643;1012.2357619997002;1015.7155996321042;1016.944068076263;15882.60293492672;16090.436834710728;17471.475855724348;17544.649107018042;18682.906585466986;49981;51012.23481647852;51246.74376628093;52134.739326303126;52929.676758081354;72949.6352518234;73964.63017684878;74122.62938685271;75311.62344188245;77969;7876.724314649189;7893.250141236574;7976.322012628992;8003.31971782405;8012.639431225492;9045.366824322235;9930;10334.431606261727;12058.336791476202;12144;9702.660406886007;10244.078032977068;10534.36793792375;10590.258681892501;10741.892581074402;10326.690199294033;10425.9478702606;10474.790504190027;10862.293950893483;10936.562537498728;8673.653053877773;10814.729631759268;11104.056155226895;11257.04315133223;11310.60412885545;7885.921140788519;8047.919520804951;8105.108438071689;8122.918770812216;8273.503589784632;10112.292139550162;10141.594336226468;10402.843957340494;10746.946265268623;10807.189460790314 08:33:46 INFO - PROCESS | 1637 | |3;mootools.html;1339.6048165791092;1351.959441216764;1499.7300485912535;1652.4216524216527;1855.5546668799493;7404.66678999445;7785.026871641045;8015.839683206333;8263.91736082639;8286.5028098314;8139.308158806493;8231.670733170666;8233.135520770322;8237.464564803284;8237.95881020594;2032.6036422897541;2279.5099053703407;2320.628699408095;2321.6981792367055;2322.036354912709;2118.7775283595233;2131.2221039320693;2135.882526461052;2138.4226258910085;2139.037433155079;2119.7774233705472;2151.107290474451;2210.7899749523767;2299.839011269212;2301.4476525633813;2279.840411171219;2291.163725240284;2294.208498068164;2294.265834932822;2297.5060362022164;2277.487565297795;2297.1615360393503;2334.3580515358412;2340.824438167127;2345.108858633708;8193.180681931819;8284.295834854045;8298.04572474167;8305.837182794414;8310.916890831135;4981.551660350586;5154.639175257734;5168;5171.120909445403;5173.663711858717;2935.882564697431;3204.7436205103536;3281.7037270278106;3426;3479.7738147020364;1001.3140998416109;1025.9589616415335;1031.6801791444677;1032.550840384435;1052.9157667386592;10693.411862347568;10756.515956781885;10758.677239682822;10766.138708903269;10780.245382823205;3868.6324799144036;4474.977625111854;4657.883552911204;4676;4676.3686902267755;9057;9236.399634023766;9256.166944974984;9272.165505104573;9288.907110928803;5082.110630639623;5133.486651334837;5204.713740744295;5208.401033881077;5224.555912747383;4653.650976176733;4667.369905062773;4680.134175177603;4745.501722319176;4766.666333356632;3470.878519251814;3589.6948759355223;3615.204654975901;3635.8000309982676;3726.869559565402;1191.4102519253024;1241.3420886929941;1259.2759163481035;1281.14803655568;1282.7242142939126;857.4855086947781;866.2593482572436;895.9955200223957;912.9360944733805;958.0706714486937;5429.321334833146;5607.52336051432;5684.602077854511;5755.625884317506;5824.79613213544;891.1845661219911;907.8275127725711;923.9260859131253;927.4945154890601;955.1260596554214;3638.799866007342;3673.522442082512;3748.6063963283464;3805.37211360128;3876.980615096963;9674.75813104664;9914.80170396588;10034.498275086216;10038.297319187734;10044.945280745562;9984;9985.800283994426;9991.550380232908;9999.600015999278;10006.69979900604;7623.4663573549315;7744.41916856238;7759.340456061185;7765.262300081483;7766;4880.46314905353;5273.6572122811895;5523.2819733436;5550;5586.357568879468;8965.282777377664;9175.587098580447;9237.953810230905;9334.113259240361;9354.53227338644;9203.76990575241;9401.858972115288;9407.858882116638;9477.905220947978;9490.572924218288;6579.539432239697;6665.533412661067;6720.32796720324;6728.259891412039;6731.427828634425;7024.4029257513685;7665.42509311815;7713.845723085619;7787.987561616954;7788.065432148179;6401;6635.193559608447;6968.756093536702;7004.194517630538;7089.929100708927;6486.383793539606;6649.800505984828;6703.966480167763;6714.462842972648;6795.592264464148;6290.968545157245;6505.316941721051;6578.04618330349;6634.402903738686;6652.268250492345;4749.192637251745;4779.283107533898;4811.831585894477;4813.278008298783;4955;4203.747775133502;4740.597049250852;4785.928211076767;4834;5027.547520723152 08:33:46 INFO - PROCESS | 1637 | |4;prototype.html;284.7494205099513;285.6087160589992;344.5951007566111;358.7363287983332;361.32612677356724;4358.869233922987;4608.736918350525;4850.296706977486;5213.713245771481;5225;4326.30779075348;4965.307784143985;5112.335396398463;5136.38363396392;5227.32044834171;4009.83960641574;4034.536028356747;4056.229316429869;4067.877963661095;4087.0191154123095;3891.3384724596744;3912.56961734209;4061.3501839705655;4064.634182923536;4080.795960201993;3335.799112319563;3979.820908059144;4025.2754504189234;4033.97983010086;4054.513458384998;3851.4030325299623;3998.520177578709;4005.539362973266;4012.257732319501;4017.5781542938157;3017.2758537950735;3574.749767516275;3580.899869649263;3581.803000834953;3596.065023093988;4720.480747117815;4760.285957106427;4926.261060840867;5021.322121513622;5076.619253555961;4215.18525734211;4339.240632889232;4425.690201685883;4575.656825738083;4619.330197121399;4855.684380515255;5053.5957123430035;5412.539934105605;5421.1326187810155;5464.43171709296;3452.913677158066;3950.8222130003933;3953.881383558498;3955.426463162854;3987.302222111119;5523.447655234444;5537.473939975695;5547.25112109868;5556.499915007628;5610.755697720903;3279.4916787897914;3756.896138162583;3962.108525581721;3971.126352202511;3981.6217459341315;3602.873899413508;4033.274010678106;4055.1678663662556;4074.064819210851;4101.179764047202;4338.609525142752;4542.296638760465;4566.6481761892655;4568.246239370533;4602.493725690171;4689.742064186503;5355.196720491957;5376.091487521873;5473;5483.287172667528;1105.4528008635777;1151.8136319590835;1258.3079306381453;1278.9936050319689;1300.681333073403;815.3110621524802;914.8902131744101;941.990580094204;950.9667161649447;953.2564599612314;4408.779561021936;4465.665075119379;4628.814847406134;4793.832215872498;4871.879467722444;4588.678792484561;4810.735409552438;5176.731700733344;5276.762545685453;5455.799034743305;4268.445102136764;5158.38099428071;5173.508516690908;5175.741212939338;5191.532762051434;2252.6170551006367;2716.9728302717117;2762.682291536499;2768.7092855249907;2782.9721702783118;5203.32356793622;5410.513053825174;5502.58730595199;5553.361363443256;5832.88334233313;4790.664653474223;5887.264091988502;5912.733926973297;5918.496927761103;5945.435183657545;5133.512316329943;5226.529612334908;5926.4666180044005;5933.199018132497;5960;5300.4945796073025;5647.780764963931;5666.546676265972;5675.772969081356;5677.403872593318;4662.673612847068;5087.796488140581;5417.945820541744;5637.379888212211;5699.743511542073;5379.811706590251;5728.307813113369;5821.912671310019;5871.354151043467;5874.324452687995;3703.5000824666054;3778.811059447072;3785.6971442285103;3789.5263092113487;3794.867179648699;4990;5446.291982042309;5583.637063590853;5639.54883609302;5681.562654593911;4776.829676729223;4867.418089121121;5064.29099926018;5234.502722241381;5533.446655334435;4893.486183950634;5189.6247494414765;5565.944340556704;5566;5572.637778544382;5137.6660517066275;5178.456262092426;5336.226247194058;5337.866553336197;5476.945230547643;5463.344398672185;5474.91787623194;5485.50630443262;5535.474129957647;5552.7778888843995;4786.736729479912;4896.1357605799585;4944.554990050912;5152.407473140637;5430.67415955044 08:33:46 INFO - PROCESS | 1637 | |5;yui.html;732.3299181249157;763.8548675751607;774.4424014709407;818.9222023907735;832.9708460203892;14605.342759575818;15420.383184672628;15516.844831551709;15546.83398745093;15599.610009749747;14189.645258868533;14360.784588231185;14392.640183995405;14393.136411815298;14394.424223031092;846.3779122345071;868.9348298877578;883.1786438612088;885.3536918049828;886.4814083761007;874.0560194989396;874.816288579399;876.3077169036453;877.6577134917387;879.8812160358366;923.1968187676731;923.6490133749165;926.4950601921969;931.7763736703176;934.2152591822868;920.3189639666665;920.9815803683922;922.6263363337858;922.9939366090993;923.824473350068;687.7077242172057;687.9312068793131;688.3288793426419;689.5207830557764;689.862027594478;15194.088354698642;15214.63068323845;15236.390544378211;15245.542633721006;15291.923540382339;13465.124026112826;13838.792418113737;13848.047732033563;14153.363098660482;14221.21783301918;11525.711857203552;11652.766944661143;11697;11990.498245753563;12199.756004879853;3663.8534458621625;3683.355412802749;3686.4101743720876;3692.8707495237804;3850.7111966602615;61322.0801687975;72349.63825180894;72540.2745972544;106347;110100.89899100986;10618.415987120783;11117.944410278058;11165.320323122392;11218.55125794959;11484.655460336204;20321.695174572393;21615.56768864614;21881.562368752537;22054.669179962315;22079.889600551895;7838.098618658813;7905.486143400775;7924.890664570364;7936.6031698414845;8073.555954422446;4246.702730808814;4349.369341445473;4351.717138385995;4357.237483440385;4379.1022840317655;3496.230829217568;3639.7816131032223;3806.5241844769403;3852.1910398816003;3880.825362858678;696.7839969609437;699.4858778797579;704.4470090978659;715.3740477082553;718.2637796258877;506.12440477973314;528.8651393894532;577.592797078059;590.8936391449495;677.47495690839;9124.087591240823;9247.907520924839;9351.953240233755;9517.428954262767;9699.563519641491;651.667649498759;652.742166844094;657.1916542652468;668.909697190873;677.298995539624;3878.0111071676542;4066.268071747055;4572.4055872736335;4591.609713174417;4594.908101837945;81514.5545633632;82636.58681706553;83188;92217.53891230501;108598;70409.23976900619;71300;83022;83216.58391708003;87943;74009.88985165227;80714.19285807067;80714.99999999882;81136;82304.58847705842;9431.292653050912;9830.726890399406;9874.605015799287;9898.455584942898;9921.305508614329;38149.80925095357;47512.2873156896;48147;49031.26453103135;50569;65651.68696626136;66545.33636659122;68733.65633171803;70731.64634176796;71058.64470677613;11421.600243991421;12657.430415631134;13087.124792311091;13236.490702608262;13331.733365332446;14714.484993025193;14746.262686865828;14851.480198193012;14907.627309317353;15229;13484.32578371058;13509.72980540364;13747.312634368041;13857.4457021718;14024.859751402355;13469.528566500125;13644.317784110557;13779.586612401645;13798.793018104938;13907.294658814404;11962.222455540363;13353;13356.332183390987;13539.729205416033;13556.93221533886;10768.946155269174;10944.835827462754;11139.610113645984;11165.162612804235;11511.712207194887;9219.815603688023;9820.263480238867;10325.9483702584;11567.826482602935;11595.710107247387 08:33:46 INFO - PROCESS | 1637 | __end_tp_report 08:33:46 INFO - PROCESS | 1637 | __start_cc_report 08:33:46 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1270 08:33:46 INFO - PROCESS | 1637 | __end_cc_report 08:33:46 INFO - PROCESS | 1637 | __startTimestamp1481733226796__endTimestamp 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | ------- Summary: start ------- 08:33:46 INFO - PROCESS | 1637 | Number of tests: 6 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5614.66 Median:5812.85 stddev:664.62 (11.4%) stddev-sans-first:637.14 08:33:46 INFO - PROCESS | 1637 | Values: 3117.5 3280.9 3292.3 3322.1 3325.2 5487.6 5526.1 5587.6 5602.3 5621.0 4486.6 5554.3 5644.3 5650.0 5693.2 4172.9 4319.9 5094.9 5138.5 5158.1 5062.9 5130.4 5148.3 5157.9 5163.9 4280.4 5000.9 5183.7 5183.8 5190.7 5069.7 5097.0 5189.0 5189.7 5221.0 4973.2 4982.3 5022.0 5070.3 5129.2 5404.8 5440.6 5478.2 5478.2 5484.5 5922.6 6011.6 6027.8 6031.7 6047.3 6055.9 6064.7 6129.6 6144.5 6205.4 5763.9 5768.6 5795.3 5808.1 5812.0 6275.2 6281.1 6283.0 6298.6 6317.2 5790.5 5876.3 5964.0 6011.2 6048.2 6117.9 6121.8 6125.4 6135.7 6145.2 6099.1 6117.9 6119.8 6134.1 6135.8 5170.2 6124.9 6125.0 6136.3 6189.9 4882.6 4883.6 4893.0 4914.5 4952.0 4278.7 4299.3 4327.3 4330.4 4348.5 5527.8 5587.6 5598.9 5637.2 5698.9 5082.5 6127.2 6132.8 6153.7 6197.0 5654.5 5669.2 5670.1 5670.7 5690.6 5258.3 5350.3 5370.7 5373.3 5392.7 6118.1 6127.7 6151.6 6151.6 6154.8 6119.3 6119.7 6151.2 6152.1 6160.5 6209.0 6244.9 6274.7 6283.8 6299.7 5982.8 6056.3 6110.6 6126.6 6133.5 6077.8 6114.4 6116.2 6116.4 6143.1 5243.0 5916.3 5916.3 6019.0 6094.8 5987.5 6039.9 6043.9 6055.9 6066.2 5689.2 5746.4 5783.0 5812.9 5846.4 6053.1 6072.1 6085.8 6087.5 6092.1 5896.6 5900.6 5909.6 5926.5 5942.4 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:64733.89 Median:34743.98 stddev:140868.10 (405.4%) stddev-sans-first:141180.52 08:33:46 INFO - PROCESS | 1637 | Values: 423.9 442.8 454.4 464.8 503.6 25549.7 39374.0 40646.4 40707.8 40806.8 41642.8 42116.8 42144.0 42156.4 42175.6 9303.3 9511.6 9519.3 9525.3 9525.6 8589.4 8836.3 11173.4 11439.1 11443.3 11452.2 11522.5 11527.5 11528.5 11528.6 11340.7 11410.2 11434.9 11442.3 11463.7 8393.4 8624.7 11004.1 11312.6 11316.7 39882.0 40252.0 40255.8 40304.4 40317.8 3352.7 3380.6 3420.3 3948.5 4004.9 29822.7 29970.6 30076.7 31036.2 31111.4 3141.5 3141.5 3146.2 3161.5 3250.3 339500.0 340151.3 340550.0 340714.3 349249.0 56242.0 57993.0 58409.7 58480.4 58489.4 58323.7 59167.7 60358.7 60433.4 60587.0 15339.5 15852.9 15867.4 15874.5 15902.0 10502.7 11062.8 12413.3 12437.3 12482.7 14108.7 15814.8 16203.8 16228.4 16562.8 5546.9 6694.5 6729.6 6743.6 6744.9 868.8 882.0 943.7 961.7 991.6 27604.4 27933.0 28216.7 29399.4 29712.6 1023.4 1080.6 1081.3 1095.0 1147.9 14500.9 15046.8 15278.9 15388.6 15406.5 618005.0 619952.0 620171.0 620234.0 620524.0 57932.7 58084.0 58114.4 58290.5 58326.0 1374.0 1392.7 1402.5 1404.6 1404.6 28388.9 29332.9 29434.6 30065.0 30159.1 49586.0 49992.0 50004.0 50013.5 50056.2 570641.0 575500.0 575525.0 576448.0 576651.0 24112.4 24952.6 39228.2 39626.8 39727.8 36051.1 36393.7 36834.7 37053.6 42321.8 31465.7 34797.3 35545.0 36547.6 36705.6 33076.2 34770.3 34985.7 35983.0 36052.6 34574.5 34664.8 34717.7 35045.0 35299.6 30207.8 31584.5 31677.5 31700.5 31704.5 23431.5 23656.3 23874.4 24021.8 24215.4 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:32912.08 Median:3756.11 stddev:93891.27 (2499.7%) stddev-sans-first:94122.84 08:33:46 INFO - PROCESS | 1637 | Values: 352.9 370.5 372.2 378.9 402.3 14353.5 14834.6 15131.1 20037.1 20060.0 18569.7 18728.6 19290.9 19520.4 20086.2 5342.7 5688.9 5701.0 5703.3 5705.4 4937.2 5625.1 5697.5 5727.3 5727.7 5653.6 5681.3 5687.1 5690.1 5694.3 5321.0 5533.6 5601.1 5601.4 5624.3 4679.7 4909.0 4923.9 4924.2 4928.6 23581.1 23945.5 24040.5 24326.8 24619.9 2224.7 2278.9 2293.5 2412.0 2939.9 11890.5 14674.9 14735.6 15140.9 15408.0 1650.6 1796.1 1816.9 1833.4 1850.5 90259.0 111309.4 112611.3 113158.0 114144.0 9019.3 9470.1 9560.2 9584.6 9928.5 10154.6 11670.4 12167.9 12213.1 12287.3 7546.9 7756.0 7813.6 7962.4 7983.4 7989.0 8007.8 8050.7 8155.6 8158.2 3748.4 3754.0 3758.2 3827.1 3837.8 1650.4 1834.5 1888.1 1897.0 1915.7 810.9 863.3 865.9 867.3 965.9 15038.6 18865.6 19127.0 19276.4 19523.6 818.5 921.0 921.7 938.8 940.9 9244.8 9344.0 10087.0 10456.4 10535.3 541029.0 557778.0 567435.0 570294.0 574420.0 109845.4 114088.0 126375.2 127542.4 131429.1 941.5 994.2 1012.2 1015.7 1016.9 15882.6 16090.4 17471.5 17544.6 18682.9 49981.0 51012.2 51246.7 52134.7 52929.7 72949.6 73964.6 74122.6 75311.6 77969.0 7876.7 7893.3 7976.3 8003.3 8012.6 9045.4 9930.0 10334.4 12058.3 12144.0 9702.7 10244.1 10534.4 10590.3 10741.9 10326.7 10425.9 10474.8 10862.3 10936.6 8673.7 10814.7 11104.1 11257.0 11310.6 7885.9 8047.9 8105.1 8122.9 8273.5 10112.3 10141.6 10402.8 10746.9 10807.2 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5347.54 Median:5172.39 stddev:2942.23 (56.9%) stddev-sans-first:2935.06 08:33:46 INFO - PROCESS | 1637 | Values: 1339.6 1352.0 1499.7 1652.4 1855.6 7404.7 7785.0 8015.8 8263.9 8286.5 8139.3 8231.7 8233.1 8237.5 8238.0 2032.6 2279.5 2320.6 2321.7 2322.0 2118.8 2131.2 2135.9 2138.4 2139.0 2119.8 2151.1 2210.8 2299.8 2301.4 2279.8 2291.2 2294.2 2294.3 2297.5 2277.5 2297.2 2334.4 2340.8 2345.1 8193.2 8284.3 8298.0 8305.8 8310.9 4981.6 5154.6 5168.0 5171.1 5173.7 2935.9 3204.7 3281.7 3426.0 3479.8 1001.3 1026.0 1031.7 1032.6 1052.9 10693.4 10756.5 10758.7 10766.1 10780.2 3868.6 4475.0 4657.9 4676.0 4676.4 9057.0 9236.4 9256.2 9272.2 9288.9 5082.1 5133.5 5204.7 5208.4 5224.6 4653.7 4667.4 4680.1 4745.5 4766.7 3470.9 3589.7 3615.2 3635.8 3726.9 1191.4 1241.3 1259.3 1281.1 1282.7 857.5 866.3 896.0 912.9 958.1 5429.3 5607.5 5684.6 5755.6 5824.8 891.2 907.8 923.9 927.5 955.1 3638.8 3673.5 3748.6 3805.4 3877.0 9674.8 9914.8 10034.5 10038.3 10044.9 9984.0 9985.8 9991.6 9999.6 10006.7 7623.5 7744.4 7759.3 7765.3 7766.0 4880.5 5273.7 5523.3 5550.0 5586.4 8965.3 9175.6 9238.0 9334.1 9354.5 9203.8 9401.9 9407.9 9477.9 9490.6 6579.5 6665.5 6720.3 6728.3 6731.4 7024.4 7665.4 7713.8 7788.0 7788.1 6401.0 6635.2 6968.8 7004.2 7089.9 6486.4 6649.8 6704.0 6714.5 6795.6 6291.0 6505.3 6578.0 6634.4 6652.3 4749.2 4779.3 4811.8 4813.3 4955.0 4203.7 4740.6 4785.9 4834.0 5027.5 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4431.68 Median:4882.68 stddev:1341.20 (27.5%) stddev-sans-first:1308.34 08:33:46 INFO - PROCESS | 1637 | Values: 284.7 285.6 344.6 358.7 361.3 4358.9 4608.7 4850.3 5213.7 5225.0 4326.3 4965.3 5112.3 5136.4 5227.3 4009.8 4034.5 4056.2 4067.9 4087.0 3891.3 3912.6 4061.4 4064.6 4080.8 3335.8 3979.8 4025.3 4034.0 4054.5 3851.4 3998.5 4005.5 4012.3 4017.6 3017.3 3574.7 3580.9 3581.8 3596.1 4720.5 4760.3 4926.3 5021.3 5076.6 4215.2 4339.2 4425.7 4575.7 4619.3 4855.7 5053.6 5412.5 5421.1 5464.4 3452.9 3950.8 3953.9 3955.4 3987.3 5523.4 5537.5 5547.3 5556.5 5610.8 3279.5 3756.9 3962.1 3971.1 3981.6 3602.9 4033.3 4055.2 4074.1 4101.2 4338.6 4542.3 4566.6 4568.2 4602.5 4689.7 5355.2 5376.1 5473.0 5483.3 1105.5 1151.8 1258.3 1279.0 1300.7 815.3 914.9 942.0 951.0 953.3 4408.8 4465.7 4628.8 4793.8 4871.9 4588.7 4810.7 5176.7 5276.8 5455.8 4268.4 5158.4 5173.5 5175.7 5191.5 2252.6 2717.0 2762.7 2768.7 2783.0 5203.3 5410.5 5502.6 5553.4 5832.9 4790.7 5887.3 5912.7 5918.5 5945.4 5133.5 5226.5 5926.5 5933.2 5960.0 5300.5 5647.8 5666.5 5675.8 5677.4 4662.7 5087.8 5417.9 5637.4 5699.7 5379.8 5728.3 5821.9 5871.4 5874.3 3703.5 3778.8 3785.7 3789.5 3794.9 4990.0 5446.3 5583.6 5639.5 5681.6 4776.8 4867.4 5064.3 5234.5 5533.4 4893.5 5189.6 5565.9 5566.0 5572.6 5137.7 5178.5 5336.2 5337.9 5476.9 5463.3 5474.9 5485.5 5535.5 5552.8 4786.7 4896.1 4944.6 5152.4 5430.7 08:33:46 INFO - PROCESS | 1637 | 08:33:46 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19216.73 Median:4593.26 stddev:26457.03 (576.0%) stddev-sans-first:26494.84 08:33:46 INFO - PROCESS | 1637 | Values: 732.3 763.9 774.4 818.9 833.0 14605.3 15420.4 15516.8 15546.8 15599.6 14189.6 14360.8 14392.6 14393.1 14394.4 846.4 868.9 883.2 885.4 886.5 874.1 874.8 876.3 877.7 879.9 923.2 923.6 926.5 931.8 934.2 920.3 921.0 922.6 923.0 923.8 687.7 687.9 688.3 689.5 689.9 15194.1 15214.6 15236.4 15245.5 15291.9 13465.1 13838.8 13848.0 14153.4 14221.2 11525.7 11652.8 11697.0 11990.5 12199.8 3663.9 3683.4 3686.4 3692.9 3850.7 61322.1 72349.6 72540.3 106347.0 110100.9 10618.4 11117.9 11165.3 11218.6 11484.7 20321.7 21615.6 21881.6 22054.7 22079.9 7838.1 7905.5 7924.9 7936.6 8073.6 4246.7 4349.4 4351.7 4357.2 4379.1 3496.2 3639.8 3806.5 3852.2 3880.8 696.8 699.5 704.4 715.4 718.3 506.1 528.9 577.6 590.9 677.5 9124.1 9247.9 9352.0 9517.4 9699.6 651.7 652.7 657.2 668.9 677.3 3878.0 4066.3 4572.4 4591.6 4594.9 81514.6 82636.6 83188.0 92217.5 108598.0 70409.2 71300.0 83022.0 83216.6 87943.0 74009.9 80714.2 80715.0 81136.0 82304.6 9431.3 9830.7 9874.6 9898.5 9921.3 38149.8 47512.3 48147.0 49031.3 50569.0 65651.7 66545.3 68733.7 70731.6 71058.6 11421.6 12657.4 13087.1 13236.5 13331.7 14714.5 14746.3 14851.5 14907.6 15229.0 13484.3 13509.7 13747.3 13857.4 14024.9 13469.5 13644.3 13779.6 13798.8 13907.3 11962.2 13353.0 13356.3 13539.7 13556.9 10768.9 10944.8 11139.6 11165.2 11511.7 9219.8 9820.3 10325.9 11567.8 11595.7 08:33:46 INFO - PROCESS | 1637 | -------- Summary: end -------- 08:33:46 INFO - PROCESS | 1637 | 08:33:47 INFO - TEST-INFO | 1637: exit 0 08:33:47 INFO - TEST-OK | dromaeo_css | took 1118523ms 08:33:47 INFO - TEST-START | kraken 08:33:47 INFO - operating with platform_type : mac_ 08:33:47 INFO - Initialising browser for kraken test... 08:33:47 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpKouLaH/profile http://localhost:49236/getInfo.html) 08:33:49 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 08:33:49 INFO - PROCESS | 1647 | colorDepth:24 08:33:49 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 08:33:49 INFO - PROCESS | 1647 | __metrics 08:33:49 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:33:49 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:50 INFO - TEST-INFO | 1647: exit 0 08:33:50 INFO - Browser initialized. 08:33:50 INFO - Running cycle 1/1 for kraken test... 08:33:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpKouLaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:02 INFO - PROCESS | 1648 | RSS: Main: 237428736 08:34:02 INFO - PROCESS | 1648 | 08:34:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:06 INFO - PROCESS | 1648 | RSS: Main: 290308096 08:34:06 INFO - PROCESS | 1648 | 08:34:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:34:09 INFO - PROCESS | 1648 | RSS: Main: 292605952 08:34:09 INFO - PROCESS | 1648 | 08:34:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:34:13 INFO - PROCESS | 1648 | RSS: Main: 380772352 08:34:13 INFO - PROCESS | 1648 | 08:34:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:34:16 INFO - PROCESS | 1648 | RSS: Main: 284012544 08:34:16 INFO - PROCESS | 1648 | 08:34:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:18 INFO - PROCESS | 1648 | RSS: Main: 288739328 08:34:18 INFO - PROCESS | 1648 | 08:34:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:22 INFO - PROCESS | 1648 | RSS: Main: 331788288 08:34:22 INFO - PROCESS | 1648 | 08:34:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:26 INFO - PROCESS | 1648 | RSS: Main: 333225984 08:34:26 INFO - PROCESS | 1648 | 08:34:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:34:29 INFO - PROCESS | 1648 | RSS: Main: 332492800 08:34:29 INFO - PROCESS | 1648 | 08:34:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:31 INFO - PROCESS | 1648 | RSS: Main: 304762880 08:34:31 INFO - PROCESS | 1648 | 08:34:33 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:34 INFO - PROCESS | 1648 | RSS: Main: 310181888 08:34:34 INFO - PROCESS | 1648 | 08:34:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:37 INFO - PROCESS | 1648 | RSS: Main: 311525376 08:34:37 INFO - PROCESS | 1648 | 08:34:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:41 INFO - PROCESS | 1648 | RSS: Main: 327462912 08:34:41 INFO - PROCESS | 1648 | 08:34:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:44 INFO - PROCESS | 1648 | RSS: Main: 321388544 08:34:44 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:34:46 INFO - PROCESS | 1648 | RSS: Main: 364654592 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | __start_tp_report 08:34:46 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 08:34:46 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 08:34:46 INFO - PROCESS | 1648 | |i|pagename|runs| 08:34:46 INFO - PROCESS | 1648 | |0;ai-astar;116;163;165;114;115;113;114;113;114;113 08:34:46 INFO - PROCESS | 1648 | |1;audio-beat-detection;151;114;112;151;117;126;143;119;136;111 08:34:46 INFO - PROCESS | 1648 | |2;audio-dft;183;184;183;184;184;184;184;180;181;182 08:34:46 INFO - PROCESS | 1648 | |3;audio-fft;77;59;60;89;65;74;82;84;87;59 08:34:46 INFO - PROCESS | 1648 | |4;audio-oscillator;86;70;83;67;68;67;84;69;67;83 08:34:46 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;108;110;109;119;163;109;114;167;107;110 08:34:46 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;102;94;94;94;94;94;94;93;93 08:34:46 INFO - PROCESS | 1648 | |7;imaging-desaturate;87;85;87;85;140;133;87;85;88;86 08:34:46 INFO - PROCESS | 1648 | |8;json-parse-financial;58;56;57;57;58;56;56;56;56;57 08:34:46 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;65;72;75;78;74;71;73;72;71;73 08:34:46 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;88;90;110;88;89;88;88;87;94;93 08:34:46 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;147;147;148;149;149;152;137;150;217;185 08:34:46 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;178;177;174;174;175;176;175;174;176;187 08:34:46 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;84;84;86;78;68;68;68;67;70;67 08:34:46 INFO - PROCESS | 1648 | __end_tp_report 08:34:46 INFO - PROCESS | 1648 | __start_cc_report 08:34:46 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2017 08:34:46 INFO - PROCESS | 1648 | __end_cc_report 08:34:46 INFO - PROCESS | 1648 | __startTimestamp1481733286915__endTimestamp 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | ------- Summary: start ------- 08:34:46 INFO - PROCESS | 1648 | Number of tests: 14 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:124.00 Median:114.50 stddev:21.11 (18.4%) stddev-sans-first:22.19 08:34:46 INFO - PROCESS | 1648 | Values: 116.0 163.0 165.0 114.0 115.0 113.0 114.0 113.0 114.0 113.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:131.00 stddev:15.97 (12.2%) stddev-sans-first:14.60 08:34:46 INFO - PROCESS | 1648 | Values: 151.0 114.0 112.0 151.0 117.0 126.0 143.0 119.0 136.0 111.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.90 Median:184.00 stddev:1.45 (0.8%) stddev-sans-first:1.54 08:34:46 INFO - PROCESS | 1648 | Values: 183.0 184.0 183.0 184.0 184.0 184.0 184.0 180.0 181.0 182.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:73.60 Median:79.50 stddev:11.98 (15.1%) stddev-sans-first:12.65 08:34:46 INFO - PROCESS | 1648 | Values: 77.0 59.0 60.0 89.0 65.0 74.0 82.0 84.0 87.0 59.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:74.40 Median:76.50 stddev:8.36 (10.9%) stddev-sans-first:7.74 08:34:46 INFO - PROCESS | 1648 | Values: 86.0 70.0 83.0 67.0 68.0 67.0 84.0 69.0 67.0 83.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:121.60 Median:112.00 stddev:23.15 (20.7%) stddev-sans-first:24.03 08:34:46 INFO - PROCESS | 1648 | Values: 108.0 110.0 109.0 119.0 163.0 109.0 114.0 167.0 107.0 110.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:2.68 (2.8%) stddev-sans-first:2.78 08:34:46 INFO - PROCESS | 1648 | Values: 93.0 102.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:86.50 stddev:21.28 (24.6%) stddev-sans-first:22.30 08:34:46 INFO - PROCESS | 1648 | Values: 87.0 85.0 87.0 85.0 140.0 133.0 87.0 85.0 88.0 86.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 08:34:46 INFO - PROCESS | 1648 | Values: 58.0 56.0 57.0 57.0 58.0 56.0 56.0 56.0 56.0 57.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:3.34 (4.6%) stddev-sans-first:2.22 08:34:46 INFO - PROCESS | 1648 | Values: 65.0 72.0 75.0 78.0 74.0 71.0 73.0 72.0 71.0 73.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:88.50 stddev:6.90 (7.8%) stddev-sans-first:7.20 08:34:46 INFO - PROCESS | 1648 | Values: 88.0 90.0 110.0 88.0 89.0 88.0 88.0 87.0 94.0 93.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:158.10 Median:149.50 stddev:24.16 (16.2%) stddev-sans-first:25.29 08:34:46 INFO - PROCESS | 1648 | Values: 147.0 147.0 148.0 149.0 149.0 152.0 137.0 150.0 217.0 185.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:176.00 stddev:3.89 (2.2%) stddev-sans-first:4.10 08:34:46 INFO - PROCESS | 1648 | Values: 178.0 177.0 174.0 174.0 175.0 176.0 175.0 174.0 176.0 187.0 08:34:46 INFO - PROCESS | 1648 | 08:34:46 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.00 stddev:8.04 (10.9%) stddev-sans-first:7.67 08:34:46 INFO - PROCESS | 1648 | Values: 84.0 84.0 86.0 78.0 68.0 68.0 68.0 67.0 70.0 67.0 08:34:46 INFO - PROCESS | 1648 | -------- Summary: end -------- 08:34:46 INFO - PROCESS | 1648 | 08:34:47 INFO - TEST-INFO | 1648: exit 0 08:34:47 INFO - TEST-OK | kraken | took 60327ms 08:34:47 INFO - SUITE-END | took 1178s 08:34:48 INFO - Completed test suite (00:19:39) 08:34:48 INFO - javascript benchmark 08:34:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.4856148735457, 3280.917977050575, 3292.3250733599607, 3322.053214833773, 3325.2185736351953, 5487.5609951203905, 5526.06056970315, 5587.60886737928, 5602.299712535933, 5621.0444224481835, 4486.551344865512, 5554.2779438673015, 5644.294463192101, 5650.011248031598, 5693.231413759131, 4172.916541669165, 4319.913601727963, 5094.898102037957, 5138.460461651529, 5158.148905430599, 5062.949370506285, 5130.38435387754, 5148.304978827867, 5157.871053223681, 5163.896722065557, 4280.4221430107, 5000.899982000358, 5183.714895680736, 5183.766730497136, 5190.740462976855, 5069.695818250917, 5097.0, 5188.9881473112755, 5189.66267192635, 5221.0, 4973.229149481836, 4982.277569752402, 5022.0, 5070.264811602334, 5129.179331306973, 5404.83785486436, 5440.646357986758, 5478.178273259004, 5478.233047373371, 5484.478974497416, 5922.58541902067, 6011.57918945674, 6027.819165425044, 6031.668258245794, 6047.334793172748, 6055.939440605582, 6064.727087281083, 6129.601575897597, 6144.494598823272, 6205.410486003822, 5763.85590360236, 5768.625039372428, 5795.275590551181, 5808.099744539603, 5812.0, 6275.246970363494, 6281.120643109968, 6283.0, 6298.590591611531, 6317.210348706411, 5790.478856902899, 5876.265466816648, 5964.0, 6011.158437818709, 6048.243969503812, 6117.908231376533, 6121.767890854219, 6125.41859352575, 6135.69203737716, 6145.156453064153, 6099.099188574522, 6117.877642447215, 6119.84700382494, 6134.141220229171, 6135.785247516315, 5170.224466330081, 6124.899720463051, 6124.971343706056, 6136.325004249529, 6189.938100619026, 4882.609391248691, 4883.584895283941, 4892.951070489321, 4914.483979182206, 4952.009598080326, 4278.7004909656025, 4299.290617048152, 4327.285997810326, 4330.350447432847, 4348.5216626171095, 5527.778888844482, 5587.608867379326, 5598.888022239614, 5637.182608521742, 5698.886022279531, 5082.542571168613, 6127.172831667757, 6132.814448934737, 6153.692315384213, 6197.03945888388, 5654.491095801398, 5669.177969194444, 5670.121131224667, 5670.716464176775, 5690.630109042899, 5258.342707161605, 5350.304460420199, 5370.70461124634, 5373.328333958255, 5392.73036348181, 6118.131909153847, 6127.678242056309, 6151.6001459904965, 6151.630902145886, 6154.753809847556, 6119.258838873971, 6119.663418512025, 6151.231096112986, 6152.077188421773, 6160.507159427325, 6209.0, 6244.906326405016, 6274.717637706223, 6283.842903927439, 6299.685015749103, 5982.790602328898, 6056.333803281724, 6110.602810817282, 6126.632402055891, 6133.509319254538, 6077.848053798691, 6114.358196333866, 6116.204893363834, 6116.449519543263, 6143.112737013596, 5242.951409717995, 5916.26046744157, 5916.319623243382, 6018.976773948527, 6094.8171554853425, 5987.461128498456, 6039.939600604113, 6043.879122417615, 6055.878882422238, 6066.211392518944, 5689.203511508309, 5746.425357464387, 5782.959067367914, 5812.854678633068, 5846.386129456346, 6053.122297266959, 6072.1498990140535, 6085.756569737161, 6087.543434242361, 6092.116643086816, 5896.587238893237, 5900.5574581907385, 5909.6158749681135, 5926.525877929842, 5942.405759424023], "value": 5571.464258248228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.94064830923674, 442.84057739213875, 454.3729653078749, 464.8256903661127, 503.5694481218556, 25549.744502554968, 39374.01564960877, 40646.39030414539, 40707.79646101769, 40806.79596602013, 41642.7917860411, 42116.789416052874, 42144.0, 42156.36765448513, 42175.57824421755, 9303.255739540837, 9511.619535218582, 9519.333646644738, 9525.333226674136, 9525.618975240983, 8589.44168629037, 8836.293096552261, 11173.385463799488, 11439.142064345166, 11443.313401195956, 11452.198346115776, 11522.481488333045, 11527.481263343128, 11528.481218345152, 11528.596499122532, 11340.659780206566, 11410.20128590999, 11434.94282528582, 11442.313461192354, 11463.656090317261, 8393.370497212672, 8624.65501379944, 11004.119670426348, 11312.604058857984, 11316.717082072932, 39882.0, 40252.0, 40255.79232622997, 40304.36499802502, 40317.79841100776, 3352.6814952579466, 3380.622094387774, 3420.26464310172, 3948.506436695413, 4004.8598299059395, 29822.70177298221, 29970.55044174339, 30076.69923300761, 31036.22409439782, 31111.37777244465, 3141.4816555268353, 3141.4816555268353, 3146.229173852421, 3161.462551366273, 3250.252441938344, 339500.0, 340151.29924350465, 340550.0, 340714.2964285188, 349249.0, 56242.0, 57993.0, 58409.70795146082, 58480.4151958475, 58489.4151058484, 58323.70838145782, 59167.70416147892, 60358.698206508685, 60433.39566604278, 60587.0, 15339.463118791013, 15852.890297679282, 15867.444639437565, 15874.52376428709, 15902.045877247403, 10502.73743156412, 11062.834057489144, 12413.317267550372, 12437.253764774143, 12482.687932801753, 14108.717825643635, 15814.76277855833, 16203.756943645854, 16228.350865965465, 16562.83437165613, 5546.944530554723, 6694.464442844561, 6729.5625784323865, 6743.595384276861, 6744.865102697919, 868.7914900423852, 881.9514926678966, 943.6932996776076, 961.7355227312545, 991.5884907763198, 27604.44791104207, 27933.022344217854, 28216.71783282141, 29399.412011760072, 29712.58376768429, 1023.3808545829814, 1080.5623722392443, 1081.2863510083464, 1094.950727217277, 1147.9024282936043, 14500.85499144995, 15046.75276697505, 15278.923605381902, 15388.615284617974, 15406.460773872861, 618005.0, 619952.0, 620171.0, 620234.0, 620524.0, 57932.710336448894, 58084.0, 58114.4188558109, 58290.54273643108, 58326.0, 1373.9931300343435, 1392.735380277744, 1402.5301523989579, 1404.599689088605, 1404.6067101211677, 28388.85805570959, 29332.85333573404, 29434.558481622364, 30065.0, 30159.09522714322, 49586.008279834925, 49992.0, 50004.0, 50013.499865000886, 50056.24915626342, 570641.0, 575500.0, 575525.0, 576448.0, 576651.0, 24112.397190069685, 24952.625710613993, 39228.215435691694, 39626.801865990485, 39727.814970176914, 36051.098722532144, 36393.72621958219, 36834.71078512239, 37053.629463705016, 42321.78839105908, 31465.685343146277, 34797.30405391929, 35545.0, 36547.63452365442, 36705.63294367129, 33076.1730956728, 34770.304593908484, 34985.65014349824, 35983.0, 36052.639473604926, 34574.48138277877, 34664.826675867465, 34717.65282347144, 35045.0, 35299.64700352964, 30207.848960755055, 31584.526232106076, 31677.524837127, 31700.5244921331, 31704.524432133076, 23431.531369372857, 23656.30019854954, 23874.40313992164, 24021.759782402652, 24215.394615134763], "value": 19384.265826902065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.86943830782616, 370.4591296706808, 372.2406291166021, 378.88633409977007, 402.3421705511488, 14353.497627583036, 14834.629134271649, 15131.083171379838, 20037.09833057512, 20060.0, 18569.721454178198, 18728.625427491443, 19290.90354548225, 19520.414387568395, 20086.196552137935, 5342.652727572715, 5688.857778555549, 5701.002324593201, 5703.3441154267375, 5705.4294570543025, 4937.23472861707, 5625.128105143689, 5697.515711164535, 5727.284089488814, 5727.6563406195555, 5653.632513886605, 5681.289838770153, 5687.090065589507, 5690.118031705071, 5694.316681998166, 5320.973395133038, 5533.584981126432, 5601.131824567198, 5601.3558440779425, 5624.3250809902665, 4679.74261415622, 4909.0, 4923.926141107886, 4924.212126059813, 4928.605711543068, 23581.05675772967, 23945.521089578284, 24040.51918961611, 24326.783660816887, 24619.892104855324, 2224.6996655451467, 2278.943026424336, 2293.5068960173476, 2411.963820542693, 2939.853007349624, 11890.524379024915, 14674.926625366805, 14735.631609209748, 15140.924295378452, 15408.0, 1650.5873531617096, 1796.0882313409452, 1816.8553811099055, 1833.404143653318, 1850.4826042645036, 90259.0, 111309.44345278303, 112611.3108303376, 113158.0, 114144.0, 9019.323550733721, 9470.100340467645, 9560.235181185488, 9584.616615335308, 9928.453935033642, 10154.593816247416, 11670.416479176007, 12167.939160304319, 12213.145079844504, 12287.324197169062, 7546.9245307546225, 7755.961220193863, 7813.648385822538, 7962.3630109591095, 7983.361331093499, 7988.960055199803, 8007.839843203104, 8050.677972881019, 8155.632996515171, 8158.224968627971, 3748.4189950557707, 3753.9624603753614, 3758.248350329945, 3827.1197624545953, 3837.827297771607, 1650.39086890281, 1834.4680042787443, 1888.0937150167997, 1897.0, 1915.6743353629638, 810.8905297784723, 863.2748491267365, 865.9263962563126, 867.2844902955087, 965.8840939087354, 15038.624034399227, 18865.622687546173, 19127.043647817554, 19276.397686312448, 19523.609527809647, 818.4925346285341, 921.0042622527262, 921.7326975177258, 938.7512309238058, 940.8682784410188, 9244.7688807779, 9344.0, 10087.04173103554, 10456.372617642966, 10535.315204511682, 541029.0, 557778.0, 567435.0, 570294.0, 574420.0, 109845.35231971527, 114088.0, 126375.20874373784, 127542.36228818797, 131429.1136838109, 941.5151197133482, 994.2046362909643, 1012.2357619997002, 1015.7155996321042, 1016.944068076263, 15882.60293492672, 16090.436834710728, 17471.475855724348, 17544.649107018042, 18682.906585466986, 49981.0, 51012.23481647852, 51246.74376628093, 52134.739326303126, 52929.676758081354, 72949.6352518234, 73964.63017684878, 74122.62938685271, 75311.62344188245, 77969.0, 7876.724314649189, 7893.250141236574, 7976.322012628992, 8003.31971782405, 8012.639431225492, 9045.366824322235, 9930.0, 10334.431606261727, 12058.336791476202, 12144.0, 9702.660406886007, 10244.078032977068, 10534.36793792375, 10590.258681892501, 10741.892581074402, 10326.690199294033, 10425.9478702606, 10474.790504190027, 10862.293950893483, 10936.562537498728, 8673.653053877773, 10814.729631759268, 11104.056155226895, 11257.04315133223, 11310.60412885545, 7885.921140788519, 8047.919520804951, 8105.108438071689, 8122.918770812216, 8273.503589784632, 10112.292139550162, 10141.594336226468, 10402.843957340494, 10746.946265268623, 10807.189460790314], "value": 9032.004110445785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.6048165791092, 1351.959441216764, 1499.7300485912535, 1652.4216524216527, 1855.5546668799493, 7404.66678999445, 7785.026871641045, 8015.839683206333, 8263.91736082639, 8286.5028098314, 8139.308158806493, 8231.670733170666, 8233.135520770322, 8237.464564803284, 8237.95881020594, 2032.6036422897541, 2279.5099053703407, 2320.628699408095, 2321.6981792367055, 2322.036354912709, 2118.7775283595233, 2131.2221039320693, 2135.882526461052, 2138.4226258910085, 2139.037433155079, 2119.7774233705472, 2151.107290474451, 2210.7899749523767, 2299.839011269212, 2301.4476525633813, 2279.840411171219, 2291.163725240284, 2294.208498068164, 2294.265834932822, 2297.5060362022164, 2277.487565297795, 2297.1615360393503, 2334.3580515358412, 2340.824438167127, 2345.108858633708, 8193.180681931819, 8284.295834854045, 8298.04572474167, 8305.837182794414, 8310.916890831135, 4981.551660350586, 5154.639175257734, 5168.0, 5171.120909445403, 5173.663711858717, 2935.882564697431, 3204.7436205103536, 3281.7037270278106, 3426.0, 3479.7738147020364, 1001.3140998416109, 1025.9589616415335, 1031.6801791444677, 1032.550840384435, 1052.9157667386592, 10693.411862347568, 10756.515956781885, 10758.677239682822, 10766.138708903269, 10780.245382823205, 3868.6324799144036, 4474.977625111854, 4657.883552911204, 4676.0, 4676.3686902267755, 9057.0, 9236.399634023766, 9256.166944974984, 9272.165505104573, 9288.907110928803, 5082.110630639623, 5133.486651334837, 5204.713740744295, 5208.401033881077, 5224.555912747383, 4653.650976176733, 4667.369905062773, 4680.134175177603, 4745.501722319176, 4766.666333356632, 3470.878519251814, 3589.6948759355223, 3615.204654975901, 3635.8000309982676, 3726.869559565402, 1191.4102519253024, 1241.3420886929941, 1259.2759163481035, 1281.14803655568, 1282.7242142939126, 857.4855086947781, 866.2593482572436, 895.9955200223957, 912.9360944733805, 958.0706714486937, 5429.321334833146, 5607.52336051432, 5684.602077854511, 5755.625884317506, 5824.79613213544, 891.1845661219911, 907.8275127725711, 923.9260859131253, 927.4945154890601, 955.1260596554214, 3638.799866007342, 3673.522442082512, 3748.6063963283464, 3805.37211360128, 3876.980615096963, 9674.75813104664, 9914.80170396588, 10034.498275086216, 10038.297319187734, 10044.945280745562, 9984.0, 9985.800283994426, 9991.550380232908, 9999.600015999278, 10006.69979900604, 7623.4663573549315, 7744.41916856238, 7759.340456061185, 7765.262300081483, 7766.0, 4880.46314905353, 5273.6572122811895, 5523.2819733436, 5550.0, 5586.357568879468, 8965.282777377664, 9175.587098580447, 9237.953810230905, 9334.113259240361, 9354.53227338644, 9203.76990575241, 9401.858972115288, 9407.858882116638, 9477.905220947978, 9490.572924218288, 6579.539432239697, 6665.533412661067, 6720.32796720324, 6728.259891412039, 6731.427828634425, 7024.4029257513685, 7665.42509311815, 7713.845723085619, 7787.987561616954, 7788.065432148179, 6401.0, 6635.193559608447, 6968.756093536702, 7004.194517630538, 7089.929100708927, 6486.383793539606, 6649.800505984828, 6703.966480167763, 6714.462842972648, 6795.592264464148, 6290.968545157245, 6505.316941721051, 6578.04618330349, 6634.402903738686, 6652.268250492345, 4749.192637251745, 4779.283107533898, 4811.831585894477, 4813.278008298783, 4955.0, 4203.747775133502, 4740.597049250852, 4785.928211076767, 4834.0, 5027.547520723152], "value": 4334.7578560637385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.7494205099513, 285.6087160589992, 344.5951007566111, 358.7363287983332, 361.32612677356724, 4358.869233922987, 4608.736918350525, 4850.296706977486, 5213.713245771481, 5225.0, 4326.30779075348, 4965.307784143985, 5112.335396398463, 5136.38363396392, 5227.32044834171, 4009.83960641574, 4034.536028356747, 4056.229316429869, 4067.877963661095, 4087.0191154123095, 3891.3384724596744, 3912.56961734209, 4061.3501839705655, 4064.634182923536, 4080.795960201993, 3335.799112319563, 3979.820908059144, 4025.2754504189234, 4033.97983010086, 4054.513458384998, 3851.4030325299623, 3998.520177578709, 4005.539362973266, 4012.257732319501, 4017.5781542938157, 3017.2758537950735, 3574.749767516275, 3580.899869649263, 3581.803000834953, 3596.065023093988, 4720.480747117815, 4760.285957106427, 4926.261060840867, 5021.322121513622, 5076.619253555961, 4215.18525734211, 4339.240632889232, 4425.690201685883, 4575.656825738083, 4619.330197121399, 4855.684380515255, 5053.5957123430035, 5412.539934105605, 5421.1326187810155, 5464.43171709296, 3452.913677158066, 3950.8222130003933, 3953.881383558498, 3955.426463162854, 3987.302222111119, 5523.447655234444, 5537.473939975695, 5547.25112109868, 5556.499915007628, 5610.755697720903, 3279.4916787897914, 3756.896138162583, 3962.108525581721, 3971.126352202511, 3981.6217459341315, 3602.873899413508, 4033.274010678106, 4055.1678663662556, 4074.064819210851, 4101.179764047202, 4338.609525142752, 4542.296638760465, 4566.6481761892655, 4568.246239370533, 4602.493725690171, 4689.742064186503, 5355.196720491957, 5376.091487521873, 5473.0, 5483.287172667528, 1105.4528008635777, 1151.8136319590835, 1258.3079306381453, 1278.9936050319689, 1300.681333073403, 815.3110621524802, 914.8902131744101, 941.990580094204, 950.9667161649447, 953.2564599612314, 4408.779561021936, 4465.665075119379, 4628.814847406134, 4793.832215872498, 4871.879467722444, 4588.678792484561, 4810.735409552438, 5176.731700733344, 5276.762545685453, 5455.799034743305, 4268.445102136764, 5158.38099428071, 5173.508516690908, 5175.741212939338, 5191.532762051434, 2252.6170551006367, 2716.9728302717117, 2762.682291536499, 2768.7092855249907, 2782.9721702783118, 5203.32356793622, 5410.513053825174, 5502.58730595199, 5553.361363443256, 5832.88334233313, 4790.664653474223, 5887.264091988502, 5912.733926973297, 5918.496927761103, 5945.435183657545, 5133.512316329943, 5226.529612334908, 5926.4666180044005, 5933.199018132497, 5960.0, 5300.4945796073025, 5647.780764963931, 5666.546676265972, 5675.772969081356, 5677.403872593318, 4662.673612847068, 5087.796488140581, 5417.945820541744, 5637.379888212211, 5699.743511542073, 5379.811706590251, 5728.307813113369, 5821.912671310019, 5871.354151043467, 5874.324452687995, 3703.5000824666054, 3778.811059447072, 3785.6971442285103, 3789.5263092113487, 3794.867179648699, 4990.0, 5446.291982042309, 5583.637063590853, 5639.54883609302, 5681.562654593911, 4776.829676729223, 4867.418089121121, 5064.29099926018, 5234.502722241381, 5533.446655334435, 4893.486183950634, 5189.6247494414765, 5565.944340556704, 5566.0, 5572.637778544382, 5137.6660517066275, 5178.456262092426, 5336.226247194058, 5337.866553336197, 5476.945230547643, 5463.344398672185, 5474.91787623194, 5485.50630443262, 5535.474129957647, 5552.7778888843995, 4786.736729479912, 4896.1357605799585, 4944.554990050912, 5152.407473140637, 5430.67415955044], "value": 4010.3237218242934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.3299181249157, 763.8548675751607, 774.4424014709407, 818.9222023907735, 832.9708460203892, 14605.342759575818, 15420.383184672628, 15516.844831551709, 15546.83398745093, 15599.610009749747, 14189.645258868533, 14360.784588231185, 14392.640183995405, 14393.136411815298, 14394.424223031092, 846.3779122345071, 868.9348298877578, 883.1786438612088, 885.3536918049828, 886.4814083761007, 874.0560194989396, 874.816288579399, 876.3077169036453, 877.6577134917387, 879.8812160358366, 923.1968187676731, 923.6490133749165, 926.4950601921969, 931.7763736703176, 934.2152591822868, 920.3189639666665, 920.9815803683922, 922.6263363337858, 922.9939366090993, 923.824473350068, 687.7077242172057, 687.9312068793131, 688.3288793426419, 689.5207830557764, 689.862027594478, 15194.088354698642, 15214.63068323845, 15236.390544378211, 15245.542633721006, 15291.923540382339, 13465.124026112826, 13838.792418113737, 13848.047732033563, 14153.363098660482, 14221.21783301918, 11525.711857203552, 11652.766944661143, 11697.0, 11990.498245753563, 12199.756004879853, 3663.8534458621625, 3683.355412802749, 3686.4101743720876, 3692.8707495237804, 3850.7111966602615, 61322.0801687975, 72349.63825180894, 72540.2745972544, 106347.0, 110100.89899100986, 10618.415987120783, 11117.944410278058, 11165.320323122392, 11218.55125794959, 11484.655460336204, 20321.695174572393, 21615.56768864614, 21881.562368752537, 22054.669179962315, 22079.889600551895, 7838.098618658813, 7905.486143400775, 7924.890664570364, 7936.6031698414845, 8073.555954422446, 4246.702730808814, 4349.369341445473, 4351.717138385995, 4357.237483440385, 4379.1022840317655, 3496.230829217568, 3639.7816131032223, 3806.5241844769403, 3852.1910398816003, 3880.825362858678, 696.7839969609437, 699.4858778797579, 704.4470090978659, 715.3740477082553, 718.2637796258877, 506.12440477973314, 528.8651393894532, 577.592797078059, 590.8936391449495, 677.47495690839, 9124.087591240823, 9247.907520924839, 9351.953240233755, 9517.428954262767, 9699.563519641491, 651.667649498759, 652.742166844094, 657.1916542652468, 668.909697190873, 677.298995539624, 3878.0111071676542, 4066.268071747055, 4572.4055872736335, 4591.609713174417, 4594.908101837945, 81514.5545633632, 82636.58681706553, 83188.0, 92217.53891230501, 108598.0, 70409.23976900619, 71300.0, 83022.0, 83216.58391708003, 87943.0, 74009.88985165227, 80714.19285807067, 80714.99999999882, 81136.0, 82304.58847705842, 9431.292653050912, 9830.726890399406, 9874.605015799287, 9898.455584942898, 9921.305508614329, 38149.80925095357, 47512.2873156896, 48147.0, 49031.26453103135, 50569.0, 65651.68696626136, 66545.33636659122, 68733.65633171803, 70731.64634176796, 71058.64470677613, 11421.600243991421, 12657.430415631134, 13087.124792311091, 13236.490702608262, 13331.733365332446, 14714.484993025193, 14746.262686865828, 14851.480198193012, 14907.627309317353, 15229.0, 13484.32578371058, 13509.72980540364, 13747.312634368041, 13857.4457021718, 14024.859751402355, 13469.528566500125, 13644.317784110557, 13779.586612401645, 13798.793018104938, 13907.294658814404, 11962.222455540363, 13353.0, 13356.332183390987, 13539.729205416033, 13556.93221533886, 10768.946155269174, 10944.835827462754, 11139.610113645984, 11165.162612804235, 11511.712207194887, 9219.815603688023, 9820.263480238867, 10325.9483702584, 11567.826482602935, 11595.710107247387], "value": 7408.092763304063, "unit": "score"}], "name": "dromaeo_css", "value": 7077.015412778119, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 163.0, 165.0, 114.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 112.0, 151.0, 117.0, 126.0, 143.0, 119.0, 136.0, 111.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 184.0, 184.0, 184.0, 184.0, 180.0, 181.0, 182.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 60.0, 89.0, 65.0, 74.0, 82.0, 84.0, 87.0, 59.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 83.0, 67.0, 68.0, 67.0, 84.0, 69.0, 67.0, 83.0], "value": 74.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 109.0, 119.0, 163.0, 109.0, 114.0, 167.0, 107.0, 110.0], "value": 121.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 102.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 140.0, 133.0, 87.0, 85.0, 88.0, 86.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 57.0, 58.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 75.0, 78.0, 74.0, 71.0, 73.0, 72.0, 71.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 110.0, 88.0, 89.0, 88.0, 88.0, 87.0, 94.0, 93.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 149.0, 152.0, 137.0, 150.0, 217.0, 185.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 174.0, 174.0, 175.0, 176.0, 175.0, 174.0, 176.0, 187.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 78.0, 68.0, 68.0, 68.0, 67.0, 70.0, 67.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1524.6, "alertThreshold": 2.0}]} 08:34:48 INFO - Return code: 0 08:34:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:48 INFO - # TBPL SUCCESS # 08:34:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:34:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:34:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:34:48 INFO - 2016-12-14 08:34:48.257 screenresolution[1652:9676] starting screenresolution argv=screenresolution get 08:34:48 INFO - 2016-12-14 08:34:48.260 screenresolution[1652:9676] Display 0: 1600x1200x32@60 08:34:48 INFO - 2016-12-14 08:34:48.266 screenresolution[1653:9679] starting screenresolution argv=screenresolution list 08:34:48 INFO - Available Modes on Display 0 08:34:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:34:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:34:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:34:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:34:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:34:48 INFO - Intel Iris: 08:34:48 INFO - Chipset Model: Intel Iris 08:34:48 INFO - Type: GPU 08:34:48 INFO - Bus: Built-In 08:34:48 INFO - VRAM (Dynamic, Max): 1536 MB 08:34:48 INFO - Vendor: Intel (0x8086) 08:34:48 INFO - Device ID: 0x0a2e 08:34:48 INFO - Revision ID: 0x0009 08:34:48 INFO - Displays: 08:34:48 INFO - Display: 08:34:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:34:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:34:48 INFO - Display Serial Number: 1600x1200 60 08:34:48 INFO - Main Display: Yes 08:34:48 INFO - Mirror: Off 08:34:48 INFO - Online: Yes 08:34:48 INFO - Rotation: Supported 08:34:48 INFO - Return code: 0 08:34:48 INFO - Running post-action listener: _resource_record_post_action 08:34:48 INFO - [mozharness: 2016-12-14 16:34:48.501416Z] Finished run-tests step (success) 08:34:48 INFO - Running post-run listener: _resource_record_post_run 08:34:48 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38949888; Write bytes: 549481472; Read time: 406; Write time: 1708 08:34:48 INFO - TinderboxPrint: CPU usage
53.6% 08:34:48 INFO - TinderboxPrint: I/O read bytes / time
38,949,888 / 406 08:34:48 INFO - TinderboxPrint: I/O write bytes / time
549,481,472 / 1,708 08:34:48 INFO - TinderboxPrint: CPU idle
2,232.0 (46.4%) 08:34:48 INFO - TinderboxPrint: CPU system
960.7 (20.0%) 08:34:48 INFO - TinderboxPrint: CPU user
1,613.0 (33.6%) 08:34:48 INFO - TinderboxPrint: Swap in / out
288,239,616 / 0 08:34:48 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250393088; Write bytes: 250028032; Read time: 18274; Write time: 445 08:34:48 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34509824; Write bytes: 297962496; Read time: 344; Write time: 1256 08:34:48 INFO - Running post-run listener: _upload_blobber_files 08:34:48 INFO - Blob upload gear active. 08:34:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:48 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 08:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:50 INFO - (blobuploader) - INFO - Done attempting. 08:34:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:51 INFO - (blobuploader) - INFO - Done attempting. 08:34:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:54 INFO - (blobuploader) - INFO - Done attempting. 08:34:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:54 INFO - Return code: 0 08:34:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dfb4b21addb3a632cb71e9d9fae36e8ce102f36bde2f958428da8999c0253c8d7251a41e1a0e1fdbbefdccfe531e4ac27633bac1e5fc4ef98a0b7a7816d6f4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/901d879808b8b506f9b6d67130512c43252ba4c64316fea927ddf7502c4a1b2b5fd68d6b9a27949e7538bef109dea112c3b3e1821851300d0967fe6ed34ae48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251a913544bc35a48f22db2ca21edaa32129a7178001cb1f766a5c5bffa11fcb8fad51ca7bc413721076cceb08b2fc10d8f88c4d4d9a5693b99491ebc0e2109d"} 08:34:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:54 INFO - Contents: 08:34:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dfb4b21addb3a632cb71e9d9fae36e8ce102f36bde2f958428da8999c0253c8d7251a41e1a0e1fdbbefdccfe531e4ac27633bac1e5fc4ef98a0b7a7816d6f4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/901d879808b8b506f9b6d67130512c43252ba4c64316fea927ddf7502c4a1b2b5fd68d6b9a27949e7538bef109dea112c3b3e1821851300d0967fe6ed34ae48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251a913544bc35a48f22db2ca21edaa32129a7178001cb1f766a5c5bffa11fcb8fad51ca7bc413721076cceb08b2fc10d8f88c4d4d9a5693b99491ebc0e2109d"} 08:34:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:54 INFO - Copying logs to upload dir... 08:34:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.596926 ========= master_lag: 3.19 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-14 08:34:57.636864) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:34:57.640392) ========= 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.MiP033ofpJ/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.o8QjhxOUDv/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dfb4b21addb3a632cb71e9d9fae36e8ce102f36bde2f958428da8999c0253c8d7251a41e1a0e1fdbbefdccfe531e4ac27633bac1e5fc4ef98a0b7a7816d6f4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/901d879808b8b506f9b6d67130512c43252ba4c64316fea927ddf7502c4a1b2b5fd68d6b9a27949e7538bef109dea112c3b3e1821851300d0967fe6ed34ae48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251a913544bc35a48f22db2ca21edaa32129a7178001cb1f766a5c5bffa11fcb8fad51ca7bc413721076cceb08b2fc10d8f88c4d4d9a5693b99491ebc0e2109d"} build_url:https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/eBxhz1CBQ9K5ToARkOT7ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dfb4b21addb3a632cb71e9d9fae36e8ce102f36bde2f958428da8999c0253c8d7251a41e1a0e1fdbbefdccfe531e4ac27633bac1e5fc4ef98a0b7a7816d6f4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/901d879808b8b506f9b6d67130512c43252ba4c64316fea927ddf7502c4a1b2b5fd68d6b9a27949e7538bef109dea112c3b3e1821851300d0967fe6ed34ae48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251a913544bc35a48f22db2ca21edaa32129a7178001cb1f766a5c5bffa11fcb8fad51ca7bc413721076cceb08b2fc10d8f88c4d4d9a5693b99491ebc0e2109d"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:34:57.833689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:34:57.833976) ========= 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.MiP033ofpJ/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.o8QjhxOUDv/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005230 ========= master_lag: 0.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:34:58.219065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:34:58.219391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:34:58.221404) ========= ========= Total master_lag: 3.82 =========