builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0214 starttime: 1485107584.84 results: success (0) buildid: 20170122084725 builduid: 96a055c2a0d140ca8aeed7d697405db7 revision: 5f0652e323af9ec2e3768fefca22f7a65449313c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:04.843505) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:04.843901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:04.844187) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:04.913977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:04.914369) ========= 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.GnD9et1G15/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.CgVZIFR1zW/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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-22 09:53:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.08M=0.001s 2017-01-22 09:53:05 (8.08 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.661236 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:05.598952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:05.599282) ========= 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.GnD9et1G15/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.CgVZIFR1zW/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.020018 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:05.648483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-22 09:53:05.648847) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f0652e323af9ec2e3768fefca22f7a65449313c --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 5f0652e323af9ec2e3768fefca22f7a65449313c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GnD9et1G15/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.CgVZIFR1zW/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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-22 09:53:05,739 truncating revision to first 12 chars 2017-01-22 09:53:05,739 Setting DEBUG logging. 2017-01-22 09:53:05,739 attempt 1/10 2017-01-22 09:53:05,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f0652e323af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-22 09:53:06,529 unpacking tar archive at: mozilla-central-5f0652e323af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.049813 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-22 09:53:06.725437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:06.726002) ========= script_repo_revision: 5f0652e323af9ec2e3768fefca22f7a65449313c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:06.726803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:06.727419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 09:53:06.748266) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-22 09:53:06.748769) ========= /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.GnD9et1G15/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.CgVZIFR1zW/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:06 INFO - MultiFileLogger online at 20170122 09:53:06 in /builds/slave/test 09:53:06 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 09:53:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:53:06 INFO - {'append_to_log': False, 09:53:06 INFO - 'base_work_dir': '/builds/slave/test', 09:53:06 INFO - 'blob_upload_branch': 'Firefox', 09:53:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:53:06 INFO - 'branch': 'Firefox', 09:53:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:53:06 INFO - 'config_files': ('talos/mac_config.py',), 09:53:06 INFO - 'default_actions': ('clobber', 09:53:06 INFO - 'read-buildbot-config', 09:53:06 INFO - 'download-and-extract', 09:53:06 INFO - 'populate-webroot', 09:53:06 INFO - 'create-virtualenv', 09:53:06 INFO - 'install', 09:53:06 INFO - 'run-tests'), 09:53:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:53:06 INFO - 'download_minidump_stackwalk': True, 09:53:06 INFO - 'download_symbols': 'ondemand', 09:53:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:53:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:53:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:53:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:53:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:53:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:53:06 INFO - 'installer_path': 'installer.exe', 09:53:06 INFO - 'log_level': 'info', 09:53:06 INFO - 'log_name': 'talos', 09:53:06 INFO - 'log_to_console': True, 09:53:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:53:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:53:06 INFO - 'opt_config_files': (), 09:53:06 INFO - 'pip_index': False, 09:53:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:06 INFO - 'cmd': ('bash', 09:53:06 INFO - '-c', 09:53:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:06 INFO - 'enabled': True, 09:53:06 INFO - 'halt_on_failure': False, 09:53:06 INFO - 'name': 'check_screen_resolution'},), 09:53:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:06 INFO - 'cmd': ('bash', 09:53:06 INFO - '-c', 09:53:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:06 INFO - 'enabled': True, 09:53:06 INFO - 'halt_on_failure': False, 09:53:06 INFO - 'name': 'check_screen_resolution'},), 09:53:06 INFO - 'run_cmd_checks_enabled': True, 09:53:06 INFO - 'sps_profile': False, 09:53:06 INFO - 'sps_profile_interval': 0, 09:53:06 INFO - 'suite': 'dromaeojs', 09:53:06 INFO - 'system_bits': '32', 09:53:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:53:06 INFO - 'title': 't-yosemite-r7-0214', 09:53:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:53:06 INFO - 'use_talos_json': True, 09:53:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:53:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:53:06 INFO - 'work_dir': 'build'} 09:53:06 INFO - [mozharness: 2017-01-22 17:53:06.960895Z] Running clobber step. 09:53:06 INFO - Running pre-action listener: _resource_record_pre_action 09:53:06 INFO - Running main action method: clobber 09:53:06 INFO - rmtree: /builds/slave/test/build 09:53:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:53:07 INFO - Running post-action listener: _resource_record_post_action 09:53:07 INFO - [mozharness: 2017-01-22 17:53:07.867057Z] Finished clobber step (success) 09:53:07 INFO - [mozharness: 2017-01-22 17:53:07.867187Z] Running read-buildbot-config step. 09:53:07 INFO - Running pre-action listener: _resource_record_pre_action 09:53:07 INFO - Running main action method: read_buildbot_config 09:53:07 INFO - Using buildbot properties: 09:53:07 INFO - { 09:53:07 INFO - "project": "", 09:53:07 INFO - "product": "firefox", 09:53:07 INFO - "script_repo_revision": "production", 09:53:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:53:07 INFO - "repository": "", 09:53:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:53:07 INFO - "buildid": "20170122084725", 09:53:07 INFO - "pgo_build": "False", 09:53:07 INFO - "basedir": "/builds/slave/test", 09:53:07 INFO - "buildnumber": 31, 09:53:07 INFO - "slavename": "t-yosemite-r7-0214", 09:53:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:53:07 INFO - "platform": "yosemite_r7", 09:53:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:53:07 INFO - "branch": "mozilla-central", 09:53:07 INFO - "repo_path": "mozilla-central", 09:53:07 INFO - "revision": "5f0652e323af9ec2e3768fefca22f7a65449313c", 09:53:07 INFO - "stage_platform": "macosx64", 09:53:07 INFO - "builduid": "96a055c2a0d140ca8aeed7d697405db7", 09:53:07 INFO - "slavebuilddir": "test" 09:53:07 INFO - } 09:53:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:53:07 INFO - Running post-action listener: _resource_record_post_action 09:53:07 INFO - [mozharness: 2017-01-22 17:53:07.870621Z] Finished read-buildbot-config step (success) 09:53:07 INFO - [mozharness: 2017-01-22 17:53:07.870733Z] Running download-and-extract step. 09:53:07 INFO - Running pre-action listener: _resource_record_pre_action 09:53:07 INFO - Running main action method: download_and_extract 09:53:07 INFO - mkdir: /builds/slave/test/build/tests 09:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:07 INFO - trying https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:53:07 INFO - Downloading https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/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 09:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/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 09:53:09 INFO - Downloaded 1199 bytes. 09:53:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:53:09 INFO - Using the following test package requirements: 09:53:09 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:53:09 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:53:09 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:53:09 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'jsshell-mac.zip'], 09:53:09 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:53:09 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:53:09 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:53:09 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:53:09 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:53:09 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:53:09 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:53:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:53:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:53:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:53:09 INFO - Fetch https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:53:10 INFO - Expected file size: 16350799 09:53:10 INFO - Obtained file size: 16350799 09:53:16 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 09:53:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:53:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:53:16 INFO - Fetch https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:53:17 INFO - Expected file size: 16350799 09:53:17 INFO - Obtained file size: 16350799 09:53:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:53:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:53:23 INFO - Fetch https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:53:24 INFO - Expected file size: 14403485 09:53:24 INFO - Obtained file size: 14403485 09:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:25 INFO - trying https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:53:25 INFO - Downloading https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/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 09:53:27 INFO - Downloaded 69941731 bytes. 09:53:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:53:27 INFO - mkdir: /builds/slave/test/properties 09:53:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:53:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:53:27 INFO - Contents: 09:53:27 INFO - build_url:https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:53:27 INFO - Running post-action listener: _resource_record_post_action 09:53:27 INFO - Running post-action listener: set_extra_try_arguments 09:53:27 INFO - [mozharness: 2017-01-22 17:53:27.608512Z] Finished download-and-extract step (success) 09:53:27 INFO - [mozharness: 2017-01-22 17:53:27.608637Z] Running populate-webroot step. 09:53:27 INFO - Running pre-action listener: _resource_record_pre_action 09:53:27 INFO - Running main action method: populate_webroot 09:53:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:53:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:53:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:53:27 INFO - '--tppagecycles', 09:53:27 INFO - '7'], 09:53:27 INFO - 'tests': ['tsvgm']}}, 09:53:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:53:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:53:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:53:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:53:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:53:27 INFO - 'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:53:27 INFO - 'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['damp', 'tps']}, 09:53:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:53:27 INFO - 'tests': ['damp', 'tps']}, 09:53:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['dromaeo_dom']}, 09:53:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:53:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['basic_compositor_video']}, 09:53:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:53:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['a11yr', 09:53:27 INFO - 'ts_paint', 09:53:27 INFO - 'tpaint', 09:53:27 INFO - 'sessionrestore', 09:53:27 INFO - 'sessionrestore_no_auto_restore', 09:53:27 INFO - 'tabpaint']}, 09:53:27 INFO - 'other-e10s': {'tests': ['a11yr', 09:53:27 INFO - 'ts_paint', 09:53:27 INFO - 'tpaint', 09:53:27 INFO - 'sessionrestore', 09:53:27 INFO - 'sessionrestore_no_auto_restore', 09:53:27 INFO - 'tabpaint']}, 09:53:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:53:27 INFO - 'ts_paint', 09:53:27 INFO - 'tpaint', 09:53:27 INFO - 'sessionrestore', 09:53:27 INFO - 'sessionrestore_no_auto_restore', 09:53:27 INFO - 'tabpaint']}, 09:53:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:53:27 INFO - 'ts_paint', 09:53:27 INFO - 'tpaint', 09:53:27 INFO - 'sessionrestore', 09:53:27 INFO - 'sessionrestore_no_auto_restore', 09:53:27 INFO - 'tabpaint']}, 09:53:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['a11yr', 09:53:27 INFO - 'ts_paint', 09:53:27 INFO - 'tpaint', 09:53:27 INFO - 'sessionrestore', 09:53:27 INFO - 'sessionrestore_no_auto_restore', 09:53:27 INFO - 'tabpaint']}, 09:53:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['a11yr', 09:53:27 INFO - 'ts_paint', 09:53:27 INFO - 'tpaint', 09:53:27 INFO - 'sessionrestore', 09:53:27 INFO - 'sessionrestore_no_auto_restore', 09:53:27 INFO - 'tabpaint']}, 09:53:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['tsvgx', 09:53:27 INFO - 'tsvgr_opacity', 09:53:27 INFO - 'tart', 09:53:27 INFO - 'tscrollx', 09:53:27 INFO - 'cart', 09:53:27 INFO - 'tsvg_static']}, 09:53:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:53:27 INFO - 'tsvgr_opacity', 09:53:27 INFO - 'tart', 09:53:27 INFO - 'tscrollx', 09:53:27 INFO - 'cart', 09:53:27 INFO - 'tsvg_static']}, 09:53:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:53:27 INFO - 'talos_options': ['--disable-e10s'], 09:53:27 INFO - 'tests': ['tp5o']}, 09:53:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:53:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:53:27 INFO - 'talos_options': ['--disable-e10s', 09:53:27 INFO - '--xperf_path', 09:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:27 INFO - 'tests': ['tp5n']}, 09:53:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:53:27 INFO - 'talos_options': ['--xperf_path', 09:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:27 INFO - 'tests': ['tp5n']}}, 09:53:27 INFO - 'talos.zip': {'path': '', 09:53:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:53:27 INFO - Running post-action listener: _resource_record_post_action 09:53:27 INFO - [mozharness: 2017-01-22 17:53:27.627412Z] Finished populate-webroot step (success) 09:53:27 INFO - [mozharness: 2017-01-22 17:53:27.627521Z] Running create-virtualenv step. 09:53:27 INFO - Running pre-action listener: _resource_record_pre_action 09:53:27 INFO - Running main action method: create_virtualenv 09:53:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:53:27 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 09:53:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:53:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:53:27 INFO - Using real prefix '/tools/python27' 09:53:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:53:31 INFO - Installing pip.................done. 09:53:31 INFO - Return code: 0 09:53:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:53:31 INFO - Reading from file tmpfile_stdout 09:53:31 INFO - Output received: 09:53:31 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) 09:53:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:53:31 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')]} 09:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:31 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')]} 09:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:31 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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:31 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 09:53:31 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 09:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:31 INFO - 'HOME': '/Users/cltbld', 09:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:31 INFO - 'LOGNAME': 'cltbld', 09:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:31 INFO - 'MOZ_NO_REMOTE': '1', 09:53:31 INFO - 'NO_EM_RESTART': '1', 09:53:31 INFO - 'PAGER': '/bin/cat', 09:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:31 INFO - 'PWD': '/builds/slave/test', 09:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:31 INFO - 'SHELL': '/bin/bash', 09:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:31 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:31 INFO - 'USER': 'cltbld', 09:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:31 INFO - 'XPC_FLAGS': '0x0', 09:53:31 INFO - 'XPC_SERVICE_NAME': '0', 09:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:31 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 09:53:31 INFO - Cleaning up... 09:53:31 INFO - Return code: 0 09:53:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:53:31 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')]} 09:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:31 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')]} 09:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:31 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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:31 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 09:53:31 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 09:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:31 INFO - 'HOME': '/Users/cltbld', 09:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:31 INFO - 'LOGNAME': 'cltbld', 09:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:31 INFO - 'MOZ_NO_REMOTE': '1', 09:53:31 INFO - 'NO_EM_RESTART': '1', 09:53:31 INFO - 'PAGER': '/bin/cat', 09:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:31 INFO - 'PWD': '/builds/slave/test', 09:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:31 INFO - 'SHELL': '/bin/bash', 09:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:31 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:31 INFO - 'USER': 'cltbld', 09:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:31 INFO - 'XPC_FLAGS': '0x0', 09:53:31 INFO - 'XPC_SERVICE_NAME': '0', 09:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:32 INFO - Downloading/unpacking psutil>=3.1.1 09:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:53:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:36 INFO - Installing collected packages: psutil 09:53:36 INFO - Running setup.py install for psutil 09:53:36 INFO - building 'psutil._psutil_osx' extension 09:53:36 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 09:53:36 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 09:53:36 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 09:53:36 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 09:53:36 INFO - building 'psutil._psutil_posix' extension 09:53:36 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 09:53:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:53:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:53:37 INFO - ^ 09:53:37 INFO - 1 warning generated. 09:53:37 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 09:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:37 INFO - Successfully installed psutil 09:53:37 INFO - Cleaning up... 09:53:37 INFO - Return code: 0 09:53:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:37 INFO - 'HOME': '/Users/cltbld', 09:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:37 INFO - 'LOGNAME': 'cltbld', 09:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:37 INFO - 'MOZ_NO_REMOTE': '1', 09:53:37 INFO - 'NO_EM_RESTART': '1', 09:53:37 INFO - 'PAGER': '/bin/cat', 09:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:37 INFO - 'PWD': '/builds/slave/test', 09:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:37 INFO - 'SHELL': '/bin/bash', 09:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:37 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:37 INFO - 'USER': 'cltbld', 09:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:37 INFO - 'XPC_FLAGS': '0x0', 09:53:37 INFO - 'XPC_SERVICE_NAME': '0', 09:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:53:40 INFO - Installing collected packages: mozsystemmonitor 09:53:40 INFO - Running setup.py install for mozsystemmonitor 09:53:40 INFO - Successfully installed mozsystemmonitor 09:53:40 INFO - Cleaning up... 09:53:40 INFO - Return code: 0 09:53:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:53:40 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')]} 09:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:40 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')]} 09:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:40 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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:40 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 09:53:40 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 09:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:40 INFO - 'HOME': '/Users/cltbld', 09:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:40 INFO - 'LOGNAME': 'cltbld', 09:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:40 INFO - 'MOZ_NO_REMOTE': '1', 09:53:40 INFO - 'NO_EM_RESTART': '1', 09:53:40 INFO - 'PAGER': '/bin/cat', 09:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:40 INFO - 'PWD': '/builds/slave/test', 09:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:40 INFO - 'SHELL': '/bin/bash', 09:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:40 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:40 INFO - 'USER': 'cltbld', 09:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:40 INFO - 'XPC_FLAGS': '0x0', 09:53:40 INFO - 'XPC_SERVICE_NAME': '0', 09:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:53:40 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 09:53:40 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 09:53:40 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 09:53:40 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 09:53:40 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 09:53:40 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 09:53:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:53:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:53:43 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 09:53:43 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 09:53:43 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 09:53:43 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 09:53:43 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 09:53:43 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 09:53:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:53:43 INFO - warning: no files found matching '*.txt' 09:53:43 INFO - no previously-included directories found matching 'build' 09:53:43 INFO - no previously-included directories found matching 'dist' 09:53:43 INFO - no previously-included directories found matching '.git*' 09:53:43 INFO - Installing collected packages: jsonschema, functools32 09:53:43 INFO - Running setup.py install for functools32 09:53:44 INFO - warning: no files found matching '*.txt' 09:53:44 INFO - no previously-included directories found matching 'build' 09:53:44 INFO - no previously-included directories found matching 'dist' 09:53:44 INFO - no previously-included directories found matching '.git*' 09:53:44 INFO - Successfully installed jsonschema functools32 09:53:44 INFO - Cleaning up... 09:53:44 INFO - Return code: 0 09:53:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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', '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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:53: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 functools32==3.2.3-2 09:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:44 INFO - 'HOME': '/Users/cltbld', 09:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:44 INFO - 'LOGNAME': 'cltbld', 09:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:44 INFO - 'MOZ_NO_REMOTE': '1', 09:53:44 INFO - 'NO_EM_RESTART': '1', 09:53:44 INFO - 'PAGER': '/bin/cat', 09:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:44 INFO - 'PWD': '/builds/slave/test', 09:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:44 INFO - 'SHELL': '/bin/bash', 09:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:44 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:44 INFO - 'USER': 'cltbld', 09:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:44 INFO - 'XPC_FLAGS': '0x0', 09:53:44 INFO - 'XPC_SERVICE_NAME': '0', 09:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:53:44 INFO - Cleaning up... 09:53:44 INFO - Return code: 0 09:53:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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', '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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:53: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 blobuploader==1.2.4 09:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:44 INFO - 'HOME': '/Users/cltbld', 09:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:44 INFO - 'LOGNAME': 'cltbld', 09:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:44 INFO - 'MOZ_NO_REMOTE': '1', 09:53:44 INFO - 'NO_EM_RESTART': '1', 09:53:44 INFO - 'PAGER': '/bin/cat', 09:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:44 INFO - 'PWD': '/builds/slave/test', 09:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:44 INFO - 'SHELL': '/bin/bash', 09:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:44 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:44 INFO - 'USER': 'cltbld', 09:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:44 INFO - 'XPC_FLAGS': '0x0', 09:53:44 INFO - 'XPC_SERVICE_NAME': '0', 09:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:53:44 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 09:53:44 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 09:53:44 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 09:53:44 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 09:53:44 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 09:53:44 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 09:53:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:53:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:53:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:48 INFO - Downloading docopt-0.6.1.tar.gz 09:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:53:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:53:48 INFO - Running setup.py install for blobuploader 09:53:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:53:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:53:48 INFO - Running setup.py install for requests 09:53:49 INFO - Running setup.py install for docopt 09:53:49 INFO - Successfully installed blobuploader requests docopt 09:53:49 INFO - Cleaning up... 09:53:49 INFO - Return code: 0 09:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:49 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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:49 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 09:53:49 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 09:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:49 INFO - 'HOME': '/Users/cltbld', 09:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:49 INFO - 'LOGNAME': 'cltbld', 09:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:49 INFO - 'MOZ_NO_REMOTE': '1', 09:53:49 INFO - 'NO_EM_RESTART': '1', 09:53:49 INFO - 'PAGER': '/bin/cat', 09:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:49 INFO - 'PWD': '/builds/slave/test', 09:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:49 INFO - 'SHELL': '/bin/bash', 09:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:49 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:49 INFO - 'USER': 'cltbld', 09:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:49 INFO - 'XPC_FLAGS': '0x0', 09:53:49 INFO - 'XPC_SERVICE_NAME': '0', 09:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-mVfZ4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-vybFE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-dWhTMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ylJELO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TVhg8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-POFElI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-tnwQMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Fg_5yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-5jul42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-EP2UbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-no5qu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-lCWiCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:51 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-OcBzLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:51 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-CDscnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:51 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-14RlUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:51 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-FUGrWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:51 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-V5Kovk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:53:51 INFO - Running setup.py install for manifestparser 09:53:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:53:51 INFO - Running setup.py install for mozcrash 09:53:51 INFO - Running setup.py install for mozdebug 09:53:51 INFO - Running setup.py install for mozdevice 09:53:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Running setup.py install for mozfile 09:53:52 INFO - Running setup.py install for mozhttpd 09:53:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Running setup.py install for mozinfo 09:53:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Running setup.py install for mozInstall 09:53:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:53:52 INFO - Running setup.py install for mozleak 09:53:52 INFO - Running setup.py install for mozlog 09:53:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:53:53 INFO - Running setup.py install for moznetwork 09:53:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:53:53 INFO - Running setup.py install for mozprocess 09:53:53 INFO - Running setup.py install for mozprofile 09:53:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:53:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:53:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:53:53 INFO - Running setup.py install for mozrunner 09:53:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:53:53 INFO - Running setup.py install for mozscreenshot 09:53:53 INFO - Running setup.py install for moztest 09:53:54 INFO - Running setup.py install for mozversion 09:53:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:53:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:53:54 INFO - Cleaning up... 09:53:54 INFO - Return code: 0 09:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:54 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')]} 09:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:54 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')]} 09:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:54 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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:54 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 09:53:54 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 09:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:54 INFO - 'HOME': '/Users/cltbld', 09:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:54 INFO - 'LOGNAME': 'cltbld', 09:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:54 INFO - 'MOZ_NO_REMOTE': '1', 09:53:54 INFO - 'NO_EM_RESTART': '1', 09:53:54 INFO - 'PAGER': '/bin/cat', 09:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:54 INFO - 'PWD': '/builds/slave/test', 09:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:54 INFO - 'SHELL': '/bin/bash', 09:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:54 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:54 INFO - 'USER': 'cltbld', 09:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:54 INFO - 'XPC_FLAGS': '0x0', 09:53:54 INFO - 'XPC_SERVICE_NAME': '0', 09:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ak8G7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:54 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)) 09:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-BYgD9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:54 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)) 09:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JovoMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:54 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)) 09:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-oluMWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:54 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)) 09:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-WYBroT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:54 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)) 09:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-iqV9YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-p0WLYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-2eRTlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-IJED6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TPaWvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-dOr6wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-tjVqO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-1IpQRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Fo6dxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:55 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)) 09:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-oAU2Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:56 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)) 09:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:56 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-jQqO0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:56 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)) 09:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:56 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ZhKryA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:56 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)) 09:53:56 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)) 09:53:56 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)) 09:53:56 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)) 09:53:56 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)) 09:53:56 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)) 09:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:58 INFO - Downloading blessings-1.6.tar.gz 09:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:59 INFO - Installing collected packages: blessings 09:53:59 INFO - Running setup.py install for blessings 09:53:59 INFO - Successfully installed blessings 09:53:59 INFO - Cleaning up... 09:53:59 INFO - Return code: 0 09:53:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:59 INFO - Reading from file tmpfile_stdout 09:53:59 INFO - Current package versions: 09:53:59 INFO - blessings == 1.6 09:53:59 INFO - blobuploader == 1.2.4 09:53:59 INFO - docopt == 0.6.1 09:53:59 INFO - functools32 == 3.2.3-2 09:53:59 INFO - jsonschema == 2.5.1 09:53:59 INFO - manifestparser == 1.1 09:53:59 INFO - mozInstall == 1.12 09:53:59 INFO - mozcrash == 1.0 09:53:59 INFO - mozdebug == 0.1 09:53:59 INFO - mozdevice == 0.49 09:53:59 INFO - mozfile == 1.2 09:53:59 INFO - mozhttpd == 0.7 09:53:59 INFO - mozinfo == 0.9 09:53:59 INFO - mozleak == 0.1 09:53:59 INFO - mozlog == 3.4 09:53:59 INFO - moznetwork == 0.27 09:53:59 INFO - mozprocess == 0.24 09:53:59 INFO - mozprofile == 0.28 09:53:59 INFO - mozrunner == 6.13 09:53:59 INFO - mozscreenshot == 0.1 09:53:59 INFO - mozsystemmonitor == 0.3 09:53:59 INFO - moztest == 0.8 09:53:59 INFO - mozversion == 1.4 09:53:59 INFO - psutil == 3.1.1 09:53:59 INFO - requests == 1.2.3 09:53:59 INFO - wsgiref == 0.1.2 09:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:59 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')]} 09:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:59 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')]} 09:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:59 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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:59 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 09:53:59 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 09:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:59 INFO - 'HOME': '/Users/cltbld', 09:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:59 INFO - 'LOGNAME': 'cltbld', 09:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:59 INFO - 'MOZ_NO_REMOTE': '1', 09:53:59 INFO - 'NO_EM_RESTART': '1', 09:53:59 INFO - 'PAGER': '/bin/cat', 09:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:59 INFO - 'PWD': '/builds/slave/test', 09:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:59 INFO - 'SHELL': '/bin/bash', 09:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:59 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:59 INFO - 'USER': 'cltbld', 09:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:59 INFO - 'XPC_FLAGS': '0x0', 09:53:59 INFO - 'XPC_SERVICE_NAME': '0', 09:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 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)) 09:53:59 INFO - Cleaning up... 09:53:59 INFO - Return code: 0 09:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:59 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')]} 09:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:59 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')]} 09:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:59 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 0x10bd4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87e9d884e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, '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.GnD9et1G15/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.CgVZIFR1zW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 09:53:59 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 09:53:59 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 09:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:59 INFO - 'HOME': '/Users/cltbld', 09:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:59 INFO - 'LOGNAME': 'cltbld', 09:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:59 INFO - 'MOZ_NO_REMOTE': '1', 09:53:59 INFO - 'NO_EM_RESTART': '1', 09:53:59 INFO - 'PAGER': '/bin/cat', 09:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:59 INFO - 'PWD': '/builds/slave/test', 09:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:59 INFO - 'SHELL': '/bin/bash', 09:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:53:59 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:59 INFO - 'USER': 'cltbld', 09:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:59 INFO - 'XPC_FLAGS': '0x0', 09:53:59 INFO - 'XPC_SERVICE_NAME': '0', 09:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:54:00 INFO - Cleaning up... 09:54:00 INFO - Return code: 0 09:54:00 INFO - Running post-action listener: _resource_record_post_action 09:54:00 INFO - Running post-action listener: _start_resource_monitoring 09:54:00 INFO - Starting resource monitoring. 09:54:00 INFO - [mozharness: 2017-01-22 17:54:00.120870Z] Finished create-virtualenv step (success) 09:54:00 INFO - [mozharness: 2017-01-22 17:54:00.121898Z] Running install step. 09:54:00 INFO - Running pre-action listener: _resource_record_pre_action 09:54:00 INFO - Running main action method: install 09:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:00 INFO - Reading from file tmpfile_stdout 09:54:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:54:00 INFO - Reading from file tmpfile_stdout 09:54:00 INFO - Output received: 09:54:00 INFO - Usage: mozinstall [options] installer 09:54:00 INFO - Options: 09:54:00 INFO - -h, --help show this help message and exit 09:54:00 INFO - -d DEST, --destination=DEST 09:54:00 INFO - Directory to install application into. [default: 09:54:00 INFO - "/builds/slave/test"] 09:54:00 INFO - --app=APP Application being installed. [default: firefox] 09:54:00 INFO - mkdir: /builds/slave/test/build/application 09:54:00 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'] 09:54:00 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 09:54:22 INFO - Reading from file tmpfile_stdout 09:54:22 INFO - Output received: 09:54:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:54:22 INFO - Running post-action listener: _resource_record_post_action 09:54:22 INFO - [mozharness: 2017-01-22 17:54:22.413581Z] Finished install step (success) 09:54:22 INFO - [mozharness: 2017-01-22 17:54:22.413731Z] Running run-tests step. 09:54:22 INFO - Running pre-action listener: _resource_record_pre_action 09:54:22 INFO - Running main action method: run_tests 09:54:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:54:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:54:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:54:22 INFO - 2017-01-22 09:54:22.428 screenresolution[2239:17788] starting screenresolution argv=screenresolution get 09:54:22 INFO - 2017-01-22 09:54:22.430 screenresolution[2239:17788] Display 0: 1600x1200x32@60 09:54:22 INFO - 2017-01-22 09:54:22.437 screenresolution[2240:17791] starting screenresolution argv=screenresolution list 09:54:22 INFO - Available Modes on Display 0 09:54:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:54:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:54:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:54:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:54:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:54:22 INFO - Intel Iris: 09:54:22 INFO - Chipset Model: Intel Iris 09:54:22 INFO - Type: GPU 09:54:22 INFO - Bus: Built-In 09:54:22 INFO - VRAM (Dynamic, Max): 1536 MB 09:54:22 INFO - Vendor: Intel (0x8086) 09:54:22 INFO - Device ID: 0x0a2e 09:54:22 INFO - Revision ID: 0x0009 09:54:22 INFO - Displays: 09:54:22 INFO - Display: 09:54:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:54:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:54:22 INFO - Display Serial Number: 1600x1200 60 09:54:22 INFO - Main Display: Yes 09:54:22 INFO - Mirror: Off 09:54:22 INFO - Online: Yes 09:54:22 INFO - Rotation: Supported 09:54:22 INFO - Return code: 0 09:54:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:54:22 INFO - Python 2.7.3 09:54:22 INFO - Return code: 0 09:54:22 INFO - grabbing minidump binary from tooltool 09:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:22 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 0x10bb28d30>, '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 0x10ba4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb1dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:54:22 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 09:54:22 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 09:54:22 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 09:54:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:54:22 INFO - Return code: 0 09:54:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:54:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:54:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:54:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:54:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:54:22 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/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 09:54:22 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/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 09:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnD9et1G15/Render', 09:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:22 INFO - 'HOME': '/Users/cltbld', 09:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:22 INFO - 'LOGNAME': 'cltbld', 09:54:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:54:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:22 INFO - 'MOZ_NO_REMOTE': '1', 09:54:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:54:22 INFO - 'NO_EM_RESTART': '1', 09:54:22 INFO - 'PAGER': '/bin/cat', 09:54:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:22 INFO - 'PWD': '/builds/slave/test', 09:54:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:22 INFO - 'SHELL': '/bin/bash', 09:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CgVZIFR1zW/Listeners', 09:54:22 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 09:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:22 INFO - 'USER': 'cltbld', 09:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:22 INFO - 'XPC_FLAGS': '0x0', 09:54:22 INFO - 'XPC_SERVICE_NAME': '0', 09:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:22 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/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 09:54:23 INFO - mozversion application_buildid: 20170122084725 09:54:23 INFO - mozversion application_changeset: 5f0652e323af9ec2e3768fefca22f7a65449313c 09:54:23 INFO - mozversion application_display_name: Nightly 09:54:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:54:23 INFO - mozversion application_name: Firefox 09:54:23 INFO - mozversion application_remotingname: firefox 09:54:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:54:23 INFO - mozversion application_vendor: Mozilla 09:54:23 INFO - mozversion application_version: 53.0a1 09:54:23 INFO - mozversion platform_buildid: 20170122084725 09:54:23 INFO - mozversion platform_changeset: 5f0652e323af9ec2e3768fefca22f7a65449313c 09:54:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:54:23 INFO - mozversion platform_version: 53.0a1 09:54:23 INFO - using testdate: 1485107663 09:54:23 INFO - actual date: 1485107663 09:54:23 INFO - starting webserver on 'localhost:49810' 09:54:23 INFO - SUITE-START | Running 2 tests 09:54:23 INFO - TEST-START | dromaeo_css 09:54:23 INFO - operating with platform_type : mac_ 09:54:23 INFO - Initialising browser for dromaeo_css test... 09:54:23 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpM3ilDf/profile http://localhost:49810/getInfo.html) 09:54:25 INFO - PROCESS | 2250 | __metrics Screen width/height:1600/1200 09:54:25 INFO - PROCESS | 2250 | colorDepth:24 09:54:25 INFO - PROCESS | 2250 | Browser inner width/height: 1024/689 09:54:25 INFO - PROCESS | 2250 | __metrics 09:54:25 INFO - PROCESS | 2250 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 09:54:25 INFO - PROCESS | 2250 | 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" 09:54:25 INFO - PROCESS | 2250 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:54:26 INFO - TEST-INFO | 2250: exit 0 09:54:26 INFO - Browser initialized. 09:54:26 INFO - Running cycle 1/1 for dromaeo_css test... 09:54:26 INFO - TEST-INFO | started process 2252 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpM3ilDf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:38 INFO - PROCESS | 2252 | RSS: Main: 236167168 09:54:38 INFO - PROCESS | 2252 | 09:57:42 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49810/tests/dromaeo/cssquery-ext.html) 09:57:44 INFO - PROCESS | 2252 | RSS: Main: 379232256 09:57:44 INFO - PROCESS | 2252 | 09:59:28 INFO - PROCESS | 2252 | ************************* 09:59:28 INFO - PROCESS | 2252 | A coding exception was thrown and uncaught in a Task. 09:59:28 INFO - PROCESS | 2252 | 09:59:28 ERROR - PROCESS | 2252 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:59:28 INFO - PROCESS | 2252 | Full stack: 09:59:28 INFO - PROCESS | 2252 | ************************* 10:00:47 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49810/tests/dromaeo/cssquery-ext.html (next: http://localhost:49810/tests/dromaeo/cssquery-jquery.html) 10:00:47 INFO - PROCESS | 2252 | RSS: Main: 368939008 10:00:47 INFO - PROCESS | 2252 | 10:03:50 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49810/tests/dromaeo/cssquery-mootools.html) 10:03:50 INFO - PROCESS | 2252 | RSS: Main: 360792064 10:03:50 INFO - PROCESS | 2252 | 10:06:52 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49810/tests/dromaeo/cssquery-prototype.html) 10:06:53 INFO - PROCESS | 2252 | RSS: Main: 347942912 10:06:53 INFO - PROCESS | 2252 | 10:09:57 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49810/tests/dromaeo/cssquery-yui.html) 10:09:57 INFO - PROCESS | 2252 | RSS: Main: 334041088 10:09:57 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49810/tests/dromaeo/cssquery-yui.html (next: http://localhost:49810/tests/dromaeo/cssquery-dojo.html) 10:13:01 INFO - PROCESS | 2252 | RSS: Main: 415485952 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | __start_tp_report 10:13:01 INFO - PROCESS | 2252 | _x_x_mozilla_page_load 10:13:01 INFO - PROCESS | 2252 | _x_x_mozilla_page_load_details 10:13:01 INFO - PROCESS | 2252 | |i|pagename|runs| 10:13:01 INFO - PROCESS | 2252 | |0;dojo.html;3246.0910944935417;3272.770906036577;3276;3310.966890331096;3321.4353559894816;5526.115821468566;5603.579731520137;5630.183623374608;5641.7870157916095;5674.0921452567545;5562.554995600352;5608.46719561641;5610.607257491977;5619.7471113799875;5679.744411501492;5068.214426763858;5099.7705103270255;5101.183810590306;5112.744362781846;5131.974340128294;5048.268001139832;5151.7681704323395;5233.031889100528;5245.973770131144;5279.366476022883;5177.887246852772;5203.817866374697;5225.660332078422;5229.058769421503;5235.110031294689;5021.924671129936;5065.772040258161;5071;5134.127198376285;5144.639875208737;5040.017196646655;5088.643794934356;5120.001599688062;5121.129408000612;5131.461196574343;5543.085390910495;5596.832095037155;5608.803691870806;5613.214150019001;5628.240187574707;6113.576218238259;6132.091946452698;6134.528431832502;6139.229124622885;6149.200603921507;6122.306673174798;6183.505319574423;6202.348753380875;6219.87560248797;6295.338989406138;5804.65172089676;5828.941710582924;5840.532757379442;5855.443732845373;5859;5732.971335143381;5875.265591801025;6270;6274;6287.591306565058;5988.880222395528;6020.187274717945;6023.638581685025;6115.480184184395;6123.109882171256;6251.9687401562705;6270.122182894398;6277.811665650038;6283.874322513524;6290.968545157245;5958.404159584007;6119.847427074719;6130.969345153246;6141.938580614226;6155.876882462326;6221.4089661482085;6228.750849965951;6250.406211409909;6250.968745156245;6256.499480041586;4349.913001740011;4933.975330123327;4993.675411098267;5012.072766538202;5018.573421259161;4421.115776844644;4441.666874984389;4468.776561171929;4481.574250446202;4489;5599.636023658531;5715.799947001919;5716.914246286309;5724.799632012943;5730.570207234474;6115.422885572139;6128.228138398679;6180.4437600615265;6184.5052395808225;6208.906866397007;5722.9984752668115;5753.367129615739;5754.769809207669;5785.537157027427;5787.508061814793;5432.864178395572;5436.21174929633;5439.075357189287;5460.945390546123;5470.398256191816;6208.503319734501;6224.035274532545;6250.937490625218;6295.307516173309;6322.683865806691;6244.562880598314;6254.186955695731;6257.43683068526;6257.53068519872;6280.780172694116;6277.686115694289;6289.874202516015;6297.52768542352;6298.937010630018;6320.115183874169;6020.488258498077;6072.726727297194;6100.816975490742;6177.413145751147;6196.504279657526;6132.600268413531;6235.407636274546;6255.530835187288;6265.780697675742;6302.653354065387;6090.725917333819;6094.664793436404;6094.664793436404;6120.234970628671;6121.877562448815;5916.674582897982;5948.791792287249;6019.247594050744;6062.333143354315;6102.511799056154;5786.623869448473;5810.477057064884;5842.269716285465;5925.585209035326;5936.8812623748145;6041.033434650435;6049.758009679564;6062.272527296753;6068.120122582289;6073.878522429615;5735.197072409783;5748.45389687979;5750.424957504216;5844.678542680023;5886.23478947734 10:13:01 INFO - PROCESS | 2252 | |1;ext.html;435.3100335967491;436.99126017479654;474.174935612035;502.32688197814934;512.5259135299847;30420.087397378058;40691;42349.576504234945;42462.57537424625;42652.93367665806;42438.787806061;42842;42860.78569607155;42906.57093429065;42984.35523467143;7437.4793764436645;8077.95961020194;8336.62485188168;9418.1994530465;9446.763830904249;8346.165383461666;11112.722181945475;11389.316641001566;11424.42877856108;11619.941900290529;11345.149113816455;11434.485448154854;11441.199116061878;11457;11467.713307167303;8375.748727538123;8551.059383467813;11309.773804523904;11350.659480215607;11397.943010284978;10997.780044399067;11290.661280161608;11334.546618135264;11481.253718508271;11487.770244595145;37522.624773752184;41025.38461923073;41080.178396431904;41105.79447102775;41416.58583414188;3822.3502004659276;4042.555318914917;4091.4067460218102;4095.5904409558807;4177.352510360899;29596;30485.08544743639;30764.38471230563;30790.61164296239;31787.52318715198;3146.3549972255632;3252.886148984774;3257.040501542437;3292.111129994912;3354.8154851483405;480660.19339806505;481927;482076;482255;483260;58236.63225258123;58650;58679;58720;58771.70614146902;61181;61743.208247092785;62198;62302;62363;15507;15697.058176509447;15698.136602486973;15709.371625135094;15713.21433928299;9349.532523373804;11404;12297.754044919051;12354.320512371725;12372.07209459294;15001.17493537844;15350.462733804263;15365.769513457308;15625.296861641253;15653.921730391276;7095.503314767917;7167.247439018932;7210;7228.38558722504;7261;859.6260626627437;866.6663334616218;883.7569668341129;884.2925659472396;906.5739102621757;29430;29501.704982950327;29960.550591741143;30220.395592088036;30279.848600756854;1046.6912260883057;1051.1065594244983;1085.918556108295;1095.7644106517137;1169.5555688838188;15319.617009574627;15351.769723454157;15352.002119862173;15450.5364839055;15687.058776473448;586799;590526;591054;591520;591788.0410597919;57982.7100864493;58111.70944145252;58126.709366452895;58359.58044615089;58609.70695146497;1390.3395886953817;1434.4405681784112;1443.3937746146644;1448.2324368085142;1453.0119518726945;25909.574973375893;26794.732052679225;29107.417851643273;29135.562966555095;29703.55444668375;48944.510554894;49219;49300.013999719085;49326.76683082952;49378.75310623424;506178;507966;509260.45369772916;510017;510638;37746.86759397222;38254;38478.61521384862;38485;38620.227595448494;35632.46551301681;36651.266974659826;44832.551674482835;45081.549184507734;45932.08135837198;37334.81332593429;37499.06252343713;38147;38915.6108438912;38932;37052.073698157765;37310;38330.23339533138;38421.807890960365;38632.6136738629;35766.46350304696;35835;36329.81835090913;36619.63380366162;37250.06874828151;31943.041708748773;33363.1659208512;33512.66487335096;33532.664673352956;33572.66427335793;24001.039958402165;24432;24432.389190270387;24548.631770523098;24740.876295618407 10:13:01 INFO - PROCESS | 2252 | |2;jquery.html;363.8235455803936;381.4507109761941;390.25266614433355;397.5209872104114;414.1447910065716;14892;15757.290921908512;18113.366032188875;20650;20910.26814061508;22113;22193.44516387091;22293.665595016046;22673.433164170903;22739.54520909581;5830.21292125564;5893.263342082239;5984.192134061911;6064.939350606482;6158.230221222348;4186.162767446508;4398.208322501949;5886.175935369051;5999.460048595625;6000.569769243463;5251.527362537371;6520.4131628153455;6560.770373036945;6592.439642630382;6628.270890202098;6391.680415979183;6430.839229019265;6440.51696122788;6546.509011824085;6611;5581.246531718207;5589.888202235932;5711.8000869969765;5737.3975732548315;5738.081906894877;26667;27555.448891022068;27604.861975689993;27713.86143069292;27865.58201626977;2736.2065001149645;2741.9451610967667;2771.3764403009363;2783.2346104821136;2854.6431696037994;15918.522444326689;15950.441734539236;16065.759013614805;16152.919235403748;16846.49460516174;1841.2174825699024;1841.3555255660413;1862.6554087493857;1905;1925.422373288008;120688;133450.33274833564;135981.3200933999;135987;137500.31249843686;11254.381009044417;11459.390292057975;11464.94267528657;11489.482973266224;11658.766824663458;14129.929350353183;14722.852771472362;14748.631284217765;14753.92623036878;14779.039362441406;7116.608586527687;8559;8665.046844847062;8866.86699699505;8897.599608017656;8572.742817715478;8574.742757717278;8576.742697719079;8732.738017859474;8732.912670873337;7190.368863723786;7313.976043353935;7332.96333518329;7350.471773548619;7353.374963128087;1566.3499647646327;1770.8312513740868;1908.3130073173647;1910.8566857485744;1956.1197461142542;810.1452967119627;849.8087930215776;872.358816270041;900.1898291537668;908.318760929303;19562.70655940162;22074.44813879666;22200.4807405789;23275.534489310117;23516.29451116469;737.9040724705861;926.7034548944408;956.8516879883629;959.29971121082;969.3553786731885;11134.16493762971;11962;12257.754844903231;12294.692632684075;12314.753704925852;695826;705129;705461;716099;722516;149052.07583393302;158101.20949395178;158665;160514;166252;985.7190700650281;1066.7813098314828;1070.635983765508;1073.983890241647;1076.273515377133;20199.59600807946;20556.69164962497;20690.58618827585;20779.480512987295;20883;61515.692421537606;61660.38339616726;62808.68595656993;63587;63880;91266.08733912576;91369.08630913871;93726.5941010899;94338.11323773349;94844.52577737343;6670.39966403026;6914.792556223321;7343.742968996059;8040.2361775631225;8761.824763504821;7913.44605877583;10676.572937082741;13502.932485337511;13523.256220907944;14035.087719298213;11626;11692.649220523397;11926.761464770483;11984.520619175484;12053.63839084829;11418.942905285421;11561.653150405165;11730.002949749367;11977.92198702121;12042.337671428155;11615.6515304541;11621.709457263636;12055.758884822078;12111.878881211074;12128.332941688292;7536.0956685198125;7548.358389536951;7704;7753.961230194039;7872.094709108525;11566.30602163873;11606.593769218036;11997.580084697343;12089.939550302191;12096.092793040381 10:13:01 INFO - PROCESS | 2252 | |3;mootools.html;1439.3882599895041;1450.767877139658;1464.070315349753;1474.95575132746;1482.7405204089284;7904.486208396457;8304.418690691655;8310.91689083109;8326;8329.708460203887;7300.598467084322;7570.583617901013;7578.204288549706;7858.214178582139;8094.028716554007;2279.4757205842666;2323.512062466884;2325.7557956414585;2327.104064934995;2331.277304035746;2297.8621282723007;2326.2904814031713;2331.895064722083;2333.8249631277636;2337.1586228957563;2281.349815302639;2284.931452056441;2304.746477887431;2305.0664480885266;2308.699869017034;2125.8299336053155;2139.786021397848;2162.9567408651897;2176.978230217693;2281.863088214704;2290.7365652949957;2315.282262498614;2315.2938353802083;2323.384303159664;2324.1981516376823;8130.227628375294;8299.502029878227;8300.252977232018;8305.252527272514;8315.04376996647;4993.101241776479;5154.278401023859;5159.380874295071;5159.406668233126;5169.431362550116;3265.330607225537;3324.684155005295;3490.2844916791996;3538.7699799513207;3541.9114522136897;1198.8561372635252;1200.9099317551131;1229.1150371732338;1235.6725467751053;1256.3466997161424;10415.16678665705;10555.258382366901;10668.62659806903;10670.146388288918;10674.306170098918;4141.275276826544;4312.159128969884;4546.704464209815;4561.24739417999;4564.657650676212;8665.43674661145;9230.215431688248;9248.16766491019;9251.028641992494;9263.25893928484;5166.483351664803;5170.121079416508;5173.327467429285;5179.119549676564;5182.170852663556;4050.331695270306;4153.314703074019;4431.556844315607;4675.485696573374;4714.4106986626675;3693.963060369416;3730.477733117366;3819.3698039823116;3842.481265029241;3860.8841734748003;1255.4852510470664;1257.0823298991604;1257.9874201257871;1266.0441366768032;1269.7206614544784;774.4694884004475;855.6919508976763;886.5079880666163;887.6671248281895;924.6209054287845;5449.618526703172;5470.617056806065;5586.804461843816;5755;5786.913196302059;942.9292803039663;974.8196583631909;979.9853002204973;992.9106380425796;1027.6505987964129;3644.1436262478296;3675.761075530082;3759.266942946154;3772.5481184716227;3777.2823163598828;9620.518974051269;9910.851337229948;9911.10800028001;9917.206623470105;9935.751606209758;8415.621297041647;9743.512824358753;9745.366551174151;9851.852222216672;9862.358946668444;6515;7588.962055189689;7668;7765.0681918170185;7780.688772449152;5469.453054694499;5473.507384335429;5488;5662.348829884616;5765.509931655856;9159.267258619162;9247.537623118951;9266.258699303904;9300.534973251175;9316.627334906529;8990.370674053016;9273.536323183678;9370.953145234504;9429.811403772022;9451.054894510495;6926.826829329307;7052.118485189351;7137.429005679637;7196.0645116134565;7229.98780170766;7908.406869484927;7968.641411136628;7971.043474783063;7972.123066462568;7989.121196668478;6918.930810691829;7057.823554411181;7116.359527642537;7144.214136445091;7194.640267986684;5910.4089591042275;6724.899126513008;6751.966240168767;6944.895826562504;6990.895136573057;6113.083037544226;6251.437370636482;6318.873622527615;6327.019312006646;6335.176427064452;4884.975575122102;4921.3356196912955;4921.778519966539;4956.603471722326;5039.420466646383;4849;4857.489963553776;4949.480304568113;5015.874603134951;5017.147084995487 10:13:01 INFO - PROCESS | 2252 | |4;prototype.html;352.57866849115305;354.59044803252254;362.7805177867389;373.3466433740953;374.7713894524338;4896.706197628145;5030.547250747432;5132.871678208046;5222.8694282642955;5265.26286319915;4465.4641443026885;4975.328330675357;4977.303177555145;5072.3405957225505;5131.408638637492;4044.0698639312977;4101.323281658522;4110.177964407116;4129.545749967501;4134.56587058359;3979.796264007473;4090.1143913282353;4108.609682080198;4114.3211370124045;4152.68854835887;3402.5236466894653;4045.089854782665;4098.077932465201;4128.112455821998;4143.958560414388;3329.6004479462376;3377.4258376076127;3562.750607457479;3681.153334733013;4002.9199416011515;3065.493724225385;3242.5460435539044;3603.891883243507;3619.3847046002243;3628.328759179534;4802.855914322576;4909.361782968192;4916.950830491685;4963.528464795839;5176.5858731301405;4336.522982471925;4495.9325610115875;4654.627629789608;4655.4180727409075;4701.388819453449;5310.681359118426;5331.5734741220995;5331.680099194022;5376.301080859464;5420.674759514442;3451.741119416054;3845.730798844082;3914.745541539791;3966.127451960564;3979.3235150024566;5620.775168993277;5709.229254050733;5717.885642287172;5735.741891614887;5769.24999750034;4093.283675356801;4094.570070142592;4107.630313271819;4156.713807405915;4180;3464.8787292444645;3854.6145385461227;4184.389010231022;4209.957900421018;4225.873223803291;4198.790060496963;4750.572448479654;4779.95220047802;4781;4784.880377990508;4687.648426368036;5593.972030139905;5613.46672066153;5621.297337832771;5642.492175704207;1220.273937007497;1293.4438191577713;1315.53298579005;1358.1579420759192;1366.8838148757268;759.1270039454561;865.5845194306768;940.149165005671;948.8956214816365;981.7545613596601;4289.871303860889;4829.710217386968;4842.201036828884;4852.4662287148385;4920.991196804646;4553.681242313006;5108.106081435734;5277.894442111136;5331.9879313445235;5469.0155771960635;4365.934510982338;4463.741468727847;4626.953730462719;4831.782569784368;4863.197572400514;2337.6610391493136;2476.8142389320874;2766.239284196862;2781.2907708534194;2825.419795903075;4972;5104.03023425548;5108.208227724708;5165.199394093846;5463.836084917459;4553;5242.663120904145;5333.466653334713;5452.691354075073;5541;4786.664933454625;5022.698638081727;5381.677099373972;5386.7982973280905;5535.916961245584;4347.71742336018;4656.348111264493;4691.835785747619;5008.524190201925;5218.504242096995;4394.956050439582;4752.008313017082;5151.5106064923775;5177.585793136615;5181.870453238699;4603.928232295413;4731.9589690268085;5179.792808287626;5372.274742909657;5372.409035006224;3304.7686661933435;3524.4537096750046;3675.338439080884;3781.829817658157;3865.7487263327794;5275.815346462856;5524.812165384462;5590.413006634245;5614.326280846324;5629.887402252014;5398.64908780928;5429;5431.918521222264;5442.238086667949;5463.153211252262;4542.659300552538;5150.768215430389;5422.397249320427;5452.863678408072;5470.589705772162;4594.977025114853;5123.871903202301;5188.832512684616;5217.6086793491395;5380.408155103014;5396.568274538106;5428.972855135699;5430.429804870431;5439.836804895859;5545.3622833374675;5118.71847048401;5277.313949186581;5300.867478313073;5305.814296499604;5323.973380133075 10:13:01 INFO - PROCESS | 2252 | |5;yui.html;709.9432045436365;714.8105751975726;744.3933194446522;777.6345117794634;850.2942557677127;15097.547073587783;15402.537923862288;15837.049777013388;15962.281697323619;16077.919610401961;13976.440942362318;14521.854781452183;14597.92701036496;14894.553163405088;14924.328405221764;861.0743450790394;876.6230520876021;878.565110270417;881.7046289493028;882.9602667879929;597.4981015946604;686.3959715450396;706.6749295324157;860.9139086091373;866.9176428239307;917.6283605139929;935.3639525122913;937.7514958535993;937.8124375125002;938.6573900526292;930.9627614895396;931.487681775021;932.2169377722712;932.2309094996655;933.8599210118468;529.6557237795425;545.2530033853607;664.4850241063166;693.5665209244222;696.6307856835886;12345.814812777726;15599.986000909905;15619.765703514457;15625.453109141126;15644.061356318658;13926.860731392657;13939.581812545639;14111.435542578285;14130.293485325796;14185.290735463186;12674.176178548458;12763.808542871864;12796.232226066466;12900.161489503153;13077.738445231138;4409.559044095565;4441.356003379492;4493.68544201906;4505.16174809871;4617.2381557043045;111096;112525;112660;112968.43515782368;117490.41254793757;10053.59785608582;11148.777024459465;11399.088072954144;11467.426628668532;11781.528738850522;20426.38720838377;21375.358739237847;21395.144194232056;21880.89059554692;22563.887180563994;7802.29779319864;8019.679212831538;8074.919250807534;8091.959540202261;8117.269445749793;4231.344141658048;4307.396964424983;4315.244832154361;4453.198424283595;4470.7764611769935;3588.7308451866215;3652.7990960496895;3662.5421822272215;3664.8350824212976;3694.131879008431;605.2404232687949;616.4451993206061;619.3373090792809;625.0592857749059;638.3616383616384;685.907402500666;702.7540360873653;708.397861817451;711.2887112887113;718.170513057409;9919.958404367582;9932.857721361992;10030.598776048877;10111.494425278854;10170;522.3444577055847;706.992930070703;713.2261496276494;717.6053170756063;719.586237913202;4737.8104875805275;4976.661038832016;5008.924866127011;5033.2701758245585;5258.815941442108;101068.98931010743;102996.97003030023;103022;103679;107580.92419075865;88327.55836220778;89577.55211223902;90941.54529227444;92382.69043273972;93616.53191734134;65432.67283663646;68750.65624671844;76717.23282767212;78090.82863757048;78581.60709196646;9675.854862177213;9692.466914319499;9704.514774261117;9726.854097188407;9792.657256995972;50451.243231350825;52061.47938520718;52462;52795.73602132119;53414.73292633512;66937;67756.6612166936;69117.08829117048;69354;70676.58646827137;11266.436678165896;11823.11326650522;12029.338386388832;12042.458089385824;12258.87741122613;12515.12394132402;12594.433250503933;12610.243385396905;12917.418716157608;13209.207447553177;11934.880651193376;12094.697632558904;12504.624491306131;12595.811062834247;12610.684732881384;11771.52913883435;11896.345700986183;12196.695082622651;12250.264984100982;12387.75224495523;10688.25182237236;11255.7748845021;11938.403079846146;12331.445084971378;12477.93761031189;10097.747556311151;10406.687799366031;10493.685189444328;10595.258331917;10674.519646615765;9788.902110979085;9876.506174691092;9877.753056173653;9893.208543316374;9919.752006199902 10:13:01 INFO - PROCESS | 2252 | __end_tp_report 10:13:01 INFO - PROCESS | 2252 | __start_cc_report 10:13:01 INFO - PROCESS | 2252 | _x_x_mozilla_cycle_collect,1251 10:13:01 INFO - PROCESS | 2252 | __end_cc_report 10:13:01 INFO - PROCESS | 2252 | __startTimestamp1485108781358__endTimestamp 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | ------- Summary: start ------- 10:13:01 INFO - PROCESS | 2252 | Number of tests: 6 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | [#0] dojo.html Cycles:165 Average:5701.04 Median:5859.00 stddev:642.24 (11.0%) stddev-sans-first:614.66 10:13:01 INFO - PROCESS | 2252 | Values: 3246.1 3272.8 3276.0 3311.0 3321.4 5526.1 5603.6 5630.2 5641.8 5674.1 5562.6 5608.5 5610.6 5619.7 5679.7 5068.2 5099.8 5101.2 5112.7 5132.0 5048.3 5151.8 5233.0 5246.0 5279.4 5177.9 5203.8 5225.7 5229.1 5235.1 5021.9 5065.8 5071.0 5134.1 5144.6 5040.0 5088.6 5120.0 5121.1 5131.5 5543.1 5596.8 5608.8 5613.2 5628.2 6113.6 6132.1 6134.5 6139.2 6149.2 6122.3 6183.5 6202.3 6219.9 6295.3 5804.7 5828.9 5840.5 5855.4 5859.0 5733.0 5875.3 6270.0 6274.0 6287.6 5988.9 6020.2 6023.6 6115.5 6123.1 6252.0 6270.1 6277.8 6283.9 6291.0 5958.4 6119.8 6131.0 6141.9 6155.9 6221.4 6228.8 6250.4 6251.0 6256.5 4349.9 4934.0 4993.7 5012.1 5018.6 4421.1 4441.7 4468.8 4481.6 4489.0 5599.6 5715.8 5716.9 5724.8 5730.6 6115.4 6128.2 6180.4 6184.5 6208.9 5723.0 5753.4 5754.8 5785.5 5787.5 5432.9 5436.2 5439.1 5460.9 5470.4 6208.5 6224.0 6250.9 6295.3 6322.7 6244.6 6254.2 6257.4 6257.5 6280.8 6277.7 6289.9 6297.5 6298.9 6320.1 6020.5 6072.7 6100.8 6177.4 6196.5 6132.6 6235.4 6255.5 6265.8 6302.7 6090.7 6094.7 6094.7 6120.2 6121.9 5916.7 5948.8 6019.2 6062.3 6102.5 5786.6 5810.5 5842.3 5925.6 5936.9 6041.0 6049.8 6062.3 6068.1 6073.9 5735.2 5748.5 5750.4 5844.7 5886.2 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | [#1] ext.html Cycles:180 Average:66655.51 Median:20984.68 stddev:140949.27 (671.7%) stddev-sans-first:141256.98 10:13:01 INFO - PROCESS | 2252 | Values: 435.3 437.0 474.2 502.3 512.5 30420.1 40691.0 42349.6 42462.6 42652.9 42438.8 42842.0 42860.8 42906.6 42984.4 7437.5 8078.0 8336.6 9418.2 9446.8 8346.2 11112.7 11389.3 11424.4 11619.9 11345.1 11434.5 11441.2 11457.0 11467.7 8375.7 8551.1 11309.8 11350.7 11397.9 10997.8 11290.7 11334.5 11481.3 11487.8 37522.6 41025.4 41080.2 41105.8 41416.6 3822.4 4042.6 4091.4 4095.6 4177.4 29596.0 30485.1 30764.4 30790.6 31787.5 3146.4 3252.9 3257.0 3292.1 3354.8 480660.2 481927.0 482076.0 482255.0 483260.0 58236.6 58650.0 58679.0 58720.0 58771.7 61181.0 61743.2 62198.0 62302.0 62363.0 15507.0 15697.1 15698.1 15709.4 15713.2 9349.5 11404.0 12297.8 12354.3 12372.1 15001.2 15350.5 15365.8 15625.3 15653.9 7095.5 7167.2 7210.0 7228.4 7261.0 859.6 866.7 883.8 884.3 906.6 29430.0 29501.7 29960.6 30220.4 30279.8 1046.7 1051.1 1085.9 1095.8 1169.6 15319.6 15351.8 15352.0 15450.5 15687.1 586799.0 590526.0 591054.0 591520.0 591788.0 57982.7 58111.7 58126.7 58359.6 58609.7 1390.3 1434.4 1443.4 1448.2 1453.0 25909.6 26794.7 29107.4 29135.6 29703.6 48944.5 49219.0 49300.0 49326.8 49378.8 506178.0 507966.0 509260.5 510017.0 510638.0 37746.9 38254.0 38478.6 38485.0 38620.2 35632.5 36651.3 44832.6 45081.5 45932.1 37334.8 37499.1 38147.0 38915.6 38932.0 37052.1 37310.0 38330.2 38421.8 38632.6 35766.5 35835.0 36329.8 36619.6 37250.1 31943.0 33363.2 33512.7 33532.7 33572.7 24001.0 24432.0 24432.4 24548.6 24740.9 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | [#2] jquery.html Cycles:180 Average:40537.87 Median:15148.70 stddev:118594.01 (782.9%) stddev-sans-first:118888.33 10:13:01 INFO - PROCESS | 2252 | Values: 363.8 381.5 390.3 397.5 414.1 14892.0 15757.3 18113.4 20650.0 20910.3 22113.0 22193.4 22293.7 22673.4 22739.5 5830.2 5893.3 5984.2 6064.9 6158.2 4186.2 4398.2 5886.2 5999.5 6000.6 5251.5 6520.4 6560.8 6592.4 6628.3 6391.7 6430.8 6440.5 6546.5 6611.0 5581.2 5589.9 5711.8 5737.4 5738.1 26667.0 27555.4 27604.9 27713.9 27865.6 2736.2 2741.9 2771.4 2783.2 2854.6 15918.5 15950.4 16065.8 16152.9 16846.5 1841.2 1841.4 1862.7 1905.0 1925.4 120688.0 133450.3 135981.3 135987.0 137500.3 11254.4 11459.4 11464.9 11489.5 11658.8 14129.9 14722.9 14748.6 14753.9 14779.0 7116.6 8559.0 8665.0 8866.9 8897.6 8572.7 8574.7 8576.7 8732.7 8732.9 7190.4 7314.0 7333.0 7350.5 7353.4 1566.3 1770.8 1908.3 1910.9 1956.1 810.1 849.8 872.4 900.2 908.3 19562.7 22074.4 22200.5 23275.5 23516.3 737.9 926.7 956.9 959.3 969.4 11134.2 11962.0 12257.8 12294.7 12314.8 695826.0 705129.0 705461.0 716099.0 722516.0 149052.1 158101.2 158665.0 160514.0 166252.0 985.7 1066.8 1070.6 1074.0 1076.3 20199.6 20556.7 20690.6 20779.5 20883.0 61515.7 61660.4 62808.7 63587.0 63880.0 91266.1 91369.1 93726.6 94338.1 94844.5 6670.4 6914.8 7343.7 8040.2 8761.8 7913.4 10676.6 13502.9 13523.3 14035.1 11626.0 11692.6 11926.8 11984.5 12053.6 11418.9 11561.7 11730.0 11977.9 12042.3 11615.7 11621.7 12055.8 12111.9 12128.3 7536.1 7548.4 7704.0 7754.0 7872.1 11566.3 11606.6 11997.6 12089.9 12096.1 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | [#3] mootools.html Cycles:180 Average:5355.09 Median:5315.89 stddev:2894.08 (54.4%) stddev-sans-first:2887.24 10:13:01 INFO - PROCESS | 2252 | Values: 1439.4 1450.8 1464.1 1475.0 1482.7 7904.5 8304.4 8310.9 8326.0 8329.7 7300.6 7570.6 7578.2 7858.2 8094.0 2279.5 2323.5 2325.8 2327.1 2331.3 2297.9 2326.3 2331.9 2333.8 2337.2 2281.3 2284.9 2304.7 2305.1 2308.7 2125.8 2139.8 2163.0 2177.0 2281.9 2290.7 2315.3 2315.3 2323.4 2324.2 8130.2 8299.5 8300.3 8305.3 8315.0 4993.1 5154.3 5159.4 5159.4 5169.4 3265.3 3324.7 3490.3 3538.8 3541.9 1198.9 1200.9 1229.1 1235.7 1256.3 10415.2 10555.3 10668.6 10670.1 10674.3 4141.3 4312.2 4546.7 4561.2 4564.7 8665.4 9230.2 9248.2 9251.0 9263.3 5166.5 5170.1 5173.3 5179.1 5182.2 4050.3 4153.3 4431.6 4675.5 4714.4 3694.0 3730.5 3819.4 3842.5 3860.9 1255.5 1257.1 1258.0 1266.0 1269.7 774.5 855.7 886.5 887.7 924.6 5449.6 5470.6 5586.8 5755.0 5786.9 942.9 974.8 980.0 992.9 1027.7 3644.1 3675.8 3759.3 3772.5 3777.3 9620.5 9910.9 9911.1 9917.2 9935.8 8415.6 9743.5 9745.4 9851.9 9862.4 6515.0 7589.0 7668.0 7765.1 7780.7 5469.5 5473.5 5488.0 5662.3 5765.5 9159.3 9247.5 9266.3 9300.5 9316.6 8990.4 9273.5 9371.0 9429.8 9451.1 6926.8 7052.1 7137.4 7196.1 7230.0 7908.4 7968.6 7971.0 7972.1 7989.1 6918.9 7057.8 7116.4 7144.2 7194.6 5910.4 6724.9 6752.0 6944.9 6990.9 6113.1 6251.4 6318.9 6327.0 6335.2 4885.0 4921.3 4921.8 4956.6 5039.4 4849.0 4857.5 4949.5 5015.9 5017.1 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | [#4] prototype.html Cycles:180 Average:4376.81 Median:4836.99 stddev:1291.18 (26.7%) stddev-sans-first:1258.98 10:13:01 INFO - PROCESS | 2252 | Values: 352.6 354.6 362.8 373.3 374.8 4896.7 5030.5 5132.9 5222.9 5265.3 4465.5 4975.3 4977.3 5072.3 5131.4 4044.1 4101.3 4110.2 4129.5 4134.6 3979.8 4090.1 4108.6 4114.3 4152.7 3402.5 4045.1 4098.1 4128.1 4144.0 3329.6 3377.4 3562.8 3681.2 4002.9 3065.5 3242.5 3603.9 3619.4 3628.3 4802.9 4909.4 4917.0 4963.5 5176.6 4336.5 4495.9 4654.6 4655.4 4701.4 5310.7 5331.6 5331.7 5376.3 5420.7 3451.7 3845.7 3914.7 3966.1 3979.3 5620.8 5709.2 5717.9 5735.7 5769.2 4093.3 4094.6 4107.6 4156.7 4180.0 3464.9 3854.6 4184.4 4210.0 4225.9 4198.8 4750.6 4780.0 4781.0 4784.9 4687.6 5594.0 5613.5 5621.3 5642.5 1220.3 1293.4 1315.5 1358.2 1366.9 759.1 865.6 940.1 948.9 981.8 4289.9 4829.7 4842.2 4852.5 4921.0 4553.7 5108.1 5277.9 5332.0 5469.0 4365.9 4463.7 4627.0 4831.8 4863.2 2337.7 2476.8 2766.2 2781.3 2825.4 4972.0 5104.0 5108.2 5165.2 5463.8 4553.0 5242.7 5333.5 5452.7 5541.0 4786.7 5022.7 5381.7 5386.8 5535.9 4347.7 4656.3 4691.8 5008.5 5218.5 4395.0 4752.0 5151.5 5177.6 5181.9 4603.9 4732.0 5179.8 5372.3 5372.4 3304.8 3524.5 3675.3 3781.8 3865.7 5275.8 5524.8 5590.4 5614.3 5629.9 5398.6 5429.0 5431.9 5442.2 5463.2 4542.7 5150.8 5422.4 5452.9 5470.6 4595.0 5123.9 5188.8 5217.6 5380.4 5396.6 5429.0 5430.4 5439.8 5545.4 5118.7 5277.3 5300.9 5305.8 5324.0 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - PROCESS | 2252 | [#5] yui.html Cycles:180 Average:20573.53 Median:4499.42 stddev:30114.55 (669.3%) stddev-sans-first:30162.10 10:13:01 INFO - PROCESS | 2252 | Values: 709.9 714.8 744.4 777.6 850.3 15097.5 15402.5 15837.0 15962.3 16077.9 13976.4 14521.9 14597.9 14894.6 14924.3 861.1 876.6 878.6 881.7 883.0 597.5 686.4 706.7 860.9 866.9 917.6 935.4 937.8 937.8 938.7 931.0 931.5 932.2 932.2 933.9 529.7 545.3 664.5 693.6 696.6 12345.8 15600.0 15619.8 15625.5 15644.1 13926.9 13939.6 14111.4 14130.3 14185.3 12674.2 12763.8 12796.2 12900.2 13077.7 4409.6 4441.4 4493.7 4505.2 4617.2 111096.0 112525.0 112660.0 112968.4 117490.4 10053.6 11148.8 11399.1 11467.4 11781.5 20426.4 21375.4 21395.1 21880.9 22563.9 7802.3 8019.7 8074.9 8092.0 8117.3 4231.3 4307.4 4315.2 4453.2 4470.8 3588.7 3652.8 3662.5 3664.8 3694.1 605.2 616.4 619.3 625.1 638.4 685.9 702.8 708.4 711.3 718.2 9920.0 9932.9 10030.6 10111.5 10170.0 522.3 707.0 713.2 717.6 719.6 4737.8 4976.7 5008.9 5033.3 5258.8 101069.0 102997.0 103022.0 103679.0 107580.9 88327.6 89577.6 90941.5 92382.7 93616.5 65432.7 68750.7 76717.2 78090.8 78581.6 9675.9 9692.5 9704.5 9726.9 9792.7 50451.2 52061.5 52462.0 52795.7 53414.7 66937.0 67756.7 69117.1 69354.0 70676.6 11266.4 11823.1 12029.3 12042.5 12258.9 12515.1 12594.4 12610.2 12917.4 13209.2 11934.9 12094.7 12504.6 12595.8 12610.7 11771.5 11896.3 12196.7 12250.3 12387.8 10688.3 11255.8 11938.4 12331.4 12477.9 10097.7 10406.7 10493.7 10595.3 10674.5 9788.9 9876.5 9877.8 9893.2 9919.8 10:13:01 INFO - PROCESS | 2252 | -------- Summary: end -------- 10:13:01 INFO - PROCESS | 2252 | 10:13:01 INFO - TEST-INFO | 2252: exit 0 10:13:02 INFO - TEST-OK | dromaeo_css | took 1118985ms 10:13:02 INFO - TEST-START | kraken 10:13:02 INFO - operating with platform_type : mac_ 10:13:02 INFO - Initialising browser for kraken test... 10:13:02 INFO - TEST-INFO | started process 2255 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpqEs5WA/profile http://localhost:49810/getInfo.html) 10:13:04 INFO - PROCESS | 2255 | __metrics Screen width/height:1600/1200 10:13:04 INFO - PROCESS | 2255 | colorDepth:24 10:13:04 INFO - PROCESS | 2255 | Browser inner width/height: 1024/689 10:13:04 INFO - PROCESS | 2255 | __metrics 10:13:04 INFO - PROCESS | 2255 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 10:13:04 INFO - PROCESS | 2255 | 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" 10:13:04 INFO - PROCESS | 2255 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:13:05 INFO - TEST-INFO | 2255: exit 0 10:13:05 INFO - Browser initialized. 10:13:05 INFO - Running cycle 1/1 for kraken test... 10:13:05 INFO - TEST-INFO | started process 2256 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpqEs5WA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:17 INFO - PROCESS | 2256 | RSS: Main: 227160064 10:13:17 INFO - PROCESS | 2256 | 10:13:20 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49810/tests/kraken/driver.html?testName=audio-beat-detection) 10:13:21 INFO - PROCESS | 2256 | RSS: Main: 289128448 10:13:21 INFO - PROCESS | 2256 | 10:13:24 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49810/tests/kraken/driver.html?testName=audio-dft) 10:13:24 INFO - PROCESS | 2256 | RSS: Main: 291131392 10:13:24 INFO - PROCESS | 2256 | 10:13:27 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49810/tests/kraken/driver.html?testName=audio-fft) 10:13:28 INFO - PROCESS | 2256 | RSS: Main: 381829120 10:13:28 INFO - PROCESS | 2256 | 10:13:30 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49810/tests/kraken/driver.html?testName=audio-oscillator) 10:13:31 INFO - PROCESS | 2256 | RSS: Main: 282288128 10:13:31 INFO - PROCESS | 2256 | 10:13:33 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:13:33 INFO - PROCESS | 2256 | RSS: Main: 287301632 10:13:33 INFO - PROCESS | 2256 | 10:13:36 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49810/tests/kraken/driver.html?testName=imaging-darkroom) 10:13:37 INFO - PROCESS | 2256 | RSS: Main: 329867264 10:13:37 INFO - PROCESS | 2256 | 10:13:40 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49810/tests/kraken/driver.html?testName=imaging-desaturate) 10:13:40 INFO - PROCESS | 2256 | RSS: Main: 330678272 10:13:40 INFO - PROCESS | 2256 | 10:13:43 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49810/tests/kraken/driver.html?testName=json-parse-financial) 10:13:44 INFO - PROCESS | 2256 | RSS: Main: 326516736 10:13:44 INFO - PROCESS | 2256 | 10:13:45 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:13:46 INFO - PROCESS | 2256 | RSS: Main: 302247936 10:13:46 INFO - PROCESS | 2256 | 10:13:48 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:13:49 INFO - PROCESS | 2256 | RSS: Main: 306515968 10:13:49 INFO - PROCESS | 2256 | 10:13:51 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:13:51 INFO - PROCESS | 2256 | RSS: Main: 313946112 10:13:51 INFO - PROCESS | 2256 | 10:13:54 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:13:55 INFO - PROCESS | 2256 | RSS: Main: 330297344 10:13:55 INFO - PROCESS | 2256 | 10:13:58 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:13:59 INFO - PROCESS | 2256 | RSS: Main: 323256320 10:13:59 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:49810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49810/tests/kraken/driver.html?testName=ai-astar) 10:14:01 INFO - PROCESS | 2256 | RSS: Main: 367591424 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | __start_tp_report 10:14:01 INFO - PROCESS | 2256 | _x_x_mozilla_page_load 10:14:01 INFO - PROCESS | 2256 | _x_x_mozilla_page_load_details 10:14:01 INFO - PROCESS | 2256 | |i|pagename|runs| 10:14:01 INFO - PROCESS | 2256 | |0;ai-astar;113;113;113;115;165;170;113;112;113;113 10:14:01 INFO - PROCESS | 2256 | |1;audio-beat-detection;144;110;110;143;111;109;111;121;131;110 10:14:01 INFO - PROCESS | 2256 | |2;audio-dft;187;188;184;186;184;184;180;185;185;184 10:14:01 INFO - PROCESS | 2256 | |3;audio-fft;82;58;60;89;62;81;82;62;74;60 10:14:01 INFO - PROCESS | 2256 | |4;audio-oscillator;92;70;86;71;69;70;83;68;69;85 10:14:01 INFO - PROCESS | 2256 | |5;imaging-gaussian-blur;87;84;87;86;88;83;88;83;87;83 10:14:01 INFO - PROCESS | 2256 | |6;imaging-darkroom;93;93;95;94;92;94;94;94;93;103 10:14:01 INFO - PROCESS | 2256 | |7;imaging-desaturate;139;87;85;87;86;85;87;86;87;103 10:14:01 INFO - PROCESS | 2256 | |8;json-parse-financial;56;54;56;54;54;56;56;55;55;56 10:14:01 INFO - PROCESS | 2256 | |9;json-stringify-tinderbox;73;72;83;75;78;71;74;75;72;72 10:14:01 INFO - PROCESS | 2256 | |10;stanford-crypto-aes;87;89;89;89;88;86;90;88;88;85 10:14:01 INFO - PROCESS | 2256 | |11;stanford-crypto-ccm;138;141;146;126;150;149;153;147;187;138 10:14:01 INFO - PROCESS | 2256 | |12;stanford-crypto-pbkdf2;174;175;172;173;188;236;192;172;175;191 10:14:01 INFO - PROCESS | 2256 | |13;stanford-crypto-sha256-iterative;67;69;68;67;66;69;67;66;65;67 10:14:01 INFO - PROCESS | 2256 | __end_tp_report 10:14:01 INFO - PROCESS | 2256 | __start_cc_report 10:14:01 INFO - PROCESS | 2256 | _x_x_mozilla_cycle_collect,2037 10:14:01 INFO - PROCESS | 2256 | __end_cc_report 10:14:01 INFO - PROCESS | 2256 | __startTimestamp1485108841310__endTimestamp 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | ------- Summary: start ------- 10:14:01 INFO - PROCESS | 2256 | Number of tests: 14 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#0] ai-astar Cycles:10 Average:124.00 Median:113.00 stddev:22.97 (20.3%) stddev-sans-first:24.01 10:14:01 INFO - PROCESS | 2256 | Values: 113.0 113.0 113.0 115.0 165.0 170.0 113.0 112.0 113.0 113.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#1] audio-beat-detection Cycles:10 Average:120.00 Median:116.00 stddev:14.18 (12.2%) stddev-sans-first:12.09 10:14:01 INFO - PROCESS | 2256 | Values: 144.0 110.0 110.0 143.0 111.0 109.0 111.0 121.0 131.0 110.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:2.16 (1.2%) stddev-sans-first:2.13 10:14:01 INFO - PROCESS | 2256 | Values: 187.0 188.0 184.0 186.0 184.0 184.0 180.0 185.0 185.0 184.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#3] audio-fft Cycles:10 Average:71.00 Median:77.50 stddev:11.78 (15.2%) stddev-sans-first:11.80 10:14:01 INFO - PROCESS | 2256 | Values: 82.0 58.0 60.0 89.0 62.0 81.0 82.0 62.0 74.0 60.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:77.00 stddev:9.09 (11.8%) stddev-sans-first:7.67 10:14:01 INFO - PROCESS | 2256 | Values: 92.0 70.0 86.0 71.0 69.0 70.0 83.0 68.0 69.0 85.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:87.00 stddev:2.12 (2.4%) stddev-sans-first:2.19 10:14:01 INFO - PROCESS | 2256 | Values: 87.0 84.0 87.0 86.0 88.0 83.0 88.0 83.0 87.0 83.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:3.10 (3.3%) stddev-sans-first:3.24 10:14:01 INFO - PROCESS | 2256 | Values: 93.0 93.0 95.0 94.0 92.0 94.0 94.0 94.0 93.0 103.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:86.50 stddev:16.95 (19.6%) stddev-sans-first:5.64 10:14:01 INFO - PROCESS | 2256 | Values: 139.0 87.0 85.0 87.0 86.0 85.0 87.0 86.0 87.0 103.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 10:14:01 INFO - PROCESS | 2256 | Values: 56.0 54.0 56.0 54.0 54.0 56.0 56.0 55.0 55.0 56.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#9] json-stringify-tinderbox Cycles:10 Average:74.50 Median:74.50 stddev:3.63 (4.9%) stddev-sans-first:3.81 10:14:01 INFO - PROCESS | 2256 | Values: 73.0 72.0 83.0 75.0 78.0 71.0 74.0 75.0 72.0 72.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.50 stddev:1.52 (1.7%) stddev-sans-first:1.58 10:14:01 INFO - PROCESS | 2256 | Values: 87.0 89.0 89.0 89.0 88.0 86.0 90.0 88.0 88.0 85.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:148.00 stddev:15.94 (10.8%) stddev-sans-first:16.53 10:14:01 INFO - PROCESS | 2256 | Values: 138.0 141.0 146.0 126.0 150.0 149.0 153.0 147.0 187.0 138.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:181.50 stddev:19.71 (10.9%) stddev-sans-first:20.52 10:14:01 INFO - PROCESS | 2256 | Values: 174.0 175.0 172.0 173.0 188.0 236.0 192.0 172.0 175.0 191.0 10:14:01 INFO - PROCESS | 2256 | 10:14:01 INFO - PROCESS | 2256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:1.36 10:14:01 INFO - PROCESS | 2256 | Values: 67.0 69.0 68.0 67.0 66.0 69.0 67.0 66.0 65.0 67.0 10:14:01 INFO - PROCESS | 2256 | -------- Summary: end -------- 10:14:01 INFO - PROCESS | 2256 | 10:14:02 INFO - TEST-INFO | 2256: exit 0 10:14:02 INFO - TEST-OK | kraken | took 60248ms 10:14:02 INFO - SUITE-END | took 1179s 10:14:02 INFO - Completed test suite (00:19:39) 10:14:02 INFO - javascript benchmark 10:14:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.0910944935417, 3272.770906036577, 3276.0, 3310.966890331096, 3321.4353559894816, 5526.115821468566, 5603.579731520137, 5630.183623374608, 5641.7870157916095, 5674.0921452567545, 5562.554995600352, 5608.46719561641, 5610.607257491977, 5619.7471113799875, 5679.744411501492, 5068.214426763858, 5099.7705103270255, 5101.183810590306, 5112.744362781846, 5131.974340128294, 5048.268001139832, 5151.7681704323395, 5233.031889100528, 5245.973770131144, 5279.366476022883, 5177.887246852772, 5203.817866374697, 5225.660332078422, 5229.058769421503, 5235.110031294689, 5021.924671129936, 5065.772040258161, 5071.0, 5134.127198376285, 5144.639875208737, 5040.017196646655, 5088.643794934356, 5120.001599688062, 5121.129408000612, 5131.461196574343, 5543.085390910495, 5596.832095037155, 5608.803691870806, 5613.214150019001, 5628.240187574707, 6113.576218238259, 6132.091946452698, 6134.528431832502, 6139.229124622885, 6149.200603921507, 6122.306673174798, 6183.505319574423, 6202.348753380875, 6219.87560248797, 6295.338989406138, 5804.65172089676, 5828.941710582924, 5840.532757379442, 5855.443732845373, 5859.0, 5732.971335143381, 5875.265591801025, 6270.0, 6274.0, 6287.591306565058, 5988.880222395528, 6020.187274717945, 6023.638581685025, 6115.480184184395, 6123.109882171256, 6251.9687401562705, 6270.122182894398, 6277.811665650038, 6283.874322513524, 6290.968545157245, 5958.404159584007, 6119.847427074719, 6130.969345153246, 6141.938580614226, 6155.876882462326, 6221.4089661482085, 6228.750849965951, 6250.406211409909, 6250.968745156245, 6256.499480041586, 4349.913001740011, 4933.975330123327, 4993.675411098267, 5012.072766538202, 5018.573421259161, 4421.115776844644, 4441.666874984389, 4468.776561171929, 4481.574250446202, 4489.0, 5599.636023658531, 5715.799947001919, 5716.914246286309, 5724.799632012943, 5730.570207234474, 6115.422885572139, 6128.228138398679, 6180.4437600615265, 6184.5052395808225, 6208.906866397007, 5722.9984752668115, 5753.367129615739, 5754.769809207669, 5785.537157027427, 5787.508061814793, 5432.864178395572, 5436.21174929633, 5439.075357189287, 5460.945390546123, 5470.398256191816, 6208.503319734501, 6224.035274532545, 6250.937490625218, 6295.307516173309, 6322.683865806691, 6244.562880598314, 6254.186955695731, 6257.43683068526, 6257.53068519872, 6280.780172694116, 6277.686115694289, 6289.874202516015, 6297.52768542352, 6298.937010630018, 6320.115183874169, 6020.488258498077, 6072.726727297194, 6100.816975490742, 6177.413145751147, 6196.504279657526, 6132.600268413531, 6235.407636274546, 6255.530835187288, 6265.780697675742, 6302.653354065387, 6090.725917333819, 6094.664793436404, 6094.664793436404, 6120.234970628671, 6121.877562448815, 5916.674582897982, 5948.791792287249, 6019.247594050744, 6062.333143354315, 6102.511799056154, 5786.623869448473, 5810.477057064884, 5842.269716285465, 5925.585209035326, 5936.8812623748145, 6041.033434650435, 6049.758009679564, 6062.272527296753, 6068.120122582289, 6073.878522429615, 5735.197072409783, 5748.45389687979, 5750.424957504216, 5844.678542680023, 5886.23478947734], "value": 5658.498273514397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.3100335967491, 436.99126017479654, 474.174935612035, 502.32688197814934, 512.5259135299847, 30420.087397378058, 40691.0, 42349.576504234945, 42462.57537424625, 42652.93367665806, 42438.787806061, 42842.0, 42860.78569607155, 42906.57093429065, 42984.35523467143, 7437.4793764436645, 8077.95961020194, 8336.62485188168, 9418.1994530465, 9446.763830904249, 8346.165383461666, 11112.722181945475, 11389.316641001566, 11424.42877856108, 11619.941900290529, 11345.149113816455, 11434.485448154854, 11441.199116061878, 11457.0, 11467.713307167303, 8375.748727538123, 8551.059383467813, 11309.773804523904, 11350.659480215607, 11397.943010284978, 10997.780044399067, 11290.661280161608, 11334.546618135264, 11481.253718508271, 11487.770244595145, 37522.624773752184, 41025.38461923073, 41080.178396431904, 41105.79447102775, 41416.58583414188, 3822.3502004659276, 4042.555318914917, 4091.4067460218102, 4095.5904409558807, 4177.352510360899, 29596.0, 30485.08544743639, 30764.38471230563, 30790.61164296239, 31787.52318715198, 3146.3549972255632, 3252.886148984774, 3257.040501542437, 3292.111129994912, 3354.8154851483405, 480660.19339806505, 481927.0, 482076.0, 482255.0, 483260.0, 58236.63225258123, 58650.0, 58679.0, 58720.0, 58771.70614146902, 61181.0, 61743.208247092785, 62198.0, 62302.0, 62363.0, 15507.0, 15697.058176509447, 15698.136602486973, 15709.371625135094, 15713.21433928299, 9349.532523373804, 11404.0, 12297.754044919051, 12354.320512371725, 12372.07209459294, 15001.17493537844, 15350.462733804263, 15365.769513457308, 15625.296861641253, 15653.921730391276, 7095.503314767917, 7167.247439018932, 7210.0, 7228.38558722504, 7261.0, 859.6260626627437, 866.6663334616218, 883.7569668341129, 884.2925659472396, 906.5739102621757, 29430.0, 29501.704982950327, 29960.550591741143, 30220.395592088036, 30279.848600756854, 1046.6912260883057, 1051.1065594244983, 1085.918556108295, 1095.7644106517137, 1169.5555688838188, 15319.617009574627, 15351.769723454157, 15352.002119862173, 15450.5364839055, 15687.058776473448, 586799.0, 590526.0, 591054.0, 591520.0, 591788.0410597919, 57982.7100864493, 58111.70944145252, 58126.709366452895, 58359.58044615089, 58609.70695146497, 1390.3395886953817, 1434.4405681784112, 1443.3937746146644, 1448.2324368085142, 1453.0119518726945, 25909.574973375893, 26794.732052679225, 29107.417851643273, 29135.562966555095, 29703.55444668375, 48944.510554894, 49219.0, 49300.013999719085, 49326.76683082952, 49378.75310623424, 506178.0, 507966.0, 509260.45369772916, 510017.0, 510638.0, 37746.86759397222, 38254.0, 38478.61521384862, 38485.0, 38620.227595448494, 35632.46551301681, 36651.266974659826, 44832.551674482835, 45081.549184507734, 45932.08135837198, 37334.81332593429, 37499.06252343713, 38147.0, 38915.6108438912, 38932.0, 37052.073698157765, 37310.0, 38330.23339533138, 38421.807890960365, 38632.6136738629, 35766.46350304696, 35835.0, 36329.81835090913, 36619.63380366162, 37250.06874828151, 31943.041708748773, 33363.1659208512, 33512.66487335096, 33532.664673352956, 33572.66427335793, 24001.039958402165, 24432.0, 24432.389190270387, 24548.631770523098, 24740.876295618407], "value": 19914.53602753559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.8235455803936, 381.4507109761941, 390.25266614433355, 397.5209872104114, 414.1447910065716, 14892.0, 15757.290921908512, 18113.366032188875, 20650.0, 20910.26814061508, 22113.0, 22193.44516387091, 22293.665595016046, 22673.433164170903, 22739.54520909581, 5830.21292125564, 5893.263342082239, 5984.192134061911, 6064.939350606482, 6158.230221222348, 4186.162767446508, 4398.208322501949, 5886.175935369051, 5999.460048595625, 6000.569769243463, 5251.527362537371, 6520.4131628153455, 6560.770373036945, 6592.439642630382, 6628.270890202098, 6391.680415979183, 6430.839229019265, 6440.51696122788, 6546.509011824085, 6611.0, 5581.246531718207, 5589.888202235932, 5711.8000869969765, 5737.3975732548315, 5738.081906894877, 26667.0, 27555.448891022068, 27604.861975689993, 27713.86143069292, 27865.58201626977, 2736.2065001149645, 2741.9451610967667, 2771.3764403009363, 2783.2346104821136, 2854.6431696037994, 15918.522444326689, 15950.441734539236, 16065.759013614805, 16152.919235403748, 16846.49460516174, 1841.2174825699024, 1841.3555255660413, 1862.6554087493857, 1905.0, 1925.422373288008, 120688.0, 133450.33274833564, 135981.3200933999, 135987.0, 137500.31249843686, 11254.381009044417, 11459.390292057975, 11464.94267528657, 11489.482973266224, 11658.766824663458, 14129.929350353183, 14722.852771472362, 14748.631284217765, 14753.92623036878, 14779.039362441406, 7116.608586527687, 8559.0, 8665.046844847062, 8866.86699699505, 8897.599608017656, 8572.742817715478, 8574.742757717278, 8576.742697719079, 8732.738017859474, 8732.912670873337, 7190.368863723786, 7313.976043353935, 7332.96333518329, 7350.471773548619, 7353.374963128087, 1566.3499647646327, 1770.8312513740868, 1908.3130073173647, 1910.8566857485744, 1956.1197461142542, 810.1452967119627, 849.8087930215776, 872.358816270041, 900.1898291537668, 908.318760929303, 19562.70655940162, 22074.44813879666, 22200.4807405789, 23275.534489310117, 23516.29451116469, 737.9040724705861, 926.7034548944408, 956.8516879883629, 959.29971121082, 969.3553786731885, 11134.16493762971, 11962.0, 12257.754844903231, 12294.692632684075, 12314.753704925852, 695826.0, 705129.0, 705461.0, 716099.0, 722516.0, 149052.07583393302, 158101.20949395178, 158665.0, 160514.0, 166252.0, 985.7190700650281, 1066.7813098314828, 1070.635983765508, 1073.983890241647, 1076.273515377133, 20199.59600807946, 20556.69164962497, 20690.58618827585, 20779.480512987295, 20883.0, 61515.692421537606, 61660.38339616726, 62808.68595656993, 63587.0, 63880.0, 91266.08733912576, 91369.08630913871, 93726.5941010899, 94338.11323773349, 94844.52577737343, 6670.39966403026, 6914.792556223321, 7343.742968996059, 8040.2361775631225, 8761.824763504821, 7913.44605877583, 10676.572937082741, 13502.932485337511, 13523.256220907944, 14035.087719298213, 11626.0, 11692.649220523397, 11926.761464770483, 11984.520619175484, 12053.63839084829, 11418.942905285421, 11561.653150405165, 11730.002949749367, 11977.92198702121, 12042.337671428155, 11615.6515304541, 11621.709457263636, 12055.758884822078, 12111.878881211074, 12128.332941688292, 7536.0956685198125, 7548.358389536951, 7704.0, 7753.961230194039, 7872.094709108525, 11566.30602163873, 11606.593769218036, 11997.580084697343, 12089.939550302191, 12096.092793040381], "value": 10242.969186562192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.3882599895041, 1450.767877139658, 1464.070315349753, 1474.95575132746, 1482.7405204089284, 7904.486208396457, 8304.418690691655, 8310.91689083109, 8326.0, 8329.708460203887, 7300.598467084322, 7570.583617901013, 7578.204288549706, 7858.214178582139, 8094.028716554007, 2279.4757205842666, 2323.512062466884, 2325.7557956414585, 2327.104064934995, 2331.277304035746, 2297.8621282723007, 2326.2904814031713, 2331.895064722083, 2333.8249631277636, 2337.1586228957563, 2281.349815302639, 2284.931452056441, 2304.746477887431, 2305.0664480885266, 2308.699869017034, 2125.8299336053155, 2139.786021397848, 2162.9567408651897, 2176.978230217693, 2281.863088214704, 2290.7365652949957, 2315.282262498614, 2315.2938353802083, 2323.384303159664, 2324.1981516376823, 8130.227628375294, 8299.502029878227, 8300.252977232018, 8305.252527272514, 8315.04376996647, 4993.101241776479, 5154.278401023859, 5159.380874295071, 5159.406668233126, 5169.431362550116, 3265.330607225537, 3324.684155005295, 3490.2844916791996, 3538.7699799513207, 3541.9114522136897, 1198.8561372635252, 1200.9099317551131, 1229.1150371732338, 1235.6725467751053, 1256.3466997161424, 10415.16678665705, 10555.258382366901, 10668.62659806903, 10670.146388288918, 10674.306170098918, 4141.275276826544, 4312.159128969884, 4546.704464209815, 4561.24739417999, 4564.657650676212, 8665.43674661145, 9230.215431688248, 9248.16766491019, 9251.028641992494, 9263.25893928484, 5166.483351664803, 5170.121079416508, 5173.327467429285, 5179.119549676564, 5182.170852663556, 4050.331695270306, 4153.314703074019, 4431.556844315607, 4675.485696573374, 4714.4106986626675, 3693.963060369416, 3730.477733117366, 3819.3698039823116, 3842.481265029241, 3860.8841734748003, 1255.4852510470664, 1257.0823298991604, 1257.9874201257871, 1266.0441366768032, 1269.7206614544784, 774.4694884004475, 855.6919508976763, 886.5079880666163, 887.6671248281895, 924.6209054287845, 5449.618526703172, 5470.617056806065, 5586.804461843816, 5755.0, 5786.913196302059, 942.9292803039663, 974.8196583631909, 979.9853002204973, 992.9106380425796, 1027.6505987964129, 3644.1436262478296, 3675.761075530082, 3759.266942946154, 3772.5481184716227, 3777.2823163598828, 9620.518974051269, 9910.851337229948, 9911.10800028001, 9917.206623470105, 9935.751606209758, 8415.621297041647, 9743.512824358753, 9745.366551174151, 9851.852222216672, 9862.358946668444, 6515.0, 7588.962055189689, 7668.0, 7765.0681918170185, 7780.688772449152, 5469.453054694499, 5473.507384335429, 5488.0, 5662.348829884616, 5765.509931655856, 9159.267258619162, 9247.537623118951, 9266.258699303904, 9300.534973251175, 9316.627334906529, 8990.370674053016, 9273.536323183678, 9370.953145234504, 9429.811403772022, 9451.054894510495, 6926.826829329307, 7052.118485189351, 7137.429005679637, 7196.0645116134565, 7229.98780170766, 7908.406869484927, 7968.641411136628, 7971.043474783063, 7972.123066462568, 7989.121196668478, 6918.930810691829, 7057.823554411181, 7116.359527642537, 7144.214136445091, 7194.640267986684, 5910.4089591042275, 6724.899126513008, 6751.966240168767, 6944.895826562504, 6990.895136573057, 6113.083037544226, 6251.437370636482, 6318.873622527615, 6327.019312006646, 6335.176427064452, 4884.975575122102, 4921.3356196912955, 4921.778519966539, 4956.603471722326, 5039.420466646383, 4849.0, 4857.489963553776, 4949.480304568113, 5015.874603134951, 5017.147084995487], "value": 4373.788861986026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.57866849115305, 354.59044803252254, 362.7805177867389, 373.3466433740953, 374.7713894524338, 4896.706197628145, 5030.547250747432, 5132.871678208046, 5222.8694282642955, 5265.26286319915, 4465.4641443026885, 4975.328330675357, 4977.303177555145, 5072.3405957225505, 5131.408638637492, 4044.0698639312977, 4101.323281658522, 4110.177964407116, 4129.545749967501, 4134.56587058359, 3979.796264007473, 4090.1143913282353, 4108.609682080198, 4114.3211370124045, 4152.68854835887, 3402.5236466894653, 4045.089854782665, 4098.077932465201, 4128.112455821998, 4143.958560414388, 3329.6004479462376, 3377.4258376076127, 3562.750607457479, 3681.153334733013, 4002.9199416011515, 3065.493724225385, 3242.5460435539044, 3603.891883243507, 3619.3847046002243, 3628.328759179534, 4802.855914322576, 4909.361782968192, 4916.950830491685, 4963.528464795839, 5176.5858731301405, 4336.522982471925, 4495.9325610115875, 4654.627629789608, 4655.4180727409075, 4701.388819453449, 5310.681359118426, 5331.5734741220995, 5331.680099194022, 5376.301080859464, 5420.674759514442, 3451.741119416054, 3845.730798844082, 3914.745541539791, 3966.127451960564, 3979.3235150024566, 5620.775168993277, 5709.229254050733, 5717.885642287172, 5735.741891614887, 5769.24999750034, 4093.283675356801, 4094.570070142592, 4107.630313271819, 4156.713807405915, 4180.0, 3464.8787292444645, 3854.6145385461227, 4184.389010231022, 4209.957900421018, 4225.873223803291, 4198.790060496963, 4750.572448479654, 4779.95220047802, 4781.0, 4784.880377990508, 4687.648426368036, 5593.972030139905, 5613.46672066153, 5621.297337832771, 5642.492175704207, 1220.273937007497, 1293.4438191577713, 1315.53298579005, 1358.1579420759192, 1366.8838148757268, 759.1270039454561, 865.5845194306768, 940.149165005671, 948.8956214816365, 981.7545613596601, 4289.871303860889, 4829.710217386968, 4842.201036828884, 4852.4662287148385, 4920.991196804646, 4553.681242313006, 5108.106081435734, 5277.894442111136, 5331.9879313445235, 5469.0155771960635, 4365.934510982338, 4463.741468727847, 4626.953730462719, 4831.782569784368, 4863.197572400514, 2337.6610391493136, 2476.8142389320874, 2766.239284196862, 2781.2907708534194, 2825.419795903075, 4972.0, 5104.03023425548, 5108.208227724708, 5165.199394093846, 5463.836084917459, 4553.0, 5242.663120904145, 5333.466653334713, 5452.691354075073, 5541.0, 4786.664933454625, 5022.698638081727, 5381.677099373972, 5386.7982973280905, 5535.916961245584, 4347.71742336018, 4656.348111264493, 4691.835785747619, 5008.524190201925, 5218.504242096995, 4394.956050439582, 4752.008313017082, 5151.5106064923775, 5177.585793136615, 5181.870453238699, 4603.928232295413, 4731.9589690268085, 5179.792808287626, 5372.274742909657, 5372.409035006224, 3304.7686661933435, 3524.4537096750046, 3675.338439080884, 3781.829817658157, 3865.7487263327794, 5275.815346462856, 5524.812165384462, 5590.413006634245, 5614.326280846324, 5629.887402252014, 5398.64908780928, 5429.0, 5431.918521222264, 5442.238086667949, 5463.153211252262, 4542.659300552538, 5150.768215430389, 5422.397249320427, 5452.863678408072, 5470.589705772162, 4594.977025114853, 5123.871903202301, 5188.832512684616, 5217.6086793491395, 5380.408155103014, 5396.568274538106, 5428.972855135699, 5430.429804870431, 5439.836804895859, 5545.3622833374675, 5118.71847048401, 5277.313949186581, 5300.867478313073, 5305.814296499604, 5323.973380133075], "value": 3983.6590542080166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9432045436365, 714.8105751975726, 744.3933194446522, 777.6345117794634, 850.2942557677127, 15097.547073587783, 15402.537923862288, 15837.049777013388, 15962.281697323619, 16077.919610401961, 13976.440942362318, 14521.854781452183, 14597.92701036496, 14894.553163405088, 14924.328405221764, 861.0743450790394, 876.6230520876021, 878.565110270417, 881.7046289493028, 882.9602667879929, 597.4981015946604, 686.3959715450396, 706.6749295324157, 860.9139086091373, 866.9176428239307, 917.6283605139929, 935.3639525122913, 937.7514958535993, 937.8124375125002, 938.6573900526292, 930.9627614895396, 931.487681775021, 932.2169377722712, 932.2309094996655, 933.8599210118468, 529.6557237795425, 545.2530033853607, 664.4850241063166, 693.5665209244222, 696.6307856835886, 12345.814812777726, 15599.986000909905, 15619.765703514457, 15625.453109141126, 15644.061356318658, 13926.860731392657, 13939.581812545639, 14111.435542578285, 14130.293485325796, 14185.290735463186, 12674.176178548458, 12763.808542871864, 12796.232226066466, 12900.161489503153, 13077.738445231138, 4409.559044095565, 4441.356003379492, 4493.68544201906, 4505.16174809871, 4617.2381557043045, 111096.0, 112525.0, 112660.0, 112968.43515782368, 117490.41254793757, 10053.59785608582, 11148.777024459465, 11399.088072954144, 11467.426628668532, 11781.528738850522, 20426.38720838377, 21375.358739237847, 21395.144194232056, 21880.89059554692, 22563.887180563994, 7802.29779319864, 8019.679212831538, 8074.919250807534, 8091.959540202261, 8117.269445749793, 4231.344141658048, 4307.396964424983, 4315.244832154361, 4453.198424283595, 4470.7764611769935, 3588.7308451866215, 3652.7990960496895, 3662.5421822272215, 3664.8350824212976, 3694.131879008431, 605.2404232687949, 616.4451993206061, 619.3373090792809, 625.0592857749059, 638.3616383616384, 685.907402500666, 702.7540360873653, 708.397861817451, 711.2887112887113, 718.170513057409, 9919.958404367582, 9932.857721361992, 10030.598776048877, 10111.494425278854, 10170.0, 522.3444577055847, 706.992930070703, 713.2261496276494, 717.6053170756063, 719.586237913202, 4737.8104875805275, 4976.661038832016, 5008.924866127011, 5033.2701758245585, 5258.815941442108, 101068.98931010743, 102996.97003030023, 103022.0, 103679.0, 107580.92419075865, 88327.55836220778, 89577.55211223902, 90941.54529227444, 92382.69043273972, 93616.53191734134, 65432.67283663646, 68750.65624671844, 76717.23282767212, 78090.82863757048, 78581.60709196646, 9675.854862177213, 9692.466914319499, 9704.514774261117, 9726.854097188407, 9792.657256995972, 50451.243231350825, 52061.47938520718, 52462.0, 52795.73602132119, 53414.73292633512, 66937.0, 67756.6612166936, 69117.08829117048, 69354.0, 70676.58646827137, 11266.436678165896, 11823.11326650522, 12029.338386388832, 12042.458089385824, 12258.87741122613, 12515.12394132402, 12594.433250503933, 12610.243385396905, 12917.418716157608, 13209.207447553177, 11934.880651193376, 12094.697632558904, 12504.624491306131, 12595.811062834247, 12610.684732881384, 11771.52913883435, 11896.345700986183, 12196.695082622651, 12250.264984100982, 12387.75224495523, 10688.25182237236, 11255.7748845021, 11938.403079846146, 12331.445084971378, 12477.93761031189, 10097.747556311151, 10406.687799366031, 10493.685189444328, 10595.258331917, 10674.519646615765, 9788.902110979085, 9876.506174691092, 9877.753056173653, 9893.208543316374, 9919.752006199902], "value": 7457.8633121433695, "unit": "score"}], "name": "dromaeo_css", "value": 7289.262811341084, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 115.0, 165.0, 170.0, 113.0, 112.0, 113.0, 113.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 110.0, 143.0, 111.0, 109.0, 111.0, 121.0, 131.0, 110.0], "value": 120.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 188.0, 184.0, 186.0, 184.0, 184.0, 180.0, 185.0, 185.0, 184.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 89.0, 62.0, 81.0, 82.0, 62.0, 74.0, 60.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 86.0, 71.0, 69.0, 70.0, 83.0, 68.0, 69.0, 85.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 86.0, 88.0, 83.0, 88.0, 83.0, 87.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 95.0, 94.0, 92.0, 94.0, 94.0, 94.0, 93.0, 103.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 87.0, 85.0, 87.0, 86.0, 85.0, 87.0, 86.0, 87.0, 103.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 54.0, 54.0, 56.0, 56.0, 55.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 83.0, 75.0, 78.0, 71.0, 74.0, 75.0, 72.0, 72.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 89.0, 89.0, 88.0, 86.0, 90.0, 88.0, 88.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 146.0, 126.0, 150.0, 149.0, 153.0, 147.0, 187.0, 138.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 172.0, 173.0, 188.0, 236.0, 192.0, 172.0, 175.0, 191.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 67.0, 66.0, 69.0, 67.0, 66.0, 65.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1466.3, "alertThreshold": 2.0}]} 10:14:02 INFO - Return code: 0 10:14:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:14:02 ERROR - # TBPL SUCCESS # 10:14:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:14:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:14:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:14:02 INFO - 2017-01-22 10:14:02.627 screenresolution[2260:19872] starting screenresolution argv=screenresolution get 10:14:02 INFO - 2017-01-22 10:14:02.630 screenresolution[2260:19872] Display 0: 1600x1200x32@60 10:14:02 INFO - 2017-01-22 10:14:02.636 screenresolution[2261:19875] starting screenresolution argv=screenresolution list 10:14:02 INFO - Available Modes on Display 0 10:14:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:14:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:14:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:14:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:14:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:14:02 INFO - Intel Iris: 10:14:02 INFO - Chipset Model: Intel Iris 10:14:02 INFO - Type: GPU 10:14:02 INFO - Bus: Built-In 10:14:02 INFO - VRAM (Dynamic, Max): 1536 MB 10:14:02 INFO - Vendor: Intel (0x8086) 10:14:02 INFO - Device ID: 0x0a2e 10:14:02 INFO - Revision ID: 0x0009 10:14:02 INFO - Displays: 10:14:02 INFO - Display: 10:14:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:14:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:14:02 INFO - Display Serial Number: 1600x1200 60 10:14:02 INFO - Main Display: Yes 10:14:02 INFO - Mirror: Off 10:14:02 INFO - Online: Yes 10:14:02 INFO - Rotation: Supported 10:14:02 INFO - Return code: 0 10:14:02 INFO - Running post-action listener: _resource_record_post_action 10:14:02 INFO - [mozharness: 2017-01-22 18:14:02.873528Z] Finished run-tests step (success) 10:14:02 INFO - Running post-run listener: _resource_record_post_run 10:14:02 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 8192; Write bytes: 554735104; Read time: 1; Write time: 1664 10:14:02 INFO - TinderboxPrint: CPU usage
53.6% 10:14:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 1 10:14:02 INFO - TinderboxPrint: I/O write bytes / time
554,735,104 / 1,664 10:14:02 INFO - TinderboxPrint: CPU idle
2,229.5 (46.4%) 10:14:02 INFO - TinderboxPrint: CPU system
959.2 (19.9%) 10:14:02 INFO - TinderboxPrint: CPU user
1,621.1 (33.7%) 10:14:02 INFO - TinderboxPrint: Swap in / out
250,392,576 / 0 10:14:02 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247034368; Write bytes: 242755584; Read time: 17832; Write time: 517 10:14:02 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 8192; Write bytes: 298372608; Read time: 1; Write time: 1102 10:14:03 INFO - Running post-run listener: _upload_blobber_files 10:14:03 INFO - Blob upload gear active. 10:14:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:14:03 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 10:14:03 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'] 10:14:03 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 10:14:03 INFO - (blobuploader) - INFO - Open directory for files ... 10:14:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:14:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:14:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:04 INFO - (blobuploader) - INFO - Done attempting. 10:14:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:14:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:14:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:05 INFO - (blobuploader) - INFO - Done attempting. 10:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:06 INFO - (blobuploader) - INFO - Done attempting. 10:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:09 INFO - (blobuploader) - INFO - Done attempting. 10:14:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:14:09 INFO - Return code: 0 10:14:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:14:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:14:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/603cbe64873ae952fbc66f9126b514ece28df26b3ae6fc2e129e9c08376536f89bf7d623760dd8996ee6eed4c6d954abcc71c50d9bfe3113d185cc2b908f277e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655ad411aabe3996cfc2065d343626208a1c562517c5a4e7db275e91be81c446911501fee38f061fe10ac170dfac87b929e92e09fc009a4df3e5b874d02ca629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596f2b2fae70aa91efa5b21f56c19d0693f73fb593dc669bee4b1922b6d476d91e952496a20a2bfd9c985c45413b4b1bc377d036e0c012a1f7797a1dd57165f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65c31da959f7307238a2ea06c66ea5839798ab90795b905d689b2e17249112999498ce45c5a65a039d9b88b94741aa4b6f0ada4dca9e92e2485eba12ec59cc97"} 10:14:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:14:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:14:09 INFO - Contents: 10:14:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/603cbe64873ae952fbc66f9126b514ece28df26b3ae6fc2e129e9c08376536f89bf7d623760dd8996ee6eed4c6d954abcc71c50d9bfe3113d185cc2b908f277e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655ad411aabe3996cfc2065d343626208a1c562517c5a4e7db275e91be81c446911501fee38f061fe10ac170dfac87b929e92e09fc009a4df3e5b874d02ca629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596f2b2fae70aa91efa5b21f56c19d0693f73fb593dc669bee4b1922b6d476d91e952496a20a2bfd9c985c45413b4b1bc377d036e0c012a1f7797a1dd57165f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65c31da959f7307238a2ea06c66ea5839798ab90795b905d689b2e17249112999498ce45c5a65a039d9b88b94741aa4b6f0ada4dca9e92e2485eba12ec59cc97"} 10:14:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:14:09 INFO - Copying logs to upload dir... 10:14:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:14:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.288644 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-22 10:14:09.076499) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 10:14:09.083522) ========= 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.GnD9et1G15/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.CgVZIFR1zW/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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/603cbe64873ae952fbc66f9126b514ece28df26b3ae6fc2e129e9c08376536f89bf7d623760dd8996ee6eed4c6d954abcc71c50d9bfe3113d185cc2b908f277e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655ad411aabe3996cfc2065d343626208a1c562517c5a4e7db275e91be81c446911501fee38f061fe10ac170dfac87b929e92e09fc009a4df3e5b874d02ca629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596f2b2fae70aa91efa5b21f56c19d0693f73fb593dc669bee4b1922b6d476d91e952496a20a2bfd9c985c45413b4b1bc377d036e0c012a1f7797a1dd57165f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65c31da959f7307238a2ea06c66ea5839798ab90795b905d689b2e17249112999498ce45c5a65a039d9b88b94741aa4b6f0ada4dca9e92e2485eba12ec59cc97"} build_url:https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010934 build_url: 'https://queue.taskcluster.net/v1/task/J9xsUC-hR4qmdiNfwTs7Tw/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/603cbe64873ae952fbc66f9126b514ece28df26b3ae6fc2e129e9c08376536f89bf7d623760dd8996ee6eed4c6d954abcc71c50d9bfe3113d185cc2b908f277e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655ad411aabe3996cfc2065d343626208a1c562517c5a4e7db275e91be81c446911501fee38f061fe10ac170dfac87b929e92e09fc009a4df3e5b874d02ca629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596f2b2fae70aa91efa5b21f56c19d0693f73fb593dc669bee4b1922b6d476d91e952496a20a2bfd9c985c45413b4b1bc377d036e0c012a1f7797a1dd57165f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65c31da959f7307238a2ea06c66ea5839798ab90795b905d689b2e17249112999498ce45c5a65a039d9b88b94741aa4b6f0ada4dca9e92e2485eba12ec59cc97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 10:14:09.117931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 10:14:09.118279) ========= 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.GnD9et1G15/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.CgVZIFR1zW/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005229 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 10:14:09.167448) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 10:14:09.167764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 10:14:09.168105) ========= ========= Total master_lag: 0.19 =========