builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0025 starttime: 1484267648.45 results: success (0) buildid: 20170112154018 builduid: 045fd10f615249df8188a946659444d8 revision: 721c28b39396010388fcab52459e98435ee8b33e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.450630) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.451136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.451411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.477953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.478289) ========= 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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 --2017-01-12 16:34:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2017-01-12 16:34:08 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.647352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.647668) ========= 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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.037953 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:08.709162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 16:34:08.709548) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 721c28b39396010388fcab52459e98435ee8b33e --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 721c28b39396010388fcab52459e98435ee8b33e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 2017-01-12 16:34:08,804 truncating revision to first 12 chars 2017-01-12 16:34:08,804 Setting DEBUG logging. 2017-01-12 16:34:08,804 attempt 1/10 2017-01-12 16:34:08,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/721c28b39396?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 16:34:09,923 unpacking tar archive at: mozilla-central-721c28b39396/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 16:34:10.127240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:10.127702) ========= script_repo_revision: 721c28b39396010388fcab52459e98435ee8b33e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:10.128455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:10.128866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 16:34:10.149654) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-12 16:34:10.150197) ========= /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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:10 INFO - MultiFileLogger online at 20170112 16:34:10 in /builds/slave/test 16:34:10 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 16:34:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:34:10 INFO - {'append_to_log': False, 16:34:10 INFO - 'base_work_dir': '/builds/slave/test', 16:34:10 INFO - 'blob_upload_branch': 'Firefox', 16:34:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:34:10 INFO - 'branch': 'Firefox', 16:34:10 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:10 INFO - 'config_files': ('talos/mac_config.py',), 16:34:10 INFO - 'default_actions': ('clobber', 16:34:10 INFO - 'read-buildbot-config', 16:34:10 INFO - 'download-and-extract', 16:34:10 INFO - 'populate-webroot', 16:34:10 INFO - 'create-virtualenv', 16:34:10 INFO - 'install', 16:34:10 INFO - 'run-tests'), 16:34:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:10 INFO - 'download_minidump_stackwalk': True, 16:34:10 INFO - 'download_symbols': 'ondemand', 16:34:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:10 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:10 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:10 INFO - 'installer_path': 'installer.exe', 16:34:10 INFO - 'log_level': 'info', 16:34:10 INFO - 'log_name': 'talos', 16:34:10 INFO - 'log_to_console': True, 16:34:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:34:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:34:10 INFO - 'opt_config_files': (), 16:34:10 INFO - 'pip_index': False, 16:34:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:10 INFO - 'cmd': ('bash', 16:34:10 INFO - '-c', 16:34:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:10 INFO - 'enabled': True, 16:34:10 INFO - 'halt_on_failure': False, 16:34:10 INFO - 'name': 'check_screen_resolution'},), 16:34:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:10 INFO - 'cmd': ('bash', 16:34:10 INFO - '-c', 16:34:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:10 INFO - 'enabled': True, 16:34:10 INFO - 'halt_on_failure': False, 16:34:10 INFO - 'name': 'check_screen_resolution'},), 16:34:10 INFO - 'run_cmd_checks_enabled': True, 16:34:10 INFO - 'sps_profile': False, 16:34:10 INFO - 'sps_profile_interval': 0, 16:34:10 INFO - 'suite': 'dromaeojs', 16:34:10 INFO - 'system_bits': '32', 16:34:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:10 INFO - 'title': 't-yosemite-r7-0025', 16:34:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:10 INFO - 'use_talos_json': True, 16:34:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:34:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:10 INFO - 'work_dir': 'build'} 16:34:10 INFO - [mozharness: 2017-01-13 00:34:10.357939Z] Running clobber step. 16:34:10 INFO - Running pre-action listener: _resource_record_pre_action 16:34:10 INFO - Running main action method: clobber 16:34:10 INFO - rmtree: /builds/slave/test/build 16:34:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:34:12 INFO - Running post-action listener: _resource_record_post_action 16:34:12 INFO - [mozharness: 2017-01-13 00:34:12.532169Z] Finished clobber step (success) 16:34:12 INFO - [mozharness: 2017-01-13 00:34:12.532293Z] Running read-buildbot-config step. 16:34:12 INFO - Running pre-action listener: _resource_record_pre_action 16:34:12 INFO - Running main action method: read_buildbot_config 16:34:12 INFO - Using buildbot properties: 16:34:12 INFO - { 16:34:12 INFO - "project": "", 16:34:12 INFO - "product": "firefox", 16:34:12 INFO - "script_repo_revision": "production", 16:34:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:34:12 INFO - "repository": "", 16:34:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:34:12 INFO - "buildid": "20170112154018", 16:34:12 INFO - "pgo_build": "False", 16:34:12 INFO - "basedir": "/builds/slave/test", 16:34:12 INFO - "buildnumber": 7, 16:34:12 INFO - "slavename": "t-yosemite-r7-0025", 16:34:12 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:34:12 INFO - "platform": "yosemite_r7", 16:34:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:34:12 INFO - "branch": "mozilla-central", 16:34:12 INFO - "repo_path": "mozilla-central", 16:34:12 INFO - "revision": "721c28b39396010388fcab52459e98435ee8b33e", 16:34:12 INFO - "stage_platform": "macosx64", 16:34:12 INFO - "builduid": "045fd10f615249df8188a946659444d8", 16:34:12 INFO - "slavebuilddir": "test" 16:34:12 INFO - } 16:34:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 16:34:12 INFO - Running post-action listener: _resource_record_post_action 16:34:12 INFO - [mozharness: 2017-01-13 00:34:12.535650Z] Finished read-buildbot-config step (success) 16:34:12 INFO - [mozharness: 2017-01-13 00:34:12.535801Z] Running download-and-extract step. 16:34:12 INFO - Running pre-action listener: _resource_record_pre_action 16:34:12 INFO - Running main action method: download_and_extract 16:34:12 INFO - mkdir: /builds/slave/test/build/tests 16:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:12 INFO - trying https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 16:34:12 INFO - Downloading https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/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 16:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/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 16:34:13 INFO - Downloaded 1199 bytes. 16:34:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:34:13 INFO - Using the following test package requirements: 16:34:13 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:34:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 16:34:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 16:34:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'jsshell-mac.zip'], 16:34:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 16:34:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:34:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 16:34:13 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 16:34:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 16:34:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 16:34:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:34:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:34:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:34:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:34:14 INFO - Expected file size: 16314510 16:34:14 INFO - Obtained file size: 16314510 16:34:21 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 16:34:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:34:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:34:21 INFO - Fetch https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:34:22 INFO - Expected file size: 16314510 16:34:22 INFO - Obtained file size: 16314510 16:34:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 16:34:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:34:28 INFO - Fetch https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 16:34:29 INFO - Expected file size: 14403555 16:34:29 INFO - Obtained file size: 14403555 16:34: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')]} 16:34:29 INFO - trying https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:34:29 INFO - Downloading https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 16:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/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 16:34:31 INFO - Downloaded 70020049 bytes. 16:34:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:34:31 INFO - mkdir: /builds/slave/test/properties 16:34:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:34:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:34:31 INFO - Contents: 16:34:31 INFO - build_url:https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:34:32 INFO - Running post-action listener: _resource_record_post_action 16:34:32 INFO - Running post-action listener: set_extra_try_arguments 16:34:32 INFO - [mozharness: 2017-01-13 00:34:32.471074Z] Finished download-and-extract step (success) 16:34:32 INFO - [mozharness: 2017-01-13 00:34:32.471198Z] Running populate-webroot step. 16:34:32 INFO - Running pre-action listener: _resource_record_pre_action 16:34:32 INFO - Running main action method: populate_webroot 16:34:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:34:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:34:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:34:32 INFO - '--tppagecycles', 16:34:32 INFO - '7'], 16:34:32 INFO - 'tests': ['tsvgm']}}, 16:34:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:34:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:34:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:34:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:34:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:34:32 INFO - 'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:34:32 INFO - 'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['damp', 'tps']}, 16:34:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:34:32 INFO - 'tests': ['damp', 'tps']}, 16:34:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['dromaeo_dom']}, 16:34:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:34:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['basic_compositor_video']}, 16:34:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:34:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['a11yr', 16:34:32 INFO - 'ts_paint', 16:34:32 INFO - 'tpaint', 16:34:32 INFO - 'sessionrestore', 16:34:32 INFO - 'sessionrestore_no_auto_restore', 16:34:32 INFO - 'tabpaint']}, 16:34:32 INFO - 'other-e10s': {'tests': ['a11yr', 16:34:32 INFO - 'ts_paint', 16:34:32 INFO - 'tpaint', 16:34:32 INFO - 'sessionrestore', 16:34:32 INFO - 'sessionrestore_no_auto_restore', 16:34:32 INFO - 'tabpaint']}, 16:34:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:34:32 INFO - 'ts_paint', 16:34:32 INFO - 'tpaint', 16:34:32 INFO - 'sessionrestore', 16:34:32 INFO - 'sessionrestore_no_auto_restore', 16:34:32 INFO - 'tabpaint']}, 16:34:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:34:32 INFO - 'ts_paint', 16:34:32 INFO - 'tpaint', 16:34:32 INFO - 'sessionrestore', 16:34:32 INFO - 'sessionrestore_no_auto_restore', 16:34:32 INFO - 'tabpaint']}, 16:34:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['a11yr', 16:34:32 INFO - 'ts_paint', 16:34:32 INFO - 'tpaint', 16:34:32 INFO - 'sessionrestore', 16:34:32 INFO - 'sessionrestore_no_auto_restore', 16:34:32 INFO - 'tabpaint']}, 16:34:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['a11yr', 16:34:32 INFO - 'ts_paint', 16:34:32 INFO - 'tpaint', 16:34:32 INFO - 'sessionrestore', 16:34:32 INFO - 'sessionrestore_no_auto_restore', 16:34:32 INFO - 'tabpaint']}, 16:34:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['tsvgx', 16:34:32 INFO - 'tsvgr_opacity', 16:34:32 INFO - 'tart', 16:34:32 INFO - 'tscrollx', 16:34:32 INFO - 'cart', 16:34:32 INFO - 'tsvg_static']}, 16:34:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:34:32 INFO - 'tsvgr_opacity', 16:34:32 INFO - 'tart', 16:34:32 INFO - 'tscrollx', 16:34:32 INFO - 'cart', 16:34:32 INFO - 'tsvg_static']}, 16:34:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:34:32 INFO - 'talos_options': ['--disable-e10s'], 16:34:32 INFO - 'tests': ['tp5o']}, 16:34:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:34:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:34:32 INFO - 'talos_options': ['--disable-e10s', 16:34:32 INFO - '--xperf_path', 16:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:32 INFO - 'tests': ['tp5n']}, 16:34:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:34:32 INFO - 'talos_options': ['--xperf_path', 16:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:32 INFO - 'tests': ['tp5n']}}, 16:34:32 INFO - 'talos.zip': {'path': '', 16:34:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:34:32 INFO - Running post-action listener: _resource_record_post_action 16:34:32 INFO - [mozharness: 2017-01-13 00:34:32.489033Z] Finished populate-webroot step (success) 16:34:32 INFO - [mozharness: 2017-01-13 00:34:32.489175Z] Running create-virtualenv step. 16:34:32 INFO - Running pre-action listener: _resource_record_pre_action 16:34:32 INFO - Running main action method: create_virtualenv 16:34:32 INFO - Creating virtualenv /builds/slave/test/build/venv 16:34:32 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 16:34:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:34:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:34:32 INFO - Using real prefix '/tools/python27' 16:34:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:34:33 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:36 INFO - Installing pip.................done. 16:34:36 INFO - Return code: 0 16:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:34:36 INFO - Reading from file tmpfile_stdout 16:34:36 INFO - Output received: 16:34:36 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) 16:34:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:34:36 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')]} 16:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:36 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')]} 16:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:36 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 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:36 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 16:34:36 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 16:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:36 INFO - 'HOME': '/Users/cltbld', 16:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:36 INFO - 'LOGNAME': 'cltbld', 16:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:36 INFO - 'MOZ_NO_REMOTE': '1', 16:34:36 INFO - 'NO_EM_RESTART': '1', 16:34:36 INFO - 'PAGER': '/bin/cat', 16:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:36 INFO - 'PWD': '/builds/slave/test', 16:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:36 INFO - 'SHELL': '/bin/bash', 16:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:36 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:36 INFO - 'USER': 'cltbld', 16:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:36 INFO - 'XPC_FLAGS': '0x0', 16:34:36 INFO - 'XPC_SERVICE_NAME': '0', 16:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:36 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 16:34:36 INFO - Cleaning up... 16:34:36 INFO - Return code: 0 16:34:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:34:36 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')]} 16:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:36 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')]} 16:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:36 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 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:36 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 16:34:36 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 16:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:36 INFO - 'HOME': '/Users/cltbld', 16:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:36 INFO - 'LOGNAME': 'cltbld', 16:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:36 INFO - 'MOZ_NO_REMOTE': '1', 16:34:36 INFO - 'NO_EM_RESTART': '1', 16:34:36 INFO - 'PAGER': '/bin/cat', 16:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:36 INFO - 'PWD': '/builds/slave/test', 16:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:36 INFO - 'SHELL': '/bin/bash', 16:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:36 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:36 INFO - 'USER': 'cltbld', 16:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:36 INFO - 'XPC_FLAGS': '0x0', 16:34:36 INFO - 'XPC_SERVICE_NAME': '0', 16:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:36 INFO - Downloading/unpacking psutil>=3.1.1 16:34:36 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 16:34:36 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 16:34:36 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 16:34:36 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 16:34:36 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 16:34:36 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 16:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:40 INFO - Installing collected packages: psutil 16:34:40 INFO - Running setup.py install for psutil 16:34:40 INFO - building 'psutil._psutil_osx' extension 16:34:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:34:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:34:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:34:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:34:41 INFO - building 'psutil._psutil_posix' extension 16:34:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:34:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:34:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:34:41 INFO - ^ 16:34:41 INFO - 1 warning generated. 16:34:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:34:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:41 INFO - Successfully installed psutil 16:34:41 INFO - Cleaning up... 16:34:41 INFO - Return code: 0 16:34:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:41 INFO - 'HOME': '/Users/cltbld', 16:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:41 INFO - 'LOGNAME': 'cltbld', 16:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:41 INFO - 'MOZ_NO_REMOTE': '1', 16:34:41 INFO - 'NO_EM_RESTART': '1', 16:34:41 INFO - 'PAGER': '/bin/cat', 16:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:41 INFO - 'PWD': '/builds/slave/test', 16:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:41 INFO - 'SHELL': '/bin/bash', 16:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:41 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:41 INFO - 'USER': 'cltbld', 16:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:41 INFO - 'XPC_FLAGS': '0x0', 16:34:41 INFO - 'XPC_SERVICE_NAME': '0', 16:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:34:44 INFO - Installing collected packages: mozsystemmonitor 16:34:44 INFO - Running setup.py install for mozsystemmonitor 16:34:44 INFO - Successfully installed mozsystemmonitor 16:34:44 INFO - Cleaning up... 16:34:44 INFO - Return code: 0 16:34:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:44 INFO - 'HOME': '/Users/cltbld', 16:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:44 INFO - 'LOGNAME': 'cltbld', 16:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:44 INFO - 'MOZ_NO_REMOTE': '1', 16:34:44 INFO - 'NO_EM_RESTART': '1', 16:34:44 INFO - 'PAGER': '/bin/cat', 16:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:44 INFO - 'PWD': '/builds/slave/test', 16:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:44 INFO - 'SHELL': '/bin/bash', 16:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:44 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:44 INFO - 'USER': 'cltbld', 16:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:44 INFO - 'XPC_FLAGS': '0x0', 16:34:44 INFO - 'XPC_SERVICE_NAME': '0', 16:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:45 INFO - Downloading/unpacking jsonschema==2.5.1 16:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:34:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:47 INFO - Downloading functools32-3.2.3-2.tar.gz 16:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:34:48 INFO - warning: no files found matching '*.txt' 16:34:48 INFO - no previously-included directories found matching 'build' 16:34:48 INFO - no previously-included directories found matching 'dist' 16:34:48 INFO - no previously-included directories found matching '.git*' 16:34:48 INFO - Installing collected packages: jsonschema, functools32 16:34:48 INFO - Running setup.py install for functools32 16:34:48 INFO - warning: no files found matching '*.txt' 16:34:48 INFO - no previously-included directories found matching 'build' 16:34:48 INFO - no previously-included directories found matching 'dist' 16:34:48 INFO - no previously-included directories found matching '.git*' 16:34:48 INFO - Successfully installed jsonschema functools32 16:34:48 INFO - Cleaning up... 16:34:48 INFO - Return code: 0 16:34:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:48 INFO - 'HOME': '/Users/cltbld', 16:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:48 INFO - 'LOGNAME': 'cltbld', 16:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:48 INFO - 'MOZ_NO_REMOTE': '1', 16:34:48 INFO - 'NO_EM_RESTART': '1', 16:34:48 INFO - 'PAGER': '/bin/cat', 16:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:48 INFO - 'PWD': '/builds/slave/test', 16:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:48 INFO - 'SHELL': '/bin/bash', 16:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:48 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:48 INFO - 'USER': 'cltbld', 16:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:48 INFO - 'XPC_FLAGS': '0x0', 16:34:48 INFO - 'XPC_SERVICE_NAME': '0', 16:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:34:48 INFO - Cleaning up... 16:34:48 INFO - Return code: 0 16:34:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:48 INFO - 'HOME': '/Users/cltbld', 16:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:48 INFO - 'LOGNAME': 'cltbld', 16:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:48 INFO - 'MOZ_NO_REMOTE': '1', 16:34:48 INFO - 'NO_EM_RESTART': '1', 16:34:48 INFO - 'PAGER': '/bin/cat', 16:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:48 INFO - 'PWD': '/builds/slave/test', 16:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:48 INFO - 'SHELL': '/bin/bash', 16:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:48 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:48 INFO - 'USER': 'cltbld', 16:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:48 INFO - 'XPC_FLAGS': '0x0', 16:34:48 INFO - 'XPC_SERVICE_NAME': '0', 16:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:51 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:34:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:52 INFO - Downloading docopt-0.6.1.tar.gz 16:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:52 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:52 INFO - Running setup.py install for blobuploader 16:34:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:34:52 INFO - Running setup.py install for requests 16:34:53 INFO - Running setup.py install for docopt 16:34:53 INFO - Successfully installed blobuploader requests docopt 16:34:53 INFO - Cleaning up... 16:34:53 INFO - Return code: 0 16:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:53 INFO - 'HOME': '/Users/cltbld', 16:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:53 INFO - 'LOGNAME': 'cltbld', 16:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:53 INFO - 'MOZ_NO_REMOTE': '1', 16:34:53 INFO - 'NO_EM_RESTART': '1', 16:34:53 INFO - 'PAGER': '/bin/cat', 16:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:53 INFO - 'PWD': '/builds/slave/test', 16:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:53 INFO - 'SHELL': '/bin/bash', 16:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:53 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:53 INFO - 'USER': 'cltbld', 16:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:53 INFO - 'XPC_FLAGS': '0x0', 16:34:53 INFO - 'XPC_SERVICE_NAME': '0', 16:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-I_5fvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5RJpPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-xfKxRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-CbsOWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-u9ENwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-CVp2fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-S9HA6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-GB0tyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-XPzYnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-MLKMFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ci6yO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:55 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-A6K7uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:55 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Ie1NNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:55 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-rKF2I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:55 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-AdWNW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:55 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-LSuAPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:55 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-KEUuHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:55 INFO - Running setup.py install for manifestparser 16:34:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:34:55 INFO - Running setup.py install for mozcrash 16:34:55 INFO - Running setup.py install for mozdebug 16:34:56 INFO - Running setup.py install for mozdevice 16:34:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Running setup.py install for mozfile 16:34:56 INFO - Running setup.py install for mozhttpd 16:34:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Running setup.py install for mozinfo 16:34:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Running setup.py install for mozInstall 16:34:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Running setup.py install for mozleak 16:34:56 INFO - Running setup.py install for mozlog 16:34:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for moznetwork 16:34:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for mozprocess 16:34:57 INFO - Running setup.py install for mozprofile 16:34:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for mozrunner 16:34:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for mozscreenshot 16:34:57 INFO - Running setup.py install for moztest 16:34:58 INFO - Running setup.py install for mozversion 16:34:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:58 INFO - Cleaning up... 16:34:58 INFO - Return code: 0 16:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:58 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 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:34:58 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 16:34:58 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 16:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:58 INFO - 'HOME': '/Users/cltbld', 16:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:58 INFO - 'LOGNAME': 'cltbld', 16:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:58 INFO - 'MOZ_NO_REMOTE': '1', 16:34:58 INFO - 'NO_EM_RESTART': '1', 16:34:58 INFO - 'PAGER': '/bin/cat', 16:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:58 INFO - 'PWD': '/builds/slave/test', 16:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:58 INFO - 'SHELL': '/bin/bash', 16:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:34:58 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:58 INFO - 'USER': 'cltbld', 16:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:58 INFO - 'XPC_FLAGS': '0x0', 16:34:58 INFO - 'XPC_SERVICE_NAME': '0', 16:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:58 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-XYWh0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:58 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-YurTsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:58 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)) 16:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:58 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9GLgD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:58 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ZPoKTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:58 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)) 16:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:58 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-a00aZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-AWrR9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Ur0APx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-s7y97u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ZvzdLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-CKQk21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8v5lbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-xTog8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-q1Nstq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:59 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wZS_3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:00 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-sPRRh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:00 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-HugeSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:00 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-AyDc9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:02 INFO - Downloading blessings-1.6.tar.gz 16:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:03 INFO - Installing collected packages: blessings 16:35:03 INFO - Running setup.py install for blessings 16:35:03 INFO - Successfully installed blessings 16:35:03 INFO - Cleaning up... 16:35:03 INFO - Return code: 0 16:35:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:03 INFO - Reading from file tmpfile_stdout 16:35:03 INFO - Current package versions: 16:35:03 INFO - blessings == 1.6 16:35:03 INFO - blobuploader == 1.2.4 16:35:03 INFO - docopt == 0.6.1 16:35:03 INFO - functools32 == 3.2.3-2 16:35:03 INFO - jsonschema == 2.5.1 16:35:03 INFO - manifestparser == 1.1 16:35:03 INFO - mozInstall == 1.12 16:35:03 INFO - mozcrash == 1.0 16:35:03 INFO - mozdebug == 0.1 16:35:03 INFO - mozdevice == 0.49 16:35:03 INFO - mozfile == 1.2 16:35:03 INFO - mozhttpd == 0.7 16:35:03 INFO - mozinfo == 0.9 16:35:03 INFO - mozleak == 0.1 16:35:03 INFO - mozlog == 3.4 16:35:03 INFO - moznetwork == 0.27 16:35:03 INFO - mozprocess == 0.24 16:35:03 INFO - mozprofile == 0.28 16:35:03 INFO - mozrunner == 6.13 16:35:03 INFO - mozscreenshot == 0.1 16:35:03 INFO - mozsystemmonitor == 0.3 16:35:03 INFO - moztest == 0.8 16:35:03 INFO - mozversion == 1.4 16:35:03 INFO - psutil == 3.1.1 16:35:03 INFO - requests == 1.2.3 16:35:03 INFO - wsgiref == 0.1.2 16:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:04 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 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:35:04 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 16:35:04 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 16:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:04 INFO - 'HOME': '/Users/cltbld', 16:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:04 INFO - 'LOGNAME': 'cltbld', 16:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:04 INFO - 'MOZ_NO_REMOTE': '1', 16:35:04 INFO - 'NO_EM_RESTART': '1', 16:35:04 INFO - 'PAGER': '/bin/cat', 16:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:04 INFO - 'PWD': '/builds/slave/test', 16:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:04 INFO - 'SHELL': '/bin/bash', 16:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:35:04 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:04 INFO - 'USER': 'cltbld', 16:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:04 INFO - 'XPC_FLAGS': '0x0', 16:35:04 INFO - 'XPC_SERVICE_NAME': '0', 16:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 INFO - Cleaning up... 16:35:04 INFO - Return code: 0 16:35:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:35:04 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')]} 16:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:04 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')]} 16:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:04 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 0x105b98b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b9b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac8ad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, '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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 16:35:04 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 16:35:04 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 16:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:04 INFO - 'HOME': '/Users/cltbld', 16:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:04 INFO - 'LOGNAME': 'cltbld', 16:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:04 INFO - 'MOZ_NO_REMOTE': '1', 16:35:04 INFO - 'NO_EM_RESTART': '1', 16:35:04 INFO - 'PAGER': '/bin/cat', 16:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:04 INFO - 'PWD': '/builds/slave/test', 16:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:04 INFO - 'SHELL': '/bin/bash', 16:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:35:04 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:04 INFO - 'USER': 'cltbld', 16:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:04 INFO - 'XPC_FLAGS': '0x0', 16:35:04 INFO - 'XPC_SERVICE_NAME': '0', 16:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:35:05 INFO - Cleaning up... 16:35:05 INFO - Return code: 0 16:35:05 INFO - Running post-action listener: _resource_record_post_action 16:35:05 INFO - Running post-action listener: _start_resource_monitoring 16:35:05 INFO - Starting resource monitoring. 16:35:05 INFO - [mozharness: 2017-01-13 00:35:05.231832Z] Finished create-virtualenv step (success) 16:35:05 INFO - [mozharness: 2017-01-13 00:35:05.232774Z] Running install step. 16:35:05 INFO - Running pre-action listener: _resource_record_pre_action 16:35:05 INFO - Running main action method: install 16:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:05 INFO - Reading from file tmpfile_stdout 16:35:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:05 INFO - Reading from file tmpfile_stdout 16:35:05 INFO - Output received: 16:35:05 INFO - Usage: mozinstall [options] installer 16:35:05 INFO - Options: 16:35:05 INFO - -h, --help show this help message and exit 16:35:05 INFO - -d DEST, --destination=DEST 16:35:05 INFO - Directory to install application into. [default: 16:35:05 INFO - "/builds/slave/test"] 16:35:05 INFO - --app=APP Application being installed. [default: firefox] 16:35:05 INFO - mkdir: /builds/slave/test/build/application 16:35:05 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'] 16:35:05 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 16:35:27 INFO - Reading from file tmpfile_stdout 16:35:27 INFO - Output received: 16:35:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:35:27 INFO - Running post-action listener: _resource_record_post_action 16:35:27 INFO - [mozharness: 2017-01-13 00:35:27.425257Z] Finished install step (success) 16:35:27 INFO - [mozharness: 2017-01-13 00:35:27.425416Z] Running run-tests step. 16:35:27 INFO - Running pre-action listener: _resource_record_pre_action 16:35:27 INFO - Running main action method: run_tests 16:35:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:35:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:35:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:35:27 INFO - 2017-01-12 16:35:27.439 screenresolution[1621:7479] starting screenresolution argv=screenresolution get 16:35:27 INFO - 2017-01-12 16:35:27.442 screenresolution[1621:7479] Display 0: 1600x1200x32@60 16:35:27 INFO - 2017-01-12 16:35:27.448 screenresolution[1622:7482] starting screenresolution argv=screenresolution list 16:35:27 INFO - Available Modes on Display 0 16:35:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:35:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:35:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:35:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:35:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:35:27 INFO - Intel Iris: 16:35:27 INFO - Chipset Model: Intel Iris 16:35:27 INFO - Type: GPU 16:35:27 INFO - Bus: Built-In 16:35:27 INFO - VRAM (Dynamic, Max): 1536 MB 16:35:27 INFO - Vendor: Intel (0x8086) 16:35:27 INFO - Device ID: 0x0a2e 16:35:27 INFO - Revision ID: 0x0009 16:35:27 INFO - Displays: 16:35:27 INFO - Display: 16:35:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:35:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:35:27 INFO - Display Serial Number: 1600x1200 60 16:35:27 INFO - Main Display: Yes 16:35:27 INFO - Mirror: Off 16:35:27 INFO - Online: Yes 16:35:27 INFO - Rotation: Supported 16:35:27 INFO - Return code: 0 16:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:35:27 INFO - Python 2.7.3 16:35:27 INFO - Return code: 0 16:35:27 INFO - grabbing minidump binary from tooltool 16:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:27 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 0x105976d30>, '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 0x10589ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10596bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:35:27 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 16:35:27 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 16:35:27 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 16:35:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:35:27 INFO - Return code: 0 16:35:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:35:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:35:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:35:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:35:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:35:27 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/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 16:35:27 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/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --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 16:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4pUR3j8Dcj/Render', 16:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:27 INFO - 'HOME': '/Users/cltbld', 16:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:27 INFO - 'LOGNAME': 'cltbld', 16:35:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:35:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:27 INFO - 'MOZ_NO_REMOTE': '1', 16:35:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:35:27 INFO - 'NO_EM_RESTART': '1', 16:35:27 INFO - 'PAGER': '/bin/cat', 16:35:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:27 INFO - 'PWD': '/builds/slave/test', 16:35:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:27 INFO - 'SHELL': '/bin/bash', 16:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c3Dzfwjf9x/Listeners', 16:35:27 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 16:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:27 INFO - 'USER': 'cltbld', 16:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:27 INFO - 'XPC_FLAGS': '0x0', 16:35:27 INFO - 'XPC_SERVICE_NAME': '0', 16:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:27 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/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 16:35:28 INFO - mozversion application_buildid: 20170112154018 16:35:28 INFO - mozversion application_changeset: 721c28b39396010388fcab52459e98435ee8b33e 16:35:28 INFO - mozversion application_display_name: Nightly 16:35:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:35:28 INFO - mozversion application_name: Firefox 16:35:28 INFO - mozversion application_remotingname: firefox 16:35:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:35:28 INFO - mozversion application_vendor: Mozilla 16:35:28 INFO - mozversion application_version: 53.0a1 16:35:28 INFO - mozversion platform_buildid: 20170112154018 16:35:28 INFO - mozversion platform_changeset: 721c28b39396010388fcab52459e98435ee8b33e 16:35:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:35:28 INFO - mozversion platform_version: 53.0a1 16:35:28 INFO - using testdate: 1484267728 16:35:28 INFO - actual date: 1484267728 16:35:28 INFO - starting webserver on 'localhost:49242' 16:35:28 INFO - SUITE-START | Running 2 tests 16:35:28 INFO - TEST-START | dromaeo_css 16:35:28 INFO - operating with platform_type : mac_ 16:35:28 INFO - Initialising browser for dromaeo_css test... 16:35:28 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpWsPF0U/profile http://localhost:49242/getInfo.html) 16:35:30 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 16:35:30 INFO - PROCESS | 1632 | colorDepth:24 16:35:30 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 16:35:30 INFO - PROCESS | 1632 | __metrics 16:35:30 INFO - PROCESS | 1632 | 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" 16:35:30 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:35:31 INFO - TEST-INFO | 1632: exit 0 16:35:31 INFO - Browser initialized. 16:35:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:35:31 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpWsPF0U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:43 INFO - PROCESS | 1634 | RSS: Main: 235302912 16:35:43 INFO - PROCESS | 1634 | 16:38:46 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 16:38:48 INFO - PROCESS | 1634 | RSS: Main: 402767872 16:38:48 INFO - PROCESS | 1634 | 16:40:31 INFO - PROCESS | 1634 | ************************* 16:40:31 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 16:40:31 INFO - PROCESS | 1634 | 16:40:31 INFO - PROCESS | 1634 | Full message: ReferenceError: fetch is not defined 16:40:31 INFO - PROCESS | 1634 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 16:40:31 INFO - PROCESS | 1634 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 16:40:31 INFO - PROCESS | 1634 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 16:40:31 INFO - PROCESS | 1634 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 16:40:31 INFO - PROCESS | 1634 | TaskImpl@resource://gre/modules/Task.jsm:277:3 16:40:31 INFO - PROCESS | 1634 | asyncFunction@resource://gre/modules/Task.jsm:252:14 16:40:31 INFO - PROCESS | 1634 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 16:40:31 INFO - PROCESS | 1634 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 16:40:31 INFO - PROCESS | 1634 | TaskImpl@resource://gre/modules/Task.jsm:277:3 16:40:31 INFO - PROCESS | 1634 | asyncFunction@resource://gre/modules/Task.jsm:252:14 16:40:31 INFO - PROCESS | 1634 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 16:40:31 INFO - PROCESS | 1634 | 16:40:31 INFO - PROCESS | 1634 | ************************* 16:41:51 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 16:41:52 INFO - PROCESS | 1634 | RSS: Main: 373780480 16:41:52 INFO - PROCESS | 1634 | 16:44:54 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 16:44:55 INFO - PROCESS | 1634 | RSS: Main: 347598848 16:44:55 INFO - PROCESS | 1634 | 16:47:57 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 16:47:58 INFO - PROCESS | 1634 | RSS: Main: 359391232 16:47:58 INFO - PROCESS | 1634 | 16:51:01 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 16:51:02 INFO - PROCESS | 1634 | RSS: Main: 327716864 16:51:02 INFO - PROCESS | 1634 | 16:54:05 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 16:54:06 INFO - PROCESS | 1634 | RSS: Main: 400334848 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | __start_tp_report 16:54:06 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 16:54:06 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 16:54:06 INFO - PROCESS | 1634 | |i|pagename|runs| 16:54:06 INFO - PROCESS | 1634 | |0;dojo.html;3290.506424036394;3322;3333.816640084796;3341.498775183724;3380.357732030914;5484.808031718891;5575.107982722765;5670.036093864042;5671.206031155636;5698.03133467311;5558.972205138979;5599.580031497633;5603.355614104379;5606.243157173781;5612.298462692163;5075.74621268936;5106.514881086291;5121.436641969381;5139.280500729901;5169.069567477853;5210.817621383252;5225.843224703265;5236.869078273055;5249.265102885599;5254.763535640886;5210.947890521104;5211.609129315298;5235.424103348629;5241.082810508165;5244.527992480676;5222.686638801646;5224.686518808883;5227.79088836446;5230.790768369261;5252.553532949704;4999.8000079996755;5149.974250128763;5179.14544100223;5188.740562971874;5189.299444574972;5710.200571919934;5733.254676892019;5739.16782066598;5739.684317362543;5762.88474230513;6145.201123853915;6176.227971503562;6182.659953702545;6194.721237544321;6194.81415557534;5471.68679516917;6095.664738439384;6103.307364981935;6128.483736330591;6160.322364539897;5754.194412782172;5762.222100016528;5778.075507918713;5787.305523337226;5834.620749651259;6223.813285601439;6251;6261.8747625047245;6276.717547710364;6285.151504546828;5945.137954996588;6022.668753218615;6031.607945483617;6104.3590423005835;6113.388661133851;5124.538791508708;6159.045347971071;6168.228971378578;6216.782412615627;6261.9373806262265;6032.155498230251;6183.041628547582;6183.103449999725;6185.752569897244;6187.071939209155;5578.832635020955;6169.074638804215;6172.567920245539;6234.314225435199;6246.281677607042;4816.807327706852;4882.926756098661;4889.266610008527;4913.9017219656125;4926.9014619707405;4411.625011873963;4426.11477704454;4427.623651989553;4451.376807246988;4487.214737420938;4931.112399768004;5798.884022319615;5826.329972053268;5826.766929322865;5831.212786273799;5283.682979021271;6117.632942023492;6142.437386315926;6154.3845615438095;6308.337624549448;4876.804927802848;5647.519960803295;5731.398203188689;5789.073748200268;5809.9419005809405;5390.0836857734275;5417.5395091416885;5421.647592906448;5423.593230507728;5442.346918369821;6145.3407579954055;6324.893143699926;6344.6827658616885;6358.1734374531015;6367.840803979938;6106.725197366218;6121.296050954197;6146.78486252979;6166.81499555014;6184.536159788124;6106.511479081574;6330.303666596578;6350.714217860115;6360.968195158995;6371.585846919936;6105.603135796159;6107.643995706967;6111.908321375094;6121.331035925228;6128.167033931239;6128.56865797067;6152.323244443197;6156.938430615636;6176.320604733565;6186.5360097993735;4756.857294281039;4929.975350123226;5918.526517878646;5957.582969192115;5970.641761494324;6073.240844894388;6091.299500557493;6091.7563297467605;6101.29835068955;6139.017757158833;5922.703864806656;5989.520838332835;5990.88018239624;5998.1002849572915;5998.850028749316;5969.164316995711;6022.337542870193;6034.275886893601;6119.938800611937;6133.172021777182;5946.405359464019;5991.970040149771;5996.130561068708;5998.310194327708;6083.847903802441 16:54:06 INFO - PROCESS | 1634 | |1;ext.html;456.76248350857543;471.1519265322419;504.33176041744684;522.9790808367666;539.7840863654535;26538;30085.84957075217;39028.41457378142;40758.796206019004;40800.59199408005;41658.791706041506;42059.36910946338;42149.7892510537;42152.15695686085;42283.15433691324;8252.917470825305;9088.454692718426;9193.586288617029;9303.534823258844;9327.62689492423;8333.583320833965;8513.914860851373;9276.768080797967;10784.892151078468;11036.227464077518;11100.278481898691;11192.38441885696;11213.551457941672;11214.775704485904;11223.887761122407;11177.944110279437;11232.831507527311;11249.60626378077;11253.66239012831;11281.717957051058;8279.379046571532;8442.831143377098;10848.728781780439;11079.667609971713;11112.555497780078;39894;40262.79868600638;40277.597224027675;40345.798271008454;40358.596414035776;3845.2309538092495;4025.838966441339;4087.6934229932576;4092.9795351023354;4171.853985110537;29682.40635187284;30643;30722.539161912588;30766;31215.375692486024;3124.6719094495206;3169.952450713241;3237.919052023695;3294.736421086331;3341.114604629775;476716;481621;484081;484475.57762211317;493693;58440.707796460745;58798.70600646969;58897.411025889196;58899.70550147307;58921.52696182544;61386.69306653528;61488;61503.769924601256;61631.07553386703;61664.44201148829;15709.293081811118;15936;15953.282102305424;15954.361825526848;15993.840061599236;10534.20993425496;12062.939685301517;12437.129400942029;12491.812622810665;12521.311327877054;13686.65783355424;13957.720845583235;14005.579832605039;15305.923470382577;15584.298706558233;6116.449519543174;7146.392556632744;7310;7337.853242935112;7431.85136297271;895.3329769321897;907.1654078248027;927.888653361601;937.2080591899834;937.634322614181;28886.422271554453;29922.850385747934;29966.850165749467;30643.69356306453;30659.846700766353;904.755715956688;1084.2139448899484;1122.1247427006786;1152.4295473740551;1207.124834494984;13378.063535552612;14761.92619036898;15107.848921510644;15477.922610386877;15528.689426211638;601279;602837;604238;604261;604594;58993.705031474565;59202.40797591969;59409.70295148583;59431.702841485516;59474.405255946884;1441.9855801441852;1448.3627204030192;1469.2066284206624;1486.1900264355952;1494.1035378772867;28495.43009139847;29073.563896541993;29133.271668207617;29436;30067;49159.75420122877;49655.503444965085;49709.75145124251;49758;49781.00437991292;440047.79976099916;440274;440948;440997;441457.5854241545;37810.054748631504;38297.425538616386;38449.42325865058;38555.42166867443;38668;44849.77575112104;45733.54266457293;45885.082298354515;45930.54069459263;46115.769421152676;31340.216494587818;37179.62820371761;37282.44076338912;37818.81090594529;38719.419208711326;37427.625723742414;37470.43794343033;37884.43173352347;38208.617913820504;38738.03154921037;36728.89813305605;36804;37416.62583374132;37940.62059379371;38418.0395490115;30297.636606353208;32532.51201231936;33259.00222993314;33984;34205.828970854986;21317.147314107264;23424.882875585514;24127;24640.89115989749;25070.247892563253 16:54:06 INFO - PROCESS | 1634 | |2;jquery.html;325.2162288883791;331.9817410042448;390.9218156368725;399.59741308008887;421.97468151910886;15099.471518496855;15436;16712.74930876036;20330.695039574417;21216.04527796249;12357.011439084874;14325.426982920671;20405.897970510126;21223.893880530577;21299.467513312135;5342.118550439173;5565.109582466806;5569.359523654771;5572.275604171452;5594.188842617818;5182.714950677711;5441.646292990963;7925.484843485155;7993.2806047455715;8084.7574572762915;7332.816679582999;7644.847103057936;8077.717279895205;8098.028236611615;8102.837943241132;7592.126905405838;7890.132085470594;7902.486338388015;7908.802279943047;7954.085280192736;7580.090389153337;7605.353544948686;7634.198409167068;7679.116901556281;7720.845583088307;29552.408951820842;29568.156139701918;30077.548836767466;30243.848780755954;30486.84756576203;2371.864098059611;2514.6730924979634;2959.556066590007;2975.8363290019042;3030.757539396843;16181.271842766986;16782.74825877613;16813.495595132164;16827.495175144766;17378.217980190922;1680.9747853782203;1954.4332143678316;1970.6255811395788;1986.7218589397496;1989.761228652571;132665;135215.6478435213;153226;159206.20396897942;160772;22544.436389090402;22724.863756812094;23092;23364;23398.415039624146;41136.98500047521;41541.584584153774;41777;41882;41976.74069777912;9468.715938521855;11117.444127793578;11222.214444988937;11274.041706455044;11370.147238957112;8906.287497000225;8941.865872011926;8946.913314906347;9090.500022498825;9106.180443760093;9676.322657413913;10007.298029531985;10516.316439431412;10811.297265677706;10897.291676041032;3368.5261450143516;3937.586553411908;4116.897077573085;4118.5263694674895;4135.793210339471;997.4165113408737;1002.5739060899089;1003.8393856982848;1026.2918586175515;1035.49260862177;22034.44913877134;22591.09635614557;22596.774032259465;22627.43431414195;22642.094316227165;1024.6157690865925;1025.2720568396373;1045.341434896026;1062.516554967488;1064.4677661169414;9073.45559266446;10697.786044279072;11480.540778368939;11515.481803318871;11538.88461115395;568045;707454;708238;719648.4017579879;725516;89657.55171224232;97301;139709;143740.2828533301;158985.76734838853;911.9088091190961;1000.229823036258;1028.4908970059869;1059.7244716373643;1066.8879767624444;14374.640633984234;19387.836729796258;19679.31122410766;20486.12147069627;20641.277555286095;42151.57848421476;47722;56704.71647641735;59014.34435450329;61809;65289.67355163194;68895.65552172207;83615;83753.58123209345;89092;6201.844953876009;8283.337333013224;8346.330733853132;8608.09614990442;8846.77883052903;10633.946830266108;13050.282234477196;13359.866401335863;13488.865111349154;13593.932030339785;9805.362651427635;10694.89305106939;11584.826227606423;11712.418823458724;11773.352465614473;8344.290735287568;11364.147688923198;11371.31772093677;11648.301101933912;11885.881141188824;9394.745261137141;11577.247478913843;11717;12012.219205751599;12016.33910134951;8306.460080094774;8485.363597730071;8575.271101956403;8577.528235947082;8597.441166324168;10347.379157250589;10906.781864362827;11299.661010169708;11350.659480215607;11482.36846973391 16:54:06 INFO - PROCESS | 1634 | |3;mootools.html;1457.7594696875017;1467.4350375105582;1468.368601501354;1483.2954346685326;1487.8586534279239;8080.111187769348;8493.91506084939;8506.70226542072;8519.616617252223;8527;7214.278572142783;7463.02980612521;7476.813079673011;7971.322437592811;8189.95905020474;2296.7358753743365;2308.1690591387087;2330.2892617751577;2341.8243631727605;2342.2153578551206;2316.143027079974;2341.2976107167865;2347.8239132065078;2352.2707960532202;2355.6702061711376;2309.503456756797;2310.156792770635;2324.616438287689;2328.1734984080663;2336.8013718833918;2270.5685919675293;2276.5333106713083;2294.0521628498686;2299.1952816514085;2313.086330899302;2303.6890019847274;2325.3024092772102;2335.894884730174;2335.9649605255936;2336.3341447687326;8146.103928567853;8303.4602750821;8315.750527484124;8326.542040187787;8336.499810011419;5032.169692000852;5186.170212765939;5193.766280517386;5195.792168313263;5207.661502002357;3264.820434876081;3357.6306606273292;3476.044087875829;3520.419130843408;3533.8233088345737;1136.318209074557;1196.9521219151225;1201.7055821323745;1232.057476030837;1235.9258444493269;10716.035556799847;10802.621908233174;10827.891721082768;10832.187585931088;10847.240693151483;4373.978130109393;4629.444466664022;4697.741624210701;4711.528847115261;4717.575418212377;9328.580213890256;9350.111739384747;9356.625734970661;9365.15713585767;9368.953155234316;5231.973840130775;5232.73836308183;5233.162693968947;5242.554382877422;5255.290535777697;4282.76444795533;4326.456161108211;4597.540245975442;4686.81252749893;4782.426108866958;3738.2149748553106;3797;3849.268638958589;3882.8835134946;3916.3146449371816;1265.0891358222066;1271.4405661508906;1272.8599854016052;1282.4799269435418;1287.43996361583;787.5786454247065;788.6845261895288;788.755485799404;807.2331285278891;807.4105902691068;5437.537809286176;5460.754266058037;5603.2435621191435;5623.550115990711;5733.856653583611;560.9214709940611;583.813179782474;593.0836857055859;597.6623207887529;597.6682940967718;3524.823758812049;3617;3672.4208590306425;3694.1688120173285;3698.6486283802997;9586.66446674363;9821.950890245645;9941.45322007282;9948.900510994943;9948.900510994943;9607.663731769355;9904.158146557624;9915.206783457306;9917.008299170026;9943.651972180938;7557.206493318123;7776.922230777733;7784.532928024337;7791.961040194876;7792.961035194788;5252;5265.420803711665;5310.300703774755;5353.812616558402;5417.945820541744;8911.37620366568;9134.995150533568;9169.403988740978;9172.03693612161;9265.768355791159;9071.228945539702;9115.134062264075;9286.34995550305;9346.906530934604;9425.151736343487;5295.973520132375;6680.565763225375;6691.5315927884585;6909.481788865955;7076;7627.885581716389;7806.219378062376;7879.172686868025;7917.2874441300555;7997.160298168608;6013.7293821779;6991.335823096798;7092.645367731489;7095.184053833876;7225.205227424874;6936.687849046906;6977.476689248429;6992.685329160302;7000.264972178052;7012.824679383056;6325.304216536269;6383.329750376143;6437.581557198767;6454.41910228063;6463.192100987377;4929.975350123226;4949.653524253267;5004.274380214775;5091.439941606494;5104.132297509358;4904.945436730977;4972;5035.194368900959;5169.043726910533;5183.818566350311 16:54:06 INFO - PROCESS | 1634 | |4;prototype.html;355.28410253339524;355.4543775304907;365.4737178463014;372.5231703419624;375.992480150397;4225.148025083072;4522.47991480979;4664.813407463697;5282.260483532304;5302.946970530294;4413.271810151321;4894.951050489494;5215.1395019821775;5222.63441559091;5226.895462090756;3329.5338652588657;3443.345764304787;3494.7109643183753;3799.620037996206;4027.41602467642;3384.593848738155;3605.693516051139;3608.8451695457466;3780;4033.394990751396;3387.728981681472;3536.797488853789;4075.612816782401;4089.734167279132;4105.542532400999;3183.681631836821;4075.9592404076025;4088.284550203717;4103.671706263522;4107.322291821846;2800.4259126879147;3479.68682818545;3500.3699334119847;3578.964210357889;3595.26297109092;3725.2549490102087;3950.8419663213435;4851.951480485185;4966.6771659842;5084.923726144111;4198.538160802309;4466.855909163587;4670.626349892001;4672.243376407901;4684.95315046852;5040.269160971675;5253.343332083489;5467.808626698046;5535.726782839969;5559.359304330451;3470.403614337408;3971.801409929492;3986.5614782373914;4028.576999415078;4043.3126368517424;4710.505396933307;5460.0414699343055;5716.371199168088;5722.828315150552;5811.506021988136;3998.620131087542;4078.021274894004;4089.8364065437645;4103.9179216415505;4113.3957756475;3491.8952431427097;3698.5746639136305;3764.1906989997283;4089.2230476209425;4197.4753155855515;3774.2640185163627;4700.435947686299;4706.270528068155;4711.599514041345;4750.406199225097;4372.6939114261695;5591.664500130005;5599.78012642732;5602.243697100921;5605.7197140142825;1262.8547717012661;1319.4035217386877;1336.7460182565283;1369.2400717601627;1369.9999000729524;823.8558252305822;895.7133717210561;963.7879666473365;977.5845265762165;980.9509524523745;3906.109478985587;4847.297141914473;4854.951450485521;4919.262110683426;4955.975220123948;4368.694191406635;4792.976035119802;4883.658143929962;5113.261491093046;5459.989901868167;4272.5086615039045;4300.913981720348;4706.435227772689;4948.703077815343;4959.603231741452;2654.9469010619678;2795.412963277694;2833.8724757385967;2869.7991140620375;2870.3111253299476;4745.762711864393;5547.916781248285;5623.959567480029;5630.915536266959;5674.971625141848;4704.9529504704515;4825.565699087099;5058.317127187856;5176.516864981837;5584.425967380879;4575.088299503943;5078.162103252996;5246.344206974129;5583.469570390806;5585.497305242548;4478.865634030984;5348.128155145668;5414.891702165856;5429.321334833146;5430.425176698713;4994.825181118644;5090.898182036412;5383.308345827087;5413.756380962787;5424.511793938565;5593.580481463825;5648.85877853057;5715.199872018004;5785.103308987113;5908.1137829324225;3791.7345785795833;3827.712921530952;3833.789141597239;3843.327417701947;3860;5669.943300566942;5684.687342196054;5688.7440065198;5696.829095127153;5713.514351280021;5236;5314.8376715854;5384.703841288767;5495.670259784426;5610.382857885711;4562.973331000499;4818.8918147793775;4872.366592342973;5014.5737612303365;5548.722563871871;4491.416115905042;4779.784909679003;5129.512696293846;5465.453454654503;5503.504684578407;4611.193041217706;4642.582167604932;4985.750712464434;5340.439253878442;5485.609265205991;5098.311727916832;5120.948790512047;5416.539594134385;5448;5486.533644640091 16:54:06 INFO - PROCESS | 1634 | |5;yui.html;674.4334758802605;743.4424181863602;794.1502592226317;800.2397722163946;822.4879763410243;15405.075695458267;15933.44232951847;15974.121423321712;16008.039517628951;16024.198790060495;14653.45742819724;14890.478833240839;14908.701825963475;14919.403223871032;14932.925335373335;672.4015626092781;698.7554355975393;848.6520526584086;848.9108643592426;886.9556522173898;727.1601300497933;869.3436455476107;870.6778491957984;872.1148034744739;878.9824203515926;942.3968660057569;946.0397696338222;949.0035462764105;950.9966984831001;952.0669743651226;788.7278888783361;937.446906325268;938.2025278513244;938.737153596994;940.0928104379238;524.5279248676184;543.9564834813206;663.5554178700282;682.5290549520864;694.9861002779967;12898.968082553372;15018.774718379233;15258.160801155933;15402.306896189699;15488.690226195413;13905.930470347685;14008;14087.929560352235;14097.859021409757;14098.647533811634;12647.620571382873;12919;12960.416781244867;13085.084044116915;13499.25754083525;4383.9342409863875;4429;4439.134368798085;4463.553644635543;4574.977693369811;84560.57719711363;103817;109455;110086.44956775245;110117.44941275242;9967.302288839857;10874.619388321371;11225.943870280596;11272.774544509064;11647.475863586158;20424.897875510826;21482.570348593254;21538;22058.44853878666;22824.201152959566;7756.883646745303;7928.3260922821055;7953.164917683675;7971.40214483916;8060.83878322442;4300.634446072057;4373.781310934441;4404.339349097597;4413.646908247332;4514.45826500822;3628.9455658165148;3678.2275722098125;3683.4843121962945;3704.7777133372083;3724.417122722832;682.147315855181;684.2097377528962;692.6225207262054;698.5459451356558;699.2308460693197;626.971786269619;682.8327059870363;688.8863337549349;700.8563244534859;731.7694926098262;9471.479068651153;9792.020797920151;10083.546240419199;10291.433971131659;10608.734781630521;673.6732684647942;680.6256558892688;708.7129712466459;709.7118729506034;714.5998240985065;4454.042380888124;4826.7827947742435;4882.633802464829;4901.189705809164;4967.5777558907175;101920;102898.48550757348;103868.48065759623;104204;104632.47683761685;89201.55399222963;90472.5476372627;92353;93246;94460.11079778367;79327.5143225653;79953.99999999884;80152.79770803326;80504;81486.37027259421;9344.609301675615;9659;10514.789704206027;11017.83473247886;11143.33140011602;49069.2639610399;49406.75296623494;49925.00149996907;51098.74450627723;51252.231216531036;51264;70232.64883675548;71591;72556.63721681357;72736;12613.36933153357;13143.605691828878;13333.53292218034;13337.266450345323;13339.333033348488;11626.82559761621;15030.774538382151;15039.774403383739;15082.924585377003;15460;11173.441327933733;13784;14081.859181408465;14195.574132776033;14457.85542144565;13648.317584120556;13734.65663358424;14108.435662573382;14282.143071415749;14328.034753909416;10732.624358147428;13419.194848308742;13447.46210151583;13491.932540337235;13869.930650346683;11116.944415277872;11203.21577489568;11384.260023098472;11427;11886.82169767437;10915.56337746513;11059.170562207706;11122.080937473618;11262.943685281522;11306 16:54:06 INFO - PROCESS | 1634 | __end_tp_report 16:54:06 INFO - PROCESS | 1634 | __start_cc_report 16:54:06 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1763 16:54:06 INFO - PROCESS | 1634 | __end_cc_report 16:54:06 INFO - PROCESS | 1634 | __startTimestamp1484268846165__endTimestamp 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | ------- Summary: start ------- 16:54:06 INFO - PROCESS | 1634 | Number of tests: 6 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5677.65 Median:5922.70 stddev:638.90 (10.8%) stddev-sans-first:612.80 16:54:06 INFO - PROCESS | 1634 | Values: 3290.5 3322.0 3333.8 3341.5 3380.4 5484.8 5575.1 5670.0 5671.2 5698.0 5559.0 5599.6 5603.4 5606.2 5612.3 5075.7 5106.5 5121.4 5139.3 5169.1 5210.8 5225.8 5236.9 5249.3 5254.8 5210.9 5211.6 5235.4 5241.1 5244.5 5222.7 5224.7 5227.8 5230.8 5252.6 4999.8 5150.0 5179.1 5188.7 5189.3 5710.2 5733.3 5739.2 5739.7 5762.9 6145.2 6176.2 6182.7 6194.7 6194.8 5471.7 6095.7 6103.3 6128.5 6160.3 5754.2 5762.2 5778.1 5787.3 5834.6 6223.8 6251.0 6261.9 6276.7 6285.2 5945.1 6022.7 6031.6 6104.4 6113.4 5124.5 6159.0 6168.2 6216.8 6261.9 6032.2 6183.0 6183.1 6185.8 6187.1 5578.8 6169.1 6172.6 6234.3 6246.3 4816.8 4882.9 4889.3 4913.9 4926.9 4411.6 4426.1 4427.6 4451.4 4487.2 4931.1 5798.9 5826.3 5826.8 5831.2 5283.7 6117.6 6142.4 6154.4 6308.3 4876.8 5647.5 5731.4 5789.1 5809.9 5390.1 5417.5 5421.6 5423.6 5442.3 6145.3 6324.9 6344.7 6358.2 6367.8 6106.7 6121.3 6146.8 6166.8 6184.5 6106.5 6330.3 6350.7 6361.0 6371.6 6105.6 6107.6 6111.9 6121.3 6128.2 6128.6 6152.3 6156.9 6176.3 6186.5 4756.9 4930.0 5918.5 5957.6 5970.6 6073.2 6091.3 6091.8 6101.3 6139.0 5922.7 5989.5 5990.9 5998.1 5998.9 5969.2 6022.3 6034.3 6119.9 6133.2 5946.4 5992.0 5996.1 5998.3 6083.8 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:65118.21 Median:38433.73 stddev:136962.86 (356.4%) stddev-sans-first:137261.03 16:54:06 INFO - PROCESS | 1634 | Values: 456.8 471.2 504.3 523.0 539.8 26538.0 30085.8 39028.4 40758.8 40800.6 41658.8 42059.4 42149.8 42152.2 42283.2 8252.9 9088.5 9193.6 9303.5 9327.6 8333.6 8513.9 9276.8 10784.9 11036.2 11100.3 11192.4 11213.6 11214.8 11223.9 11177.9 11232.8 11249.6 11253.7 11281.7 8279.4 8442.8 10848.7 11079.7 11112.6 39894.0 40262.8 40277.6 40345.8 40358.6 3845.2 4025.8 4087.7 4093.0 4171.9 29682.4 30643.0 30722.5 30766.0 31215.4 3124.7 3170.0 3237.9 3294.7 3341.1 476716.0 481621.0 484081.0 484475.6 493693.0 58440.7 58798.7 58897.4 58899.7 58921.5 61386.7 61488.0 61503.8 61631.1 61664.4 15709.3 15936.0 15953.3 15954.4 15993.8 10534.2 12062.9 12437.1 12491.8 12521.3 13686.7 13957.7 14005.6 15305.9 15584.3 6116.4 7146.4 7310.0 7337.9 7431.9 895.3 907.2 927.9 937.2 937.6 28886.4 29922.9 29966.9 30643.7 30659.8 904.8 1084.2 1122.1 1152.4 1207.1 13378.1 14761.9 15107.8 15477.9 15528.7 601279.0 602837.0 604238.0 604261.0 604594.0 58993.7 59202.4 59409.7 59431.7 59474.4 1442.0 1448.4 1469.2 1486.2 1494.1 28495.4 29073.6 29133.3 29436.0 30067.0 49159.8 49655.5 49709.8 49758.0 49781.0 440047.8 440274.0 440948.0 440997.0 441457.6 37810.1 38297.4 38449.4 38555.4 38668.0 44849.8 45733.5 45885.1 45930.5 46115.8 31340.2 37179.6 37282.4 37818.8 38719.4 37427.6 37470.4 37884.4 38208.6 38738.0 36728.9 36804.0 37416.6 37940.6 38418.0 30297.6 32532.5 33259.0 33984.0 34205.8 21317.1 23424.9 24127.0 24640.9 25070.2 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:40080.45 Median:2443.27 stddev:114613.65 (4691.0%) stddev-sans-first:114896.30 16:54:06 INFO - PROCESS | 1634 | Values: 325.2 332.0 390.9 399.6 422.0 15099.5 15436.0 16712.7 20330.7 21216.0 12357.0 14325.4 20405.9 21223.9 21299.5 5342.1 5565.1 5569.4 5572.3 5594.2 5182.7 5441.6 7925.5 7993.3 8084.8 7332.8 7644.8 8077.7 8098.0 8102.8 7592.1 7890.1 7902.5 7908.8 7954.1 7580.1 7605.4 7634.2 7679.1 7720.8 29552.4 29568.2 30077.5 30243.8 30486.8 2371.9 2514.7 2959.6 2975.8 3030.8 16181.3 16782.7 16813.5 16827.5 17378.2 1681.0 1954.4 1970.6 1986.7 1989.8 132665.0 135215.6 153226.0 159206.2 160772.0 22544.4 22724.9 23092.0 23364.0 23398.4 41137.0 41541.6 41777.0 41882.0 41976.7 9468.7 11117.4 11222.2 11274.0 11370.1 8906.3 8941.9 8946.9 9090.5 9106.2 9676.3 10007.3 10516.3 10811.3 10897.3 3368.5 3937.6 4116.9 4118.5 4135.8 997.4 1002.6 1003.8 1026.3 1035.5 22034.4 22591.1 22596.8 22627.4 22642.1 1024.6 1025.3 1045.3 1062.5 1064.5 9073.5 10697.8 11480.5 11515.5 11538.9 568045.0 707454.0 708238.0 719648.4 725516.0 89657.6 97301.0 139709.0 143740.3 158985.8 911.9 1000.2 1028.5 1059.7 1066.9 14374.6 19387.8 19679.3 20486.1 20641.3 42151.6 47722.0 56704.7 59014.3 61809.0 65289.7 68895.7 83615.0 83753.6 89092.0 6201.8 8283.3 8346.3 8608.1 8846.8 10633.9 13050.3 13359.9 13488.9 13593.9 9805.4 10694.9 11584.8 11712.4 11773.4 8344.3 11364.1 11371.3 11648.3 11885.9 9394.7 11577.2 11717.0 12012.2 12016.3 8306.5 8485.4 8575.3 8577.5 8597.4 10347.4 10906.8 11299.7 11350.7 11482.4 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5371.91 Median:5260.36 stddev:2934.31 (55.8%) stddev-sans-first:2927.80 16:54:06 INFO - PROCESS | 1634 | Values: 1457.8 1467.4 1468.4 1483.3 1487.9 8080.1 8493.9 8506.7 8519.6 8527.0 7214.3 7463.0 7476.8 7971.3 8190.0 2296.7 2308.2 2330.3 2341.8 2342.2 2316.1 2341.3 2347.8 2352.3 2355.7 2309.5 2310.2 2324.6 2328.2 2336.8 2270.6 2276.5 2294.1 2299.2 2313.1 2303.7 2325.3 2335.9 2336.0 2336.3 8146.1 8303.5 8315.8 8326.5 8336.5 5032.2 5186.2 5193.8 5195.8 5207.7 3264.8 3357.6 3476.0 3520.4 3533.8 1136.3 1197.0 1201.7 1232.1 1235.9 10716.0 10802.6 10827.9 10832.2 10847.2 4374.0 4629.4 4697.7 4711.5 4717.6 9328.6 9350.1 9356.6 9365.2 9369.0 5232.0 5232.7 5233.2 5242.6 5255.3 4282.8 4326.5 4597.5 4686.8 4782.4 3738.2 3797.0 3849.3 3882.9 3916.3 1265.1 1271.4 1272.9 1282.5 1287.4 787.6 788.7 788.8 807.2 807.4 5437.5 5460.8 5603.2 5623.6 5733.9 560.9 583.8 593.1 597.7 597.7 3524.8 3617.0 3672.4 3694.2 3698.6 9586.7 9822.0 9941.5 9948.9 9948.9 9607.7 9904.2 9915.2 9917.0 9943.7 7557.2 7776.9 7784.5 7792.0 7793.0 5252.0 5265.4 5310.3 5353.8 5417.9 8911.4 9135.0 9169.4 9172.0 9265.8 9071.2 9115.1 9286.3 9346.9 9425.2 5296.0 6680.6 6691.5 6909.5 7076.0 7627.9 7806.2 7879.2 7917.3 7997.2 6013.7 6991.3 7092.6 7095.2 7225.2 6936.7 6977.5 6992.7 7000.3 7012.8 6325.3 6383.3 6437.6 6454.4 6463.2 4930.0 4949.7 5004.3 5091.4 5104.1 4904.9 4972.0 5035.2 5169.0 5183.8 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4354.97 Median:4765.10 stddev:1306.35 (27.4%) stddev-sans-first:1275.05 16:54:06 INFO - PROCESS | 1634 | Values: 355.3 355.5 365.5 372.5 376.0 4225.1 4522.5 4664.8 5282.3 5302.9 4413.3 4895.0 5215.1 5222.6 5226.9 3329.5 3443.3 3494.7 3799.6 4027.4 3384.6 3605.7 3608.8 3780.0 4033.4 3387.7 3536.8 4075.6 4089.7 4105.5 3183.7 4076.0 4088.3 4103.7 4107.3 2800.4 3479.7 3500.4 3579.0 3595.3 3725.3 3950.8 4852.0 4966.7 5084.9 4198.5 4466.9 4670.6 4672.2 4685.0 5040.3 5253.3 5467.8 5535.7 5559.4 3470.4 3971.8 3986.6 4028.6 4043.3 4710.5 5460.0 5716.4 5722.8 5811.5 3998.6 4078.0 4089.8 4103.9 4113.4 3491.9 3698.6 3764.2 4089.2 4197.5 3774.3 4700.4 4706.3 4711.6 4750.4 4372.7 5591.7 5599.8 5602.2 5605.7 1262.9 1319.4 1336.7 1369.2 1370.0 823.9 895.7 963.8 977.6 981.0 3906.1 4847.3 4855.0 4919.3 4956.0 4368.7 4793.0 4883.7 5113.3 5460.0 4272.5 4300.9 4706.4 4948.7 4959.6 2654.9 2795.4 2833.9 2869.8 2870.3 4745.8 5547.9 5624.0 5630.9 5675.0 4705.0 4825.6 5058.3 5176.5 5584.4 4575.1 5078.2 5246.3 5583.5 5585.5 4478.9 5348.1 5414.9 5429.3 5430.4 4994.8 5090.9 5383.3 5413.8 5424.5 5593.6 5648.9 5715.2 5785.1 5908.1 3791.7 3827.7 3833.8 3843.3 3860.0 5669.9 5684.7 5688.7 5696.8 5713.5 5236.0 5314.8 5384.7 5495.7 5610.4 4563.0 4818.9 4872.4 5014.6 5548.7 4491.4 4779.8 5129.5 5465.5 5503.5 4611.2 4642.6 4985.8 5340.4 5485.6 5098.3 5120.9 5416.5 5448.0 5486.5 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20715.36 Median:4378.86 stddev:29595.91 (675.9%) stddev-sans-first:29640.68 16:54:06 INFO - PROCESS | 1634 | Values: 674.4 743.4 794.2 800.2 822.5 15405.1 15933.4 15974.1 16008.0 16024.2 14653.5 14890.5 14908.7 14919.4 14932.9 672.4 698.8 848.7 848.9 887.0 727.2 869.3 870.7 872.1 879.0 942.4 946.0 949.0 951.0 952.1 788.7 937.4 938.2 938.7 940.1 524.5 544.0 663.6 682.5 695.0 12899.0 15018.8 15258.2 15402.3 15488.7 13905.9 14008.0 14087.9 14097.9 14098.6 12647.6 12919.0 12960.4 13085.1 13499.3 4383.9 4429.0 4439.1 4463.6 4575.0 84560.6 103817.0 109455.0 110086.4 110117.4 9967.3 10874.6 11225.9 11272.8 11647.5 20424.9 21482.6 21538.0 22058.4 22824.2 7756.9 7928.3 7953.2 7971.4 8060.8 4300.6 4373.8 4404.3 4413.6 4514.5 3628.9 3678.2 3683.5 3704.8 3724.4 682.1 684.2 692.6 698.5 699.2 627.0 682.8 688.9 700.9 731.8 9471.5 9792.0 10083.5 10291.4 10608.7 673.7 680.6 708.7 709.7 714.6 4454.0 4826.8 4882.6 4901.2 4967.6 101920.0 102898.5 103868.5 104204.0 104632.5 89201.6 90472.5 92353.0 93246.0 94460.1 79327.5 79954.0 80152.8 80504.0 81486.4 9344.6 9659.0 10514.8 11017.8 11143.3 49069.3 49406.8 49925.0 51098.7 51252.2 51264.0 70232.6 71591.0 72556.6 72736.0 12613.4 13143.6 13333.5 13337.3 13339.3 11626.8 15030.8 15039.8 15082.9 15460.0 11173.4 13784.0 14081.9 14195.6 14457.9 13648.3 13734.7 14108.4 14282.1 14328.0 10732.6 13419.2 13447.5 13491.9 13869.9 11116.9 11203.2 11384.3 11427.0 11886.8 10915.6 11059.2 11122.1 11262.9 11306.0 16:54:06 INFO - PROCESS | 1634 | -------- Summary: end -------- 16:54:06 INFO - PROCESS | 1634 | 16:54:06 INFO - TEST-INFO | 1634: exit 0 16:54:06 INFO - TEST-OK | dromaeo_css | took 1118755ms 16:54:06 INFO - TEST-START | kraken 16:54:06 INFO - operating with platform_type : mac_ 16:54:06 INFO - Initialising browser for kraken test... 16:54:06 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpL5PGac/profile http://localhost:49242/getInfo.html) 16:54:09 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 16:54:09 INFO - PROCESS | 1640 | colorDepth:24 16:54:09 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 16:54:09 INFO - PROCESS | 1640 | __metrics 16:54:09 INFO - PROCESS | 1640 | 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" 16:54:09 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:54:10 INFO - TEST-INFO | 1640: exit 0 16:54:10 INFO - Browser initialized. 16:54:10 INFO - Running cycle 1/1 for kraken test... 16:54:10 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpL5PGac/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:22 INFO - PROCESS | 1641 | RSS: Main: 234991616 16:54:22 INFO - PROCESS | 1641 | 16:54:24 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 16:54:25 INFO - PROCESS | 1641 | RSS: Main: 287694848 16:54:25 INFO - PROCESS | 1641 | 16:54:28 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 16:54:29 INFO - PROCESS | 1641 | RSS: Main: 286744576 16:54:29 INFO - PROCESS | 1641 | 16:54:32 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 16:54:32 INFO - PROCESS | 1641 | RSS: Main: 381075456 16:54:32 INFO - PROCESS | 1641 | 16:54:34 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 16:54:35 INFO - PROCESS | 1641 | RSS: Main: 282796032 16:54:35 INFO - PROCESS | 1641 | 16:54:37 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:54:38 INFO - PROCESS | 1641 | RSS: Main: 286199808 16:54:38 INFO - PROCESS | 1641 | 16:54:40 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:41 INFO - PROCESS | 1641 | RSS: Main: 327925760 16:54:41 INFO - PROCESS | 1641 | 16:54:44 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:45 INFO - PROCESS | 1641 | RSS: Main: 330694656 16:54:45 INFO - PROCESS | 1641 | 16:54:47 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 16:54:48 INFO - PROCESS | 1641 | RSS: Main: 327688192 16:54:48 INFO - PROCESS | 1641 | 16:54:49 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:50 INFO - PROCESS | 1641 | RSS: Main: 303751168 16:54:50 INFO - PROCESS | 1641 | 16:54:52 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:54:53 INFO - PROCESS | 1641 | RSS: Main: 306585600 16:54:53 INFO - PROCESS | 1641 | 16:54:55 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:54:56 INFO - PROCESS | 1641 | RSS: Main: 307765248 16:54:56 INFO - PROCESS | 1641 | 16:54:58 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:54:59 INFO - PROCESS | 1641 | RSS: Main: 325423104 16:54:59 INFO - PROCESS | 1641 | 16:55:02 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:55:03 INFO - PROCESS | 1641 | RSS: Main: 319881216 16:55:03 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 16:55:05 INFO - PROCESS | 1641 | RSS: Main: 364109824 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | __start_tp_report 16:55:05 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 16:55:05 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 16:55:05 INFO - PROCESS | 1641 | |i|pagename|runs| 16:55:05 INFO - PROCESS | 1641 | |0;ai-astar;113;113;114;113;112;113;113;112;114;114 16:55:05 INFO - PROCESS | 1641 | |1;audio-beat-detection;144;111;109;145;114;109;108;108;129;109 16:55:05 INFO - PROCESS | 1641 | |2;audio-dft;183;184;183;185;183;185;181;182;182;184 16:55:05 INFO - PROCESS | 1641 | |3;audio-fft;83;57;59;85;61;64;59;57;72;57 16:55:05 INFO - PROCESS | 1641 | |4;audio-oscillator;86;70;84;68;68;84;113;96;83;83 16:55:05 INFO - PROCESS | 1641 | |5;imaging-gaussian-blur;88;86;87;87;87;84;88;85;88;84 16:55:05 INFO - PROCESS | 1641 | |6;imaging-darkroom;96;94;94;96;94;92;96;93;92;93 16:55:05 INFO - PROCESS | 1641 | |7;imaging-desaturate;88;86;86;86;86;87;87;88;86;87 16:55:05 INFO - PROCESS | 1641 | |8;json-parse-financial;56;55;54;55;55;57;54;55;55;56 16:55:05 INFO - PROCESS | 1641 | |9;json-stringify-tinderbox;65;77;75;80;74;72;69;71;70;72 16:55:05 INFO - PROCESS | 1641 | |10;stanford-crypto-aes;88;87;96;106;107;88;89;85;87;89 16:55:05 INFO - PROCESS | 1641 | |11;stanford-crypto-ccm;139;148;150;146;144;140;140;139;181;140 16:55:05 INFO - PROCESS | 1641 | |12;stanford-crypto-pbkdf2;173;175;173;174;176;172;172;171;177;169 16:55:05 INFO - PROCESS | 1641 | |13;stanford-crypto-sha256-iterative;67;69;68;66;69;67;69;66;67;67 16:55:05 INFO - PROCESS | 1641 | __end_tp_report 16:55:05 INFO - PROCESS | 1641 | __start_cc_report 16:55:05 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1965 16:55:05 INFO - PROCESS | 1641 | __end_cc_report 16:55:05 INFO - PROCESS | 1641 | __startTimestamp1484268905271__endTimestamp 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | ------- Summary: start ------- 16:55:05 INFO - PROCESS | 1641 | Number of tests: 14 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 16:55:05 INFO - PROCESS | 1641 | Values: 113.0 113.0 114.0 113.0 112.0 113.0 113.0 112.0 114.0 114.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:112.50 stddev:15.02 (13.4%) stddev-sans-first:12.81 16:55:05 INFO - PROCESS | 1641 | Values: 144.0 111.0 109.0 145.0 114.0 109.0 108.0 108.0 129.0 109.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.32 (0.7%) stddev-sans-first:1.39 16:55:05 INFO - PROCESS | 1641 | Values: 183.0 184.0 183.0 185.0 183.0 185.0 181.0 182.0 182.0 184.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#3] audio-fft Cycles:10 Average:65.40 Median:62.50 stddev:10.81 (17.3%) stddev-sans-first:9.41 16:55:05 INFO - PROCESS | 1641 | Values: 83.0 57.0 59.0 85.0 61.0 64.0 59.0 57.0 72.0 57.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#4] audio-oscillator Cycles:10 Average:83.50 Median:83.50 stddev:13.73 (16.4%) stddev-sans-first:14.53 16:55:05 INFO - PROCESS | 1641 | Values: 86.0 70.0 84.0 68.0 68.0 84.0 113.0 96.0 83.0 83.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:1.58 (1.8%) stddev-sans-first:1.56 16:55:05 INFO - PROCESS | 1641 | Values: 88.0 86.0 87.0 87.0 87.0 84.0 88.0 85.0 88.0 84.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:1.56 (1.7%) stddev-sans-first:1.48 16:55:05 INFO - PROCESS | 1641 | Values: 96.0 94.0 94.0 96.0 94.0 92.0 96.0 93.0 92.0 93.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 16:55:05 INFO - PROCESS | 1641 | Values: 88.0 86.0 86.0 86.0 86.0 87.0 87.0 88.0 86.0 87.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 16:55:05 INFO - PROCESS | 1641 | Values: 56.0 55.0 54.0 55.0 55.0 57.0 54.0 55.0 55.0 56.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:4.25 (5.8%) stddev-sans-first:3.54 16:55:05 INFO - PROCESS | 1641 | Values: 65.0 77.0 75.0 80.0 74.0 72.0 69.0 71.0 70.0 72.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:88.00 stddev:8.07 (9.2%) stddev-sans-first:8.41 16:55:05 INFO - PROCESS | 1641 | Values: 88.0 87.0 96.0 106.0 107.0 88.0 89.0 85.0 87.0 89.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:145.00 stddev:12.69 (8.8%) stddev-sans-first:13.15 16:55:05 INFO - PROCESS | 1641 | Values: 139.0 148.0 150.0 146.0 144.0 140.0 140.0 139.0 181.0 140.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:2.39 (1.4%) stddev-sans-first:2.54 16:55:05 INFO - PROCESS | 1641 | Values: 173.0 175.0 173.0 174.0 176.0 172.0 172.0 171.0 177.0 169.0 16:55:05 INFO - PROCESS | 1641 | 16:55:05 INFO - PROCESS | 1641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.18 (1.7%) stddev-sans-first:1.24 16:55:05 INFO - PROCESS | 1641 | Values: 67.0 69.0 68.0 66.0 69.0 67.0 69.0 66.0 67.0 67.0 16:55:05 INFO - PROCESS | 1641 | -------- Summary: end -------- 16:55:05 INFO - PROCESS | 1641 | 16:55:06 INFO - TEST-INFO | 1641: exit 0 16:55:06 INFO - TEST-OK | kraken | took 59444ms 16:55:06 INFO - SUITE-END | took 1178s 16:55:06 INFO - Completed test suite (00:19:38) 16:55:06 INFO - javascript benchmark 16:55:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3290.506424036394, 3322.0, 3333.816640084796, 3341.498775183724, 3380.357732030914, 5484.808031718891, 5575.107982722765, 5670.036093864042, 5671.206031155636, 5698.03133467311, 5558.972205138979, 5599.580031497633, 5603.355614104379, 5606.243157173781, 5612.298462692163, 5075.74621268936, 5106.514881086291, 5121.436641969381, 5139.280500729901, 5169.069567477853, 5210.817621383252, 5225.843224703265, 5236.869078273055, 5249.265102885599, 5254.763535640886, 5210.947890521104, 5211.609129315298, 5235.424103348629, 5241.082810508165, 5244.527992480676, 5222.686638801646, 5224.686518808883, 5227.79088836446, 5230.790768369261, 5252.553532949704, 4999.8000079996755, 5149.974250128763, 5179.14544100223, 5188.740562971874, 5189.299444574972, 5710.200571919934, 5733.254676892019, 5739.16782066598, 5739.684317362543, 5762.88474230513, 6145.201123853915, 6176.227971503562, 6182.659953702545, 6194.721237544321, 6194.81415557534, 5471.68679516917, 6095.664738439384, 6103.307364981935, 6128.483736330591, 6160.322364539897, 5754.194412782172, 5762.222100016528, 5778.075507918713, 5787.305523337226, 5834.620749651259, 6223.813285601439, 6251.0, 6261.8747625047245, 6276.717547710364, 6285.151504546828, 5945.137954996588, 6022.668753218615, 6031.607945483617, 6104.3590423005835, 6113.388661133851, 5124.538791508708, 6159.045347971071, 6168.228971378578, 6216.782412615627, 6261.9373806262265, 6032.155498230251, 6183.041628547582, 6183.103449999725, 6185.752569897244, 6187.071939209155, 5578.832635020955, 6169.074638804215, 6172.567920245539, 6234.314225435199, 6246.281677607042, 4816.807327706852, 4882.926756098661, 4889.266610008527, 4913.9017219656125, 4926.9014619707405, 4411.625011873963, 4426.11477704454, 4427.623651989553, 4451.376807246988, 4487.214737420938, 4931.112399768004, 5798.884022319615, 5826.329972053268, 5826.766929322865, 5831.212786273799, 5283.682979021271, 6117.632942023492, 6142.437386315926, 6154.3845615438095, 6308.337624549448, 4876.804927802848, 5647.519960803295, 5731.398203188689, 5789.073748200268, 5809.9419005809405, 5390.0836857734275, 5417.5395091416885, 5421.647592906448, 5423.593230507728, 5442.346918369821, 6145.3407579954055, 6324.893143699926, 6344.6827658616885, 6358.1734374531015, 6367.840803979938, 6106.725197366218, 6121.296050954197, 6146.78486252979, 6166.81499555014, 6184.536159788124, 6106.511479081574, 6330.303666596578, 6350.714217860115, 6360.968195158995, 6371.585846919936, 6105.603135796159, 6107.643995706967, 6111.908321375094, 6121.331035925228, 6128.167033931239, 6128.56865797067, 6152.323244443197, 6156.938430615636, 6176.320604733565, 6186.5360097993735, 4756.857294281039, 4929.975350123226, 5918.526517878646, 5957.582969192115, 5970.641761494324, 6073.240844894388, 6091.299500557493, 6091.7563297467605, 6101.29835068955, 6139.017757158833, 5922.703864806656, 5989.520838332835, 5990.88018239624, 5998.1002849572915, 5998.850028749316, 5969.164316995711, 6022.337542870193, 6034.275886893601, 6119.938800611937, 6133.172021777182, 5946.405359464019, 5991.970040149771, 5996.130561068708, 5998.310194327708, 6083.847903802441], "value": 5638.338417757178, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.76248350857543, 471.1519265322419, 504.33176041744684, 522.9790808367666, 539.7840863654535, 26538.0, 30085.84957075217, 39028.41457378142, 40758.796206019004, 40800.59199408005, 41658.791706041506, 42059.36910946338, 42149.7892510537, 42152.15695686085, 42283.15433691324, 8252.917470825305, 9088.454692718426, 9193.586288617029, 9303.534823258844, 9327.62689492423, 8333.583320833965, 8513.914860851373, 9276.768080797967, 10784.892151078468, 11036.227464077518, 11100.278481898691, 11192.38441885696, 11213.551457941672, 11214.775704485904, 11223.887761122407, 11177.944110279437, 11232.831507527311, 11249.60626378077, 11253.66239012831, 11281.717957051058, 8279.379046571532, 8442.831143377098, 10848.728781780439, 11079.667609971713, 11112.555497780078, 39894.0, 40262.79868600638, 40277.597224027675, 40345.798271008454, 40358.596414035776, 3845.2309538092495, 4025.838966441339, 4087.6934229932576, 4092.9795351023354, 4171.853985110537, 29682.40635187284, 30643.0, 30722.539161912588, 30766.0, 31215.375692486024, 3124.6719094495206, 3169.952450713241, 3237.919052023695, 3294.736421086331, 3341.114604629775, 476716.0, 481621.0, 484081.0, 484475.57762211317, 493693.0, 58440.707796460745, 58798.70600646969, 58897.411025889196, 58899.70550147307, 58921.52696182544, 61386.69306653528, 61488.0, 61503.769924601256, 61631.07553386703, 61664.44201148829, 15709.293081811118, 15936.0, 15953.282102305424, 15954.361825526848, 15993.840061599236, 10534.20993425496, 12062.939685301517, 12437.129400942029, 12491.812622810665, 12521.311327877054, 13686.65783355424, 13957.720845583235, 14005.579832605039, 15305.923470382577, 15584.298706558233, 6116.449519543174, 7146.392556632744, 7310.0, 7337.853242935112, 7431.85136297271, 895.3329769321897, 907.1654078248027, 927.888653361601, 937.2080591899834, 937.634322614181, 28886.422271554453, 29922.850385747934, 29966.850165749467, 30643.69356306453, 30659.846700766353, 904.755715956688, 1084.2139448899484, 1122.1247427006786, 1152.4295473740551, 1207.124834494984, 13378.063535552612, 14761.92619036898, 15107.848921510644, 15477.922610386877, 15528.689426211638, 601279.0, 602837.0, 604238.0, 604261.0, 604594.0, 58993.705031474565, 59202.40797591969, 59409.70295148583, 59431.702841485516, 59474.405255946884, 1441.9855801441852, 1448.3627204030192, 1469.2066284206624, 1486.1900264355952, 1494.1035378772867, 28495.43009139847, 29073.563896541993, 29133.271668207617, 29436.0, 30067.0, 49159.75420122877, 49655.503444965085, 49709.75145124251, 49758.0, 49781.00437991292, 440047.79976099916, 440274.0, 440948.0, 440997.0, 441457.5854241545, 37810.054748631504, 38297.425538616386, 38449.42325865058, 38555.42166867443, 38668.0, 44849.77575112104, 45733.54266457293, 45885.082298354515, 45930.54069459263, 46115.769421152676, 31340.216494587818, 37179.62820371761, 37282.44076338912, 37818.81090594529, 38719.419208711326, 37427.625723742414, 37470.43794343033, 37884.43173352347, 38208.617913820504, 38738.03154921037, 36728.89813305605, 36804.0, 37416.62583374132, 37940.62059379371, 38418.0395490115, 30297.636606353208, 32532.51201231936, 33259.00222993314, 33984.0, 34205.828970854986, 21317.147314107264, 23424.882875585514, 24127.0, 24640.89115989749, 25070.247892563253], "value": 19799.849602670547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2162288883791, 331.9817410042448, 390.9218156368725, 399.59741308008887, 421.97468151910886, 15099.471518496855, 15436.0, 16712.74930876036, 20330.695039574417, 21216.04527796249, 12357.011439084874, 14325.426982920671, 20405.897970510126, 21223.893880530577, 21299.467513312135, 5342.118550439173, 5565.109582466806, 5569.359523654771, 5572.275604171452, 5594.188842617818, 5182.714950677711, 5441.646292990963, 7925.484843485155, 7993.2806047455715, 8084.7574572762915, 7332.816679582999, 7644.847103057936, 8077.717279895205, 8098.028236611615, 8102.837943241132, 7592.126905405838, 7890.132085470594, 7902.486338388015, 7908.802279943047, 7954.085280192736, 7580.090389153337, 7605.353544948686, 7634.198409167068, 7679.116901556281, 7720.845583088307, 29552.408951820842, 29568.156139701918, 30077.548836767466, 30243.848780755954, 30486.84756576203, 2371.864098059611, 2514.6730924979634, 2959.556066590007, 2975.8363290019042, 3030.757539396843, 16181.271842766986, 16782.74825877613, 16813.495595132164, 16827.495175144766, 17378.217980190922, 1680.9747853782203, 1954.4332143678316, 1970.6255811395788, 1986.7218589397496, 1989.761228652571, 132665.0, 135215.6478435213, 153226.0, 159206.20396897942, 160772.0, 22544.436389090402, 22724.863756812094, 23092.0, 23364.0, 23398.415039624146, 41136.98500047521, 41541.584584153774, 41777.0, 41882.0, 41976.74069777912, 9468.715938521855, 11117.444127793578, 11222.214444988937, 11274.041706455044, 11370.147238957112, 8906.287497000225, 8941.865872011926, 8946.913314906347, 9090.500022498825, 9106.180443760093, 9676.322657413913, 10007.298029531985, 10516.316439431412, 10811.297265677706, 10897.291676041032, 3368.5261450143516, 3937.586553411908, 4116.897077573085, 4118.5263694674895, 4135.793210339471, 997.4165113408737, 1002.5739060899089, 1003.8393856982848, 1026.2918586175515, 1035.49260862177, 22034.44913877134, 22591.09635614557, 22596.774032259465, 22627.43431414195, 22642.094316227165, 1024.6157690865925, 1025.2720568396373, 1045.341434896026, 1062.516554967488, 1064.4677661169414, 9073.45559266446, 10697.786044279072, 11480.540778368939, 11515.481803318871, 11538.88461115395, 568045.0, 707454.0, 708238.0, 719648.4017579879, 725516.0, 89657.55171224232, 97301.0, 139709.0, 143740.2828533301, 158985.76734838853, 911.9088091190961, 1000.229823036258, 1028.4908970059869, 1059.7244716373643, 1066.8879767624444, 14374.640633984234, 19387.836729796258, 19679.31122410766, 20486.12147069627, 20641.277555286095, 42151.57848421476, 47722.0, 56704.71647641735, 59014.34435450329, 61809.0, 65289.67355163194, 68895.65552172207, 83615.0, 83753.58123209345, 89092.0, 6201.844953876009, 8283.337333013224, 8346.330733853132, 8608.09614990442, 8846.77883052903, 10633.946830266108, 13050.282234477196, 13359.866401335863, 13488.865111349154, 13593.932030339785, 9805.362651427635, 10694.89305106939, 11584.826227606423, 11712.418823458724, 11773.352465614473, 8344.290735287568, 11364.147688923198, 11371.31772093677, 11648.301101933912, 11885.881141188824, 9394.745261137141, 11577.247478913843, 11717.0, 12012.219205751599, 12016.33910134951, 8306.460080094774, 8485.363597730071, 8575.271101956403, 8577.528235947082, 8597.441166324168, 10347.379157250589, 10906.781864362827, 11299.661010169708, 11350.659480215607, 11482.36846973391], "value": 11289.733694370752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.7594696875017, 1467.4350375105582, 1468.368601501354, 1483.2954346685326, 1487.8586534279239, 8080.111187769348, 8493.91506084939, 8506.70226542072, 8519.616617252223, 8527.0, 7214.278572142783, 7463.02980612521, 7476.813079673011, 7971.322437592811, 8189.95905020474, 2296.7358753743365, 2308.1690591387087, 2330.2892617751577, 2341.8243631727605, 2342.2153578551206, 2316.143027079974, 2341.2976107167865, 2347.8239132065078, 2352.2707960532202, 2355.6702061711376, 2309.503456756797, 2310.156792770635, 2324.616438287689, 2328.1734984080663, 2336.8013718833918, 2270.5685919675293, 2276.5333106713083, 2294.0521628498686, 2299.1952816514085, 2313.086330899302, 2303.6890019847274, 2325.3024092772102, 2335.894884730174, 2335.9649605255936, 2336.3341447687326, 8146.103928567853, 8303.4602750821, 8315.750527484124, 8326.542040187787, 8336.499810011419, 5032.169692000852, 5186.170212765939, 5193.766280517386, 5195.792168313263, 5207.661502002357, 3264.820434876081, 3357.6306606273292, 3476.044087875829, 3520.419130843408, 3533.8233088345737, 1136.318209074557, 1196.9521219151225, 1201.7055821323745, 1232.057476030837, 1235.9258444493269, 10716.035556799847, 10802.621908233174, 10827.891721082768, 10832.187585931088, 10847.240693151483, 4373.978130109393, 4629.444466664022, 4697.741624210701, 4711.528847115261, 4717.575418212377, 9328.580213890256, 9350.111739384747, 9356.625734970661, 9365.15713585767, 9368.953155234316, 5231.973840130775, 5232.73836308183, 5233.162693968947, 5242.554382877422, 5255.290535777697, 4282.76444795533, 4326.456161108211, 4597.540245975442, 4686.81252749893, 4782.426108866958, 3738.2149748553106, 3797.0, 3849.268638958589, 3882.8835134946, 3916.3146449371816, 1265.0891358222066, 1271.4405661508906, 1272.8599854016052, 1282.4799269435418, 1287.43996361583, 787.5786454247065, 788.6845261895288, 788.755485799404, 807.2331285278891, 807.4105902691068, 5437.537809286176, 5460.754266058037, 5603.2435621191435, 5623.550115990711, 5733.856653583611, 560.9214709940611, 583.813179782474, 593.0836857055859, 597.6623207887529, 597.6682940967718, 3524.823758812049, 3617.0, 3672.4208590306425, 3694.1688120173285, 3698.6486283802997, 9586.66446674363, 9821.950890245645, 9941.45322007282, 9948.900510994943, 9948.900510994943, 9607.663731769355, 9904.158146557624, 9915.206783457306, 9917.008299170026, 9943.651972180938, 7557.206493318123, 7776.922230777733, 7784.532928024337, 7791.961040194876, 7792.961035194788, 5252.0, 5265.420803711665, 5310.300703774755, 5353.812616558402, 5417.945820541744, 8911.37620366568, 9134.995150533568, 9169.403988740978, 9172.03693612161, 9265.768355791159, 9071.228945539702, 9115.134062264075, 9286.34995550305, 9346.906530934604, 9425.151736343487, 5295.973520132375, 6680.565763225375, 6691.5315927884585, 6909.481788865955, 7076.0, 7627.885581716389, 7806.219378062376, 7879.172686868025, 7917.2874441300555, 7997.160298168608, 6013.7293821779, 6991.335823096798, 7092.645367731489, 7095.184053833876, 7225.205227424874, 6936.687849046906, 6977.476689248429, 6992.685329160302, 7000.264972178052, 7012.824679383056, 6325.304216536269, 6383.329750376143, 6437.581557198767, 6454.41910228063, 6463.192100987377, 4929.975350123226, 4949.653524253267, 5004.274380214775, 5091.439941606494, 5104.132297509358, 4904.945436730977, 4972.0, 5035.194368900959, 5169.043726910533, 5183.818566350311], "value": 4325.443012489797, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.28410253339524, 355.4543775304907, 365.4737178463014, 372.5231703419624, 375.992480150397, 4225.148025083072, 4522.47991480979, 4664.813407463697, 5282.260483532304, 5302.946970530294, 4413.271810151321, 4894.951050489494, 5215.1395019821775, 5222.63441559091, 5226.895462090756, 3329.5338652588657, 3443.345764304787, 3494.7109643183753, 3799.620037996206, 4027.41602467642, 3384.593848738155, 3605.693516051139, 3608.8451695457466, 3780.0, 4033.394990751396, 3387.728981681472, 3536.797488853789, 4075.612816782401, 4089.734167279132, 4105.542532400999, 3183.681631836821, 4075.9592404076025, 4088.284550203717, 4103.671706263522, 4107.322291821846, 2800.4259126879147, 3479.68682818545, 3500.3699334119847, 3578.964210357889, 3595.26297109092, 3725.2549490102087, 3950.8419663213435, 4851.951480485185, 4966.6771659842, 5084.923726144111, 4198.538160802309, 4466.855909163587, 4670.626349892001, 4672.243376407901, 4684.95315046852, 5040.269160971675, 5253.343332083489, 5467.808626698046, 5535.726782839969, 5559.359304330451, 3470.403614337408, 3971.801409929492, 3986.5614782373914, 4028.576999415078, 4043.3126368517424, 4710.505396933307, 5460.0414699343055, 5716.371199168088, 5722.828315150552, 5811.506021988136, 3998.620131087542, 4078.021274894004, 4089.8364065437645, 4103.9179216415505, 4113.3957756475, 3491.8952431427097, 3698.5746639136305, 3764.1906989997283, 4089.2230476209425, 4197.4753155855515, 3774.2640185163627, 4700.435947686299, 4706.270528068155, 4711.599514041345, 4750.406199225097, 4372.6939114261695, 5591.664500130005, 5599.78012642732, 5602.243697100921, 5605.7197140142825, 1262.8547717012661, 1319.4035217386877, 1336.7460182565283, 1369.2400717601627, 1369.9999000729524, 823.8558252305822, 895.7133717210561, 963.7879666473365, 977.5845265762165, 980.9509524523745, 3906.109478985587, 4847.297141914473, 4854.951450485521, 4919.262110683426, 4955.975220123948, 4368.694191406635, 4792.976035119802, 4883.658143929962, 5113.261491093046, 5459.989901868167, 4272.5086615039045, 4300.913981720348, 4706.435227772689, 4948.703077815343, 4959.603231741452, 2654.9469010619678, 2795.412963277694, 2833.8724757385967, 2869.7991140620375, 2870.3111253299476, 4745.762711864393, 5547.916781248285, 5623.959567480029, 5630.915536266959, 5674.971625141848, 4704.9529504704515, 4825.565699087099, 5058.317127187856, 5176.516864981837, 5584.425967380879, 4575.088299503943, 5078.162103252996, 5246.344206974129, 5583.469570390806, 5585.497305242548, 4478.865634030984, 5348.128155145668, 5414.891702165856, 5429.321334833146, 5430.425176698713, 4994.825181118644, 5090.898182036412, 5383.308345827087, 5413.756380962787, 5424.511793938565, 5593.580481463825, 5648.85877853057, 5715.199872018004, 5785.103308987113, 5908.1137829324225, 3791.7345785795833, 3827.712921530952, 3833.789141597239, 3843.327417701947, 3860.0, 5669.943300566942, 5684.687342196054, 5688.7440065198, 5696.829095127153, 5713.514351280021, 5236.0, 5314.8376715854, 5384.703841288767, 5495.670259784426, 5610.382857885711, 4562.973331000499, 4818.8918147793775, 4872.366592342973, 5014.5737612303365, 5548.722563871871, 4491.416115905042, 4779.784909679003, 5129.512696293846, 5465.453454654503, 5503.504684578407, 4611.193041217706, 4642.582167604932, 4985.750712464434, 5340.439253878442, 5485.609265205991, 5098.311727916832, 5120.948790512047, 5416.539594134385, 5448.0, 5486.533644640091], "value": 3968.546543241842, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.4334758802605, 743.4424181863602, 794.1502592226317, 800.2397722163946, 822.4879763410243, 15405.075695458267, 15933.44232951847, 15974.121423321712, 16008.039517628951, 16024.198790060495, 14653.45742819724, 14890.478833240839, 14908.701825963475, 14919.403223871032, 14932.925335373335, 672.4015626092781, 698.7554355975393, 848.6520526584086, 848.9108643592426, 886.9556522173898, 727.1601300497933, 869.3436455476107, 870.6778491957984, 872.1148034744739, 878.9824203515926, 942.3968660057569, 946.0397696338222, 949.0035462764105, 950.9966984831001, 952.0669743651226, 788.7278888783361, 937.446906325268, 938.2025278513244, 938.737153596994, 940.0928104379238, 524.5279248676184, 543.9564834813206, 663.5554178700282, 682.5290549520864, 694.9861002779967, 12898.968082553372, 15018.774718379233, 15258.160801155933, 15402.306896189699, 15488.690226195413, 13905.930470347685, 14008.0, 14087.929560352235, 14097.859021409757, 14098.647533811634, 12647.620571382873, 12919.0, 12960.416781244867, 13085.084044116915, 13499.25754083525, 4383.9342409863875, 4429.0, 4439.134368798085, 4463.553644635543, 4574.977693369811, 84560.57719711363, 103817.0, 109455.0, 110086.44956775245, 110117.44941275242, 9967.302288839857, 10874.619388321371, 11225.943870280596, 11272.774544509064, 11647.475863586158, 20424.897875510826, 21482.570348593254, 21538.0, 22058.44853878666, 22824.201152959566, 7756.883646745303, 7928.3260922821055, 7953.164917683675, 7971.40214483916, 8060.83878322442, 4300.634446072057, 4373.781310934441, 4404.339349097597, 4413.646908247332, 4514.45826500822, 3628.9455658165148, 3678.2275722098125, 3683.4843121962945, 3704.7777133372083, 3724.417122722832, 682.147315855181, 684.2097377528962, 692.6225207262054, 698.5459451356558, 699.2308460693197, 626.971786269619, 682.8327059870363, 688.8863337549349, 700.8563244534859, 731.7694926098262, 9471.479068651153, 9792.020797920151, 10083.546240419199, 10291.433971131659, 10608.734781630521, 673.6732684647942, 680.6256558892688, 708.7129712466459, 709.7118729506034, 714.5998240985065, 4454.042380888124, 4826.7827947742435, 4882.633802464829, 4901.189705809164, 4967.5777558907175, 101920.0, 102898.48550757348, 103868.48065759623, 104204.0, 104632.47683761685, 89201.55399222963, 90472.5476372627, 92353.0, 93246.0, 94460.11079778367, 79327.5143225653, 79953.99999999884, 80152.79770803326, 80504.0, 81486.37027259421, 9344.609301675615, 9659.0, 10514.789704206027, 11017.83473247886, 11143.33140011602, 49069.2639610399, 49406.75296623494, 49925.00149996907, 51098.74450627723, 51252.231216531036, 51264.0, 70232.64883675548, 71591.0, 72556.63721681357, 72736.0, 12613.36933153357, 13143.605691828878, 13333.53292218034, 13337.266450345323, 13339.333033348488, 11626.82559761621, 15030.774538382151, 15039.774403383739, 15082.924585377003, 15460.0, 11173.441327933733, 13784.0, 14081.859181408465, 14195.574132776033, 14457.85542144565, 13648.317584120556, 13734.65663358424, 14108.435662573382, 14282.143071415749, 14328.034753909416, 10732.624358147428, 13419.194848308742, 13447.46210151583, 13491.932540337235, 13869.930650346683, 11116.944415277872, 11203.21577489568, 11384.260023098472, 11427.0, 11886.82169767437, 10915.56337746513, 11059.170562207706, 11122.080937473618, 11262.943685281522, 11306.0], "value": 7646.659412032373, "unit": "score"}], "name": "dromaeo_css", "value": 7409.356389582322, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 112.0, 113.0, 113.0, 112.0, 114.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 109.0, 145.0, 114.0, 109.0, 108.0, 108.0, 129.0, 109.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 185.0, 183.0, 185.0, 181.0, 182.0, 182.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 59.0, 85.0, 61.0, 64.0, 59.0, 57.0, 72.0, 57.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 84.0, 68.0, 68.0, 84.0, 113.0, 96.0, 83.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 87.0, 87.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 96.0, 94.0, 92.0, 96.0, 93.0, 92.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 86.0, 86.0, 87.0, 87.0, 88.0, 86.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 55.0, 57.0, 54.0, 55.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 75.0, 80.0, 74.0, 72.0, 69.0, 71.0, 70.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 96.0, 106.0, 107.0, 88.0, 89.0, 85.0, 87.0, 89.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 148.0, 150.0, 146.0, 144.0, 140.0, 140.0, 139.0, 181.0, 140.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 174.0, 176.0, 172.0, 172.0, 171.0, 177.0, 169.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 66.0, 69.0, 67.0, 69.0, 66.0, 67.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1438.2, "alertThreshold": 2.0}]} 16:55:06 INFO - Return code: 0 16:55:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:55:06 INFO - # TBPL SUCCESS # 16:55:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:06 INFO - 2017-01-12 16:55:06.564 screenresolution[1645:9749] starting screenresolution argv=screenresolution get 16:55:06 INFO - 2017-01-12 16:55:06.567 screenresolution[1645:9749] Display 0: 1600x1200x32@60 16:55:06 INFO - 2017-01-12 16:55:06.574 screenresolution[1646:9752] starting screenresolution argv=screenresolution list 16:55:06 INFO - Available Modes on Display 0 16:55:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:06 INFO - Intel Iris: 16:55:06 INFO - Chipset Model: Intel Iris 16:55:06 INFO - Type: GPU 16:55:06 INFO - Bus: Built-In 16:55:06 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:06 INFO - Vendor: Intel (0x8086) 16:55:06 INFO - Device ID: 0x0a2e 16:55:06 INFO - Revision ID: 0x0009 16:55:06 INFO - Displays: 16:55:06 INFO - Display: 16:55:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:06 INFO - Display Serial Number: 1600x1200 60 16:55:06 INFO - Main Display: Yes 16:55:06 INFO - Mirror: Off 16:55:06 INFO - Online: Yes 16:55:06 INFO - Rotation: Supported 16:55:06 INFO - Return code: 0 16:55:06 INFO - Running post-action listener: _resource_record_post_action 16:55:06 INFO - [mozharness: 2017-01-13 00:55:06.813757Z] Finished run-tests step (success) 16:55:06 INFO - Running post-run listener: _resource_record_post_run 16:55:06 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 33328128; Write bytes: 551979008; Read time: 311; Write time: 1770 16:55:06 INFO - TinderboxPrint: CPU usage
53.7% 16:55:06 INFO - TinderboxPrint: I/O read bytes / time
33,328,128 / 311 16:55:06 INFO - TinderboxPrint: I/O write bytes / time
551,979,008 / 1,770 16:55:06 INFO - TinderboxPrint: CPU idle
2,224.9 (46.3%) 16:55:06 INFO - TinderboxPrint: CPU system
962.6 (20.0%) 16:55:06 INFO - TinderboxPrint: CPU user
1,618.2 (33.7%) 16:55:06 INFO - TinderboxPrint: Swap in / out
280,035,328 / 0 16:55:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249661952; Write bytes: 243644416; Read time: 18073; Write time: 539 16:55:06 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29006848; Write bytes: 296865792; Read time: 275; Write time: 1192 16:55:07 INFO - Running post-run listener: _upload_blobber_files 16:55:07 INFO - Blob upload gear active. 16:55:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:55:07 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 16:55:07 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'] 16:55:07 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 16:55:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:08 INFO - (blobuploader) - INFO - Done attempting. 16:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:09 INFO - (blobuploader) - INFO - Done attempting. 16:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:55:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:11 INFO - (blobuploader) - INFO - Done attempting. 16:55:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:55:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:55:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:13 INFO - (blobuploader) - INFO - Done attempting. 16:55:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:55:13 INFO - Return code: 0 16:55:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:55:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:55:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4316a3d7ed5eb2ac666564ff0e354284d8ecf22ca9c0a4b689e6e65774683773e05f6947b74328461ef4cda468ab8f34fd9a81f887d3d89a46f42d8ab7c500f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d0db4e43b8a534214d96259fe41fa94860765abe250492827881cbaa079b78a86bb841edcc12648fba0ef4b268e7b0e2bb2dbc1baf9d329ab03960de3b7984", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d192c2ecd57d18ab3d6548f65cb1bf37192a0f3de15bee70bdcc1027a2ae64bd2ab89683cb1b5d5d706fc7ef6eeb8fc1599066dcc584bd4bc2b50e753cd69a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f889ac141c05530106c05e832648b99700ac1668c7a6c7c70adb67787799d2c9b297713a5239276a7aefd7aa4b0a59fba6df8879b0a71341e20707e8b6f6ee2f"} 16:55:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:55:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:55:13 INFO - Contents: 16:55:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4316a3d7ed5eb2ac666564ff0e354284d8ecf22ca9c0a4b689e6e65774683773e05f6947b74328461ef4cda468ab8f34fd9a81f887d3d89a46f42d8ab7c500f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d0db4e43b8a534214d96259fe41fa94860765abe250492827881cbaa079b78a86bb841edcc12648fba0ef4b268e7b0e2bb2dbc1baf9d329ab03960de3b7984", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d192c2ecd57d18ab3d6548f65cb1bf37192a0f3de15bee70bdcc1027a2ae64bd2ab89683cb1b5d5d706fc7ef6eeb8fc1599066dcc584bd4bc2b50e753cd69a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f889ac141c05530106c05e832648b99700ac1668c7a6c7c70adb67787799d2c9b297713a5239276a7aefd7aa4b0a59fba6df8879b0a71341e20707e8b6f6ee2f"} 16:55:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:55:13 INFO - Copying logs to upload dir... 16:55:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:55:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.426517 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-12 16:55:13.614678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 16:55:13.618105) ========= 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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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/4316a3d7ed5eb2ac666564ff0e354284d8ecf22ca9c0a4b689e6e65774683773e05f6947b74328461ef4cda468ab8f34fd9a81f887d3d89a46f42d8ab7c500f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d0db4e43b8a534214d96259fe41fa94860765abe250492827881cbaa079b78a86bb841edcc12648fba0ef4b268e7b0e2bb2dbc1baf9d329ab03960de3b7984", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d192c2ecd57d18ab3d6548f65cb1bf37192a0f3de15bee70bdcc1027a2ae64bd2ab89683cb1b5d5d706fc7ef6eeb8fc1599066dcc584bd4bc2b50e753cd69a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f889ac141c05530106c05e832648b99700ac1668c7a6c7c70adb67787799d2c9b297713a5239276a7aefd7aa4b0a59fba6df8879b0a71341e20707e8b6f6ee2f"} build_url:https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010813 build_url: 'https://queue.taskcluster.net/v1/task/IKq_leMyQ3WA-3p6w09RHg/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/4316a3d7ed5eb2ac666564ff0e354284d8ecf22ca9c0a4b689e6e65774683773e05f6947b74328461ef4cda468ab8f34fd9a81f887d3d89a46f42d8ab7c500f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d0db4e43b8a534214d96259fe41fa94860765abe250492827881cbaa079b78a86bb841edcc12648fba0ef4b268e7b0e2bb2dbc1baf9d329ab03960de3b7984", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d192c2ecd57d18ab3d6548f65cb1bf37192a0f3de15bee70bdcc1027a2ae64bd2ab89683cb1b5d5d706fc7ef6eeb8fc1599066dcc584bd4bc2b50e753cd69a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f889ac141c05530106c05e832648b99700ac1668c7a6c7c70adb67787799d2c9b297713a5239276a7aefd7aa4b0a59fba6df8879b0a71341e20707e8b6f6ee2f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 16:55:13.650987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:55:13.651281) ========= 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.4pUR3j8Dcj/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.c3Dzfwjf9x/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005363 ========= master_lag: 0.90 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:55:14.560720) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 16:55:14.561039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 16:55:14.651698) ========= ========= Total master_lag: 1.04 =========