builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1488466915.0 results: success (0) buildid: 20170302050023 builduid: 9534839ad28f49be9aad60f06d9ef3ee revision: 180a160ae22a4d63867cfd02608e7621e8e697d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:54.998347) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:54.998782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:54.999064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:55.024627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:55.025028) ========= 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.XVdvW2a4qp/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.a7AMydosqj/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-03-02 07:01:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.76M=0.001s 2017-03-02 07:01:55 (7.76 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:55.180515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:55.180855) ========= 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.XVdvW2a4qp/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.a7AMydosqj/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.022175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:55.229659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 07:01:55.230043) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 180a160ae22a4d63867cfd02608e7621e8e697d1 --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 180a160ae22a4d63867cfd02608e7621e8e697d1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XVdvW2a4qp/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.a7AMydosqj/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-03-02 07:01:55,313 truncating revision to first 12 chars 2017-03-02 07:01:55,313 Setting DEBUG logging. 2017-03-02 07:01:55,313 attempt 1/10 2017-03-02 07:01:55,313 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/180a160ae22a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 07:01:57,085 unpacking tar archive at: mozilla-central-180a160ae22a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.023239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 07:01:57.276386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:57.276719) ========= script_repo_revision: 180a160ae22a4d63867cfd02608e7621e8e697d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:57.277112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:57.277376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 07:01:57.297729) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-02 07:01:57.298129) ========= /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.XVdvW2a4qp/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.a7AMydosqj/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:01:57 INFO - MultiFileLogger online at 20170302 07:01:57 in /builds/slave/test 07:01:57 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 07:01:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:01:57 INFO - {'append_to_log': False, 07:01:57 INFO - 'base_work_dir': '/builds/slave/test', 07:01:57 INFO - 'blob_upload_branch': 'Firefox', 07:01:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:01:57 INFO - 'branch': 'Firefox', 07:01:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:01:57 INFO - 'config_files': ('talos/mac_config.py',), 07:01:57 INFO - 'default_actions': ('clobber', 07:01:57 INFO - 'read-buildbot-config', 07:01:57 INFO - 'download-and-extract', 07:01:57 INFO - 'populate-webroot', 07:01:57 INFO - 'create-virtualenv', 07:01:57 INFO - 'install', 07:01:57 INFO - 'run-tests'), 07:01:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:01:57 INFO - 'download_minidump_stackwalk': True, 07:01:57 INFO - 'download_symbols': 'ondemand', 07:01:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:01:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:01:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:01:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:01:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:01:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:01:57 INFO - 'gecko_profile': False, 07:01:57 INFO - 'gecko_profile_interval': 0, 07:01:57 INFO - 'installer_path': 'installer.exe', 07:01:57 INFO - 'log_level': 'info', 07:01:57 INFO - 'log_name': 'talos', 07:01:57 INFO - 'log_to_console': True, 07:01:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:01:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:01:57 INFO - 'opt_config_files': (), 07:01:57 INFO - 'pip_index': False, 07:01:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:01:57 INFO - 'cmd': ('bash', 07:01:57 INFO - '-c', 07:01:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:01:57 INFO - 'enabled': True, 07:01:57 INFO - 'halt_on_failure': False, 07:01:57 INFO - 'name': 'check_screen_resolution'},), 07:01:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:01:57 INFO - 'cmd': ('bash', 07:01:57 INFO - '-c', 07:01:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:01:57 INFO - 'enabled': True, 07:01:57 INFO - 'halt_on_failure': False, 07:01:57 INFO - 'name': 'check_screen_resolution'},), 07:01:57 INFO - 'run_cmd_checks_enabled': True, 07:01:57 INFO - 'suite': 'dromaeojs', 07:01:57 INFO - 'system_bits': '32', 07:01:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:01:57 INFO - 'title': 't-yosemite-r7-0192', 07:01:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:01:57 INFO - 'use_talos_json': True, 07:01:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:01:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:01:57 INFO - 'work_dir': 'build'} 07:01:57 INFO - [mozharness: 2017-03-02 15:01:57.505045Z] Running clobber step. 07:01:57 INFO - Running pre-action listener: _resource_record_pre_action 07:01:57 INFO - Running main action method: clobber 07:01:57 INFO - rmtree: /builds/slave/test/build 07:01:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:01:59 INFO - Running post-action listener: _resource_record_post_action 07:01:59 INFO - [mozharness: 2017-03-02 15:01:59.138011Z] Finished clobber step (success) 07:01:59 INFO - [mozharness: 2017-03-02 15:01:59.138139Z] Running read-buildbot-config step. 07:01:59 INFO - Running pre-action listener: _resource_record_pre_action 07:01:59 INFO - Running main action method: read_buildbot_config 07:01:59 INFO - Using buildbot properties: 07:01:59 INFO - { 07:01:59 INFO - "project": "", 07:01:59 INFO - "product": "firefox", 07:01:59 INFO - "script_repo_revision": "production", 07:01:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:01:59 INFO - "repository": "", 07:01:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:01:59 INFO - "buildid": "20170302050023", 07:01:59 INFO - "pgo_build": "False", 07:01:59 INFO - "basedir": "/builds/slave/test", 07:01:59 INFO - "buildnumber": 1, 07:01:59 INFO - "slavename": "t-yosemite-r7-0192", 07:01:59 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:01:59 INFO - "platform": "yosemite_r7", 07:01:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:01:59 INFO - "branch": "mozilla-central", 07:01:59 INFO - "repo_path": "mozilla-central", 07:01:59 INFO - "revision": "180a160ae22a4d63867cfd02608e7621e8e697d1", 07:01:59 INFO - "stage_platform": "macosx64", 07:01:59 INFO - "builduid": "9534839ad28f49be9aad60f06d9ef3ee", 07:01:59 INFO - "slavebuilddir": "test" 07:01:59 INFO - } 07:01:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 07:01:59 INFO - Running post-action listener: _resource_record_post_action 07:01:59 INFO - [mozharness: 2017-03-02 15:01:59.141438Z] Finished read-buildbot-config step (success) 07:01:59 INFO - [mozharness: 2017-03-02 15:01:59.141540Z] Running download-and-extract step. 07:01:59 INFO - Running pre-action listener: _resource_record_pre_action 07:01:59 INFO - Running main action method: download_and_extract 07:01:59 INFO - mkdir: /builds/slave/test/build/tests 07:01: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')]} 07:01:59 INFO - trying https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 07:01:59 INFO - Downloading https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 07:02:00 INFO - Downloaded 1199 bytes. 07:02:00 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:02:00 INFO - Using the following test package requirements: 07:02:00 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:02:00 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:02:00 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:02:00 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'jsshell-mac.zip'], 07:02:00 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:02:00 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:02:00 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:02:00 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:02:00 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:02:00 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:02:00 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:02:00 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:02:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:02:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:02:00 INFO - Fetch https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:02:02 INFO - Expected file size: 51767218 07:02:02 INFO - Obtained file size: 51767218 07:02:18 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:02:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:02:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:02:18 INFO - Fetch https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:02:19 INFO - Expected file size: 51767218 07:02:19 INFO - Obtained file size: 51767218 07:02:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 07:02:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:02:34 INFO - Fetch https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 07:02:36 INFO - Expected file size: 14404424 07:02:36 INFO - Obtained file size: 14404424 07:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:36 INFO - trying https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:02:36 INFO - Downloading https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 07:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 07:02:39 INFO - Downloaded 75029822 bytes. 07:02:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:02:39 INFO - mkdir: /builds/slave/test/properties 07:02:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:02:39 INFO - Writing to file /builds/slave/test/properties/build_url 07:02:39 INFO - Contents: 07:02:39 INFO - build_url:https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:02:39 INFO - Running post-action listener: _resource_record_post_action 07:02:39 INFO - Running post-action listener: set_extra_try_arguments 07:02:39 INFO - [mozharness: 2017-03-02 15:02:39.927795Z] Finished download-and-extract step (success) 07:02:39 INFO - [mozharness: 2017-03-02 15:02:39.927919Z] Running populate-webroot step. 07:02:39 INFO - Running pre-action listener: _resource_record_pre_action 07:02:39 INFO - Running main action method: populate_webroot 07:02:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:02:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:02:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:02:39 INFO - '--tppagecycles', 07:02:39 INFO - '7'], 07:02:39 INFO - 'tests': ['tsvgm']}}, 07:02:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:02:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:02:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:02:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:02:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['damp', 'tps']}, 07:02:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'tests': ['damp', 'tps']}, 07:02:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['dromaeo_dom']}, 07:02:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:02:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['basic_compositor_video']}, 07:02:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:02:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore', 07:02:39 INFO - 'tabpaint']}, 07:02:39 INFO - 'other-e10s': {'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore', 07:02:39 INFO - 'tabpaint']}, 07:02:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore', 07:02:39 INFO - 'tabpaint']}, 07:02:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore', 07:02:39 INFO - 'tabpaint']}, 07:02:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore', 07:02:39 INFO - 'tabpaint']}, 07:02:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore', 07:02:39 INFO - 'tabpaint']}, 07:02:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['tsvgx', 07:02:39 INFO - 'tsvgr_opacity', 07:02:39 INFO - 'tart', 07:02:39 INFO - 'tscrollx', 07:02:39 INFO - 'cart', 07:02:39 INFO - 'tsvg_static']}, 07:02:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:02:39 INFO - 'tsvgr_opacity', 07:02:39 INFO - 'tart', 07:02:39 INFO - 'tscrollx', 07:02:39 INFO - 'cart', 07:02:39 INFO - 'tsvg_static']}, 07:02:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'talos_options': ['--disable-e10s'], 07:02:39 INFO - 'tests': ['tp5o']}, 07:02:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:02:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'talos_options': ['--disable-e10s', 07:02:39 INFO - '--xperf_path', 07:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:39 INFO - 'tests': ['tp5n']}, 07:02:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'talos_options': ['--xperf_path', 07:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:39 INFO - 'tests': ['tp5n']}}, 07:02:39 INFO - 'talos.zip': {'path': '', 07:02:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:02:39 INFO - Running post-action listener: _resource_record_post_action 07:02:39 INFO - [mozharness: 2017-03-02 15:02:39.946319Z] Finished populate-webroot step (success) 07:02:39 INFO - [mozharness: 2017-03-02 15:02:39.946449Z] Running create-virtualenv step. 07:02:39 INFO - Running pre-action listener: _resource_record_pre_action 07:02:39 INFO - Running main action method: create_virtualenv 07:02:39 INFO - Creating virtualenv /builds/slave/test/build/venv 07:02:39 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 07:02:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:02:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:02:40 INFO - Using real prefix '/tools/python27' 07:02:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:02:40 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:43 INFO - Installing pip.................done. 07:02:43 INFO - Return code: 0 07:02:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:02:43 INFO - Reading from file tmpfile_stdout 07:02:43 INFO - Output received: 07:02:43 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) 07:02:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:02:43 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')]} 07:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:43 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')]} 07:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:43 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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:02:43 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 07:02:43 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 07:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:02:43 INFO - 'HOME': '/Users/cltbld', 07:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:02:43 INFO - 'LOGNAME': 'cltbld', 07:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:43 INFO - 'MOZ_NO_REMOTE': '1', 07:02:43 INFO - 'NO_EM_RESTART': '1', 07:02:43 INFO - 'PAGER': '/bin/cat', 07:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:43 INFO - 'PWD': '/builds/slave/test', 07:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:02:43 INFO - 'SHELL': '/bin/bash', 07:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:02:43 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:02:43 INFO - 'USER': 'cltbld', 07:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:43 INFO - 'XPC_FLAGS': '0x0', 07:02:43 INFO - 'XPC_SERVICE_NAME': '0', 07:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:44 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 07:02:44 INFO - Cleaning up... 07:02:44 INFO - Return code: 0 07:02:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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', '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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:02: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 psutil>=3.1.1 07:02:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:02:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:02:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:02:44 INFO - 'HOME': '/Users/cltbld', 07:02:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:02:44 INFO - 'LOGNAME': 'cltbld', 07:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:44 INFO - 'MOZ_NO_REMOTE': '1', 07:02:44 INFO - 'NO_EM_RESTART': '1', 07:02:44 INFO - 'PAGER': '/bin/cat', 07:02:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:44 INFO - 'PWD': '/builds/slave/test', 07:02:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:02:44 INFO - 'SHELL': '/bin/bash', 07:02:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:02:44 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:02:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:02:44 INFO - 'USER': 'cltbld', 07:02:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:02:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:44 INFO - 'XPC_FLAGS': '0x0', 07:02:44 INFO - 'XPC_SERVICE_NAME': '0', 07:02:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:44 INFO - Downloading/unpacking psutil>=3.1.1 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:48 INFO - Installing collected packages: psutil 07:02:48 INFO - Running setup.py install for psutil 07:02:48 INFO - building 'psutil._psutil_osx' extension 07:02:48 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 07:02:48 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 07:02:48 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 07:02:48 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 07:02:48 INFO - building 'psutil._psutil_posix' extension 07:02:48 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 07:02:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:02:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:02:48 INFO - ^ 07:02:48 INFO - 1 warning generated. 07:02:48 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 07:02:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:48 INFO - Successfully installed psutil 07:02:48 INFO - Cleaning up... 07:02:49 INFO - Return code: 0 07:02:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:02:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:02:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:02:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:02:49 INFO - 'HOME': '/Users/cltbld', 07:02:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:02:49 INFO - 'LOGNAME': 'cltbld', 07:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:49 INFO - 'MOZ_NO_REMOTE': '1', 07:02:49 INFO - 'NO_EM_RESTART': '1', 07:02:49 INFO - 'PAGER': '/bin/cat', 07:02:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:49 INFO - 'PWD': '/builds/slave/test', 07:02:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:02:49 INFO - 'SHELL': '/bin/bash', 07:02:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:02:49 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:02:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:02:49 INFO - 'USER': 'cltbld', 07:02:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:02:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:49 INFO - 'XPC_FLAGS': '0x0', 07:02:49 INFO - 'XPC_SERVICE_NAME': '0', 07:02:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:02:50 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 07:02:50 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 07:02:50 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 07:02:50 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 07:02:50 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 07:02:50 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 07:02:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:02:53 INFO - Installing collected packages: mozsystemmonitor 07:02:53 INFO - Running setup.py install for mozsystemmonitor 07:02:53 INFO - Successfully installed mozsystemmonitor 07:02:53 INFO - Cleaning up... 07:02:53 INFO - Return code: 0 07:02:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:02:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:02:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:02:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:02:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:02:53 INFO - 'HOME': '/Users/cltbld', 07:02:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:02:53 INFO - 'LOGNAME': 'cltbld', 07:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:53 INFO - 'MOZ_NO_REMOTE': '1', 07:02:53 INFO - 'NO_EM_RESTART': '1', 07:02:53 INFO - 'PAGER': '/bin/cat', 07:02:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:53 INFO - 'PWD': '/builds/slave/test', 07:02:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:02:53 INFO - 'SHELL': '/bin/bash', 07:02:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:02:53 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:02:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:02:53 INFO - 'USER': 'cltbld', 07:02:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:02:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:53 INFO - 'XPC_FLAGS': '0x0', 07:02:53 INFO - 'XPC_SERVICE_NAME': '0', 07:02:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:53 INFO - Downloading/unpacking jsonschema==2.5.1 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:02:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02:56 INFO - Downloading functools32-3.2.3-2.tar.gz 07:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:02:56 INFO - warning: no files found matching '*.txt' 07:02:56 INFO - no previously-included directories found matching 'build' 07:02:56 INFO - no previously-included directories found matching 'dist' 07:02:56 INFO - no previously-included directories found matching '.git*' 07:02:56 INFO - Installing collected packages: jsonschema, functools32 07:02:56 INFO - Running setup.py install for functools32 07:02:56 INFO - warning: no files found matching '*.txt' 07:02:56 INFO - no previously-included directories found matching 'build' 07:02:56 INFO - no previously-included directories found matching 'dist' 07:02:56 INFO - no previously-included directories found matching '.git*' 07:02:56 INFO - Successfully installed jsonschema functools32 07:02:56 INFO - Cleaning up... 07:02:57 INFO - Return code: 0 07:02:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:57 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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:02:57 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 07:02:57 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 07:02:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:02:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:02:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:02:57 INFO - 'HOME': '/Users/cltbld', 07:02:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:02:57 INFO - 'LOGNAME': 'cltbld', 07:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:57 INFO - 'MOZ_NO_REMOTE': '1', 07:02:57 INFO - 'NO_EM_RESTART': '1', 07:02:57 INFO - 'PAGER': '/bin/cat', 07:02:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:57 INFO - 'PWD': '/builds/slave/test', 07:02:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:02:57 INFO - 'SHELL': '/bin/bash', 07:02:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:02:57 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:02:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:02:57 INFO - 'USER': 'cltbld', 07:02:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:02:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:57 INFO - 'XPC_FLAGS': '0x0', 07:02:57 INFO - 'XPC_SERVICE_NAME': '0', 07:02:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:02:57 INFO - Cleaning up... 07:02:57 INFO - Return code: 0 07:02:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:57 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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:02:57 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 07:02:57 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 07:02:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:02:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:02:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:02:57 INFO - 'HOME': '/Users/cltbld', 07:02:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:02:57 INFO - 'LOGNAME': 'cltbld', 07:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:57 INFO - 'MOZ_NO_REMOTE': '1', 07:02:57 INFO - 'NO_EM_RESTART': '1', 07:02:57 INFO - 'PAGER': '/bin/cat', 07:02:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:57 INFO - 'PWD': '/builds/slave/test', 07:02:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:02:57 INFO - 'SHELL': '/bin/bash', 07:02:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:02:57 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:02:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:02:57 INFO - 'USER': 'cltbld', 07:02:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:02:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:57 INFO - 'XPC_FLAGS': '0x0', 07:02:57 INFO - 'XPC_SERVICE_NAME': '0', 07:02:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:57 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:57 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 07:02:57 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 07:02:57 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 07:02:57 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 07:02:57 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 07:02:57 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 07:03:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:03:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:03:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:01 INFO - Downloading docopt-0.6.1.tar.gz 07:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:03:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:03:01 INFO - Running setup.py install for blobuploader 07:03:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:03:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:03:01 INFO - Running setup.py install for requests 07:03:02 INFO - Running setup.py install for docopt 07:03:02 INFO - Successfully installed blobuploader requests docopt 07:03:02 INFO - Cleaning up... 07:03:02 INFO - Return code: 0 07:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:02 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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:03:02 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 07:03:02 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 07:03:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:03:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:03:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:03:02 INFO - 'HOME': '/Users/cltbld', 07:03:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:03:02 INFO - 'LOGNAME': 'cltbld', 07:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:02 INFO - 'MOZ_NO_REMOTE': '1', 07:03:02 INFO - 'NO_EM_RESTART': '1', 07:03:02 INFO - 'PAGER': '/bin/cat', 07:03:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:02 INFO - 'PWD': '/builds/slave/test', 07:03:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:03:02 INFO - 'SHELL': '/bin/bash', 07:03:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:03:02 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:03:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:03:02 INFO - 'USER': 'cltbld', 07:03:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:03:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:02 INFO - 'XPC_FLAGS': '0x0', 07:03:02 INFO - 'XPC_SERVICE_NAME': '0', 07:03:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-8EgiRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-vjDgjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9i4Nm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-AG8YPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-E7t3R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-6g_pKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-26KwpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-onk1nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-NKZplF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-kSoJkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-rEtc_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-AGuDjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-5rqWNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-fuMP0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-dLzveU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-74CgWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-TyVn8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:03:04 INFO - Running setup.py install for manifestparser 07:03:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:03:04 INFO - Running setup.py install for mozcrash 07:03:04 INFO - Running setup.py install for mozdebug 07:03:04 INFO - Running setup.py install for mozdevice 07:03:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Running setup.py install for mozfile 07:03:05 INFO - Running setup.py install for mozhttpd 07:03:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Running setup.py install for mozinfo 07:03:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Running setup.py install for mozInstall 07:03:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Running setup.py install for mozleak 07:03:05 INFO - Running setup.py install for mozlog 07:03:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:03:05 INFO - Running setup.py install for moznetwork 07:03:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:03:06 INFO - Running setup.py install for mozprocess 07:03:06 INFO - Running setup.py install for mozprofile 07:03:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:03:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:03:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:03:06 INFO - Running setup.py install for mozrunner 07:03:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:03:06 INFO - Running setup.py install for mozscreenshot 07:03:06 INFO - Running setup.py install for moztest 07:03:06 INFO - Running setup.py install for mozversion 07:03:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:03:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:03:07 INFO - Cleaning up... 07:03:07 INFO - Return code: 0 07:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03: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')]} 07:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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')]} 07:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:07 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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:03:07 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 07:03:07 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 07:03:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:03:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:03:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:03:07 INFO - 'HOME': '/Users/cltbld', 07:03:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:03:07 INFO - 'LOGNAME': 'cltbld', 07:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:07 INFO - 'MOZ_NO_REMOTE': '1', 07:03:07 INFO - 'NO_EM_RESTART': '1', 07:03:07 INFO - 'PAGER': '/bin/cat', 07:03:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:07 INFO - 'PWD': '/builds/slave/test', 07:03:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:03:07 INFO - 'SHELL': '/bin/bash', 07:03:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:03:07 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:03:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:03:07 INFO - 'USER': 'cltbld', 07:03:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:03:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:07 INFO - 'XPC_FLAGS': '0x0', 07:03:07 INFO - 'XPC_SERVICE_NAME': '0', 07:03:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-pR0v5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:07 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)) 07:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-CAN3DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:07 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)) 07:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-iG5rrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:07 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)) 07:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zDeKJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:07 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)) 07:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-872C5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:07 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)) 07:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-tbdF6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:07 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)) 07:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HWb7eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-LmJYPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-uy7sZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-W25HTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-DVCVPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3W1vJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-cHMSmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-qaSDTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-O6trZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:08 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)) 07:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3hQjio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:09 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)) 07:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:09 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ONvvAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:09 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)) 07:03:09 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)) 07:03:09 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)) 07:03:09 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)) 07:03:09 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)) 07:03:09 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)) 07:03:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:09 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 07:03:09 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 07:03:09 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 07:03:09 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 07:03:09 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 07:03:09 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 07:03:11 INFO - Downloading blessings-1.6.tar.gz 07:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:03:11 INFO - Installing collected packages: blessings 07:03:11 INFO - Running setup.py install for blessings 07:03:12 INFO - Successfully installed blessings 07:03:12 INFO - Cleaning up... 07:03:12 INFO - Return code: 0 07:03:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:12 INFO - Reading from file tmpfile_stdout 07:03:12 INFO - Current package versions: 07:03:12 INFO - blessings == 1.6 07:03:12 INFO - blobuploader == 1.2.4 07:03:12 INFO - docopt == 0.6.1 07:03:12 INFO - functools32 == 3.2.3-2 07:03:12 INFO - jsonschema == 2.5.1 07:03:12 INFO - manifestparser == 1.1 07:03:12 INFO - mozInstall == 1.12 07:03:12 INFO - mozcrash == 1.0 07:03:12 INFO - mozdebug == 0.1 07:03:12 INFO - mozdevice == 0.49 07:03:12 INFO - mozfile == 1.2 07:03:12 INFO - mozhttpd == 0.7 07:03:12 INFO - mozinfo == 0.9 07:03:12 INFO - mozleak == 0.1 07:03:12 INFO - mozlog == 3.4 07:03:12 INFO - moznetwork == 0.27 07:03:12 INFO - mozprocess == 0.25 07:03:12 INFO - mozprofile == 0.28 07:03:12 INFO - mozrunner == 6.13 07:03:12 INFO - mozscreenshot == 0.1 07:03:12 INFO - mozsystemmonitor == 0.3 07:03:12 INFO - moztest == 0.8 07:03:12 INFO - mozversion == 1.4 07:03:12 INFO - psutil == 3.1.1 07:03:12 INFO - requests == 1.2.3 07:03:12 INFO - wsgiref == 0.1.2 07:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:12 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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:03:12 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 07:03:12 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 07:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:03:12 INFO - 'HOME': '/Users/cltbld', 07:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:03:12 INFO - 'LOGNAME': 'cltbld', 07:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:12 INFO - 'MOZ_NO_REMOTE': '1', 07:03:12 INFO - 'NO_EM_RESTART': '1', 07:03:12 INFO - 'PAGER': '/bin/cat', 07:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:12 INFO - 'PWD': '/builds/slave/test', 07:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:03:12 INFO - 'SHELL': '/bin/bash', 07:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:03:12 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:03:12 INFO - 'USER': 'cltbld', 07:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:12 INFO - 'XPC_FLAGS': '0x0', 07:03:12 INFO - 'XPC_SERVICE_NAME': '0', 07:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 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)) 07:03:12 INFO - Cleaning up... 07:03:12 INFO - Return code: 0 07:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:12 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 0x104e29b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81591b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, '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.XVdvW2a4qp/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.a7AMydosqj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 07:03:12 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 07:03:12 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 07:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:03:12 INFO - 'HOME': '/Users/cltbld', 07:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:03:12 INFO - 'LOGNAME': 'cltbld', 07:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:12 INFO - 'MOZ_NO_REMOTE': '1', 07:03:12 INFO - 'NO_EM_RESTART': '1', 07:03:12 INFO - 'PAGER': '/bin/cat', 07:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:12 INFO - 'PWD': '/builds/slave/test', 07:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:03:12 INFO - 'SHELL': '/bin/bash', 07:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:03:12 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:03:12 INFO - 'USER': 'cltbld', 07:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:12 INFO - 'XPC_FLAGS': '0x0', 07:03:12 INFO - 'XPC_SERVICE_NAME': '0', 07:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:03:12 INFO - Cleaning up... 07:03:12 INFO - Return code: 0 07:03:12 INFO - Running post-action listener: _resource_record_post_action 07:03:12 INFO - Running post-action listener: _start_resource_monitoring 07:03:12 INFO - Starting resource monitoring. 07:03:12 INFO - [mozharness: 2017-03-02 15:03:12.968641Z] Finished create-virtualenv step (success) 07:03:12 INFO - [mozharness: 2017-03-02 15:03:12.969719Z] Running install step. 07:03:12 INFO - Running pre-action listener: _resource_record_pre_action 07:03:12 INFO - Running main action method: install 07:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:13 INFO - Reading from file tmpfile_stdout 07:03:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:03:13 INFO - Reading from file tmpfile_stdout 07:03:13 INFO - Output received: 07:03:13 INFO - Usage: mozinstall [options] installer 07:03:13 INFO - Options: 07:03:13 INFO - -h, --help show this help message and exit 07:03:13 INFO - -d DEST, --destination=DEST 07:03:13 INFO - Directory to install application into. [default: 07:03:13 INFO - "/builds/slave/test"] 07:03:13 INFO - --app=APP Application being installed. [default: firefox] 07:03:13 INFO - mkdir: /builds/slave/test/build/application 07:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:03:33 INFO - Reading from file tmpfile_stdout 07:03:33 INFO - Output received: 07:03:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:03:33 INFO - Running post-action listener: _resource_record_post_action 07:03:33 INFO - [mozharness: 2017-03-02 15:03:33.635973Z] Finished install step (success) 07:03:33 INFO - [mozharness: 2017-03-02 15:03:33.636101Z] Running run-tests step. 07:03:33 INFO - Running pre-action listener: _resource_record_pre_action 07:03:33 INFO - Running main action method: run_tests 07:03:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:03:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:03:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:03:33 INFO - 2017-03-02 07:03:33.650 screenresolution[1908:21026] starting screenresolution argv=screenresolution get 07:03:33 INFO - 2017-03-02 07:03:33.653 screenresolution[1908:21026] Display 0: 1600x1200x32@60 07:03:33 INFO - 2017-03-02 07:03:33.659 screenresolution[1909:21028] starting screenresolution argv=screenresolution list 07:03:33 INFO - Available Modes on Display 0 07:03:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:03:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:03:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:03:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:03:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:03:33 INFO - Intel Iris: 07:03:33 INFO - Chipset Model: Intel Iris 07:03:33 INFO - Type: GPU 07:03:33 INFO - Bus: Built-In 07:03:33 INFO - VRAM (Dynamic, Max): 1536 MB 07:03:33 INFO - Vendor: Intel (0x8086) 07:03:33 INFO - Device ID: 0x0a2e 07:03:33 INFO - Revision ID: 0x0009 07:03:33 INFO - Displays: 07:03:33 INFO - Display: 07:03:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:03:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:03:33 INFO - Display Serial Number: 1600x1200 60 07:03:33 INFO - Main Display: Yes 07:03:33 INFO - Mirror: Off 07:03:33 INFO - Online: Yes 07:03:33 INFO - Rotation: Supported 07:03:33 INFO - Return code: 0 07:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:03:33 INFO - Python 2.7.3 07:03:33 INFO - Return code: 0 07:03:33 INFO - grabbing minidump binary from tooltool 07:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:33 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 0x104c07d30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:03:33 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 07:03:33 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 07:03:33 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 07:03:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:03:34 INFO - Return code: 0 07:03:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:03:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:03:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:03:34 INFO - ENV: RUST_BACKTRACE is now 1 07:03:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:03:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:03:34 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/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 07:03:34 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/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --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 07:03:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVdvW2a4qp/Render', 07:03:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:03:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:03:34 INFO - 'HOME': '/Users/cltbld', 07:03:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:03:34 INFO - 'LOGNAME': 'cltbld', 07:03:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:03:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:34 INFO - 'MOZ_NO_REMOTE': '1', 07:03:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:03:34 INFO - 'NO_EM_RESTART': '1', 07:03:34 INFO - 'PAGER': '/bin/cat', 07:03:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:34 INFO - 'PWD': '/builds/slave/test', 07:03:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:03:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:03:34 INFO - 'RUST_BACKTRACE': '1', 07:03:34 INFO - 'SHELL': '/bin/bash', 07:03:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7AMydosqj/Listeners', 07:03:34 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 07:03:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:03:34 INFO - 'USER': 'cltbld', 07:03:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:03:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:34 INFO - 'XPC_FLAGS': '0x0', 07:03:34 INFO - 'XPC_SERVICE_NAME': '0', 07:03:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:03:34 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/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 07:03:34 INFO - mozversion application_buildid: 20170302050023 07:03:34 INFO - mozversion application_changeset: 180a160ae22a4d63867cfd02608e7621e8e697d1 07:03:34 INFO - mozversion application_display_name: Nightly 07:03:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:03:34 INFO - mozversion application_name: Firefox 07:03:34 INFO - mozversion application_remotingname: firefox 07:03:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:03:34 INFO - mozversion application_vendor: Mozilla 07:03:34 INFO - mozversion application_version: 54.0a1 07:03:34 INFO - mozversion platform_buildid: 20170302050023 07:03:34 INFO - mozversion platform_changeset: 180a160ae22a4d63867cfd02608e7621e8e697d1 07:03:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:03:34 INFO - mozversion platform_version: 54.0a1 07:03:34 INFO - using testdate: 1488467014 07:03:34 INFO - actual date: 1488467014 07:03:34 INFO - starting webserver on 'localhost:56447' 07:03:34 INFO - SUITE-START | Running 2 tests 07:03:34 INFO - TEST-START | dromaeo_css 07:03:34 INFO - operating with platform_type : mac_ 07:03:34 INFO - Initialising browser for dromaeo_css test... 07:03:34 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpxJ3AjC/profile http://localhost:56447/getInfo.html) 07:03:36 INFO - PROCESS | 1919 | __metrics Screen width/height:1600/1200 07:03:36 INFO - PROCESS | 1919 | colorDepth:24 07:03:36 INFO - PROCESS | 1919 | Browser inner width/height: 1024/689 07:03:36 INFO - PROCESS | 1919 | __metrics 07:03:36 INFO - PROCESS | 1919 | 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" 07:03:36 INFO - PROCESS | 1919 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:03:37 INFO - TEST-INFO | 1919: exit 0 07:03:37 INFO - Browser initialized. 07:03:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:03:37 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpxJ3AjC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:49 INFO - PROCESS | 1921 | RSS: Main: 232009728 07:03:49 INFO - PROCESS | 1921 | 07:06:52 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:56447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56447/tests/dromaeo/cssquery-ext.html) 07:06:56 INFO - PROCESS | 1921 | RSS: Main: 517656576 07:06:56 INFO - PROCESS | 1921 | 07:08:39 INFO - PROCESS | 1921 | ************************* 07:08:39 INFO - PROCESS | 1921 | A coding exception was thrown and uncaught in a Task. 07:08:39 INFO - PROCESS | 1921 | 07:08:39 ERROR - PROCESS | 1921 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:08:39 INFO - PROCESS | 1921 | Full stack: 07:08:39 INFO - PROCESS | 1921 | ************************* 07:09:59 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:56447/tests/dromaeo/cssquery-ext.html (next: http://localhost:56447/tests/dromaeo/cssquery-jquery.html) 07:10:00 INFO - PROCESS | 1921 | RSS: Main: 365023232 07:10:00 INFO - PROCESS | 1921 | 07:13:02 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:56447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56447/tests/dromaeo/cssquery-mootools.html) 07:13:03 INFO - PROCESS | 1921 | RSS: Main: 348979200 07:13:03 INFO - PROCESS | 1921 | 07:16:05 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:56447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56447/tests/dromaeo/cssquery-prototype.html) 07:16:06 INFO - PROCESS | 1921 | RSS: Main: 332726272 07:16:06 INFO - PROCESS | 1921 | 07:19:10 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:56447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56447/tests/dromaeo/cssquery-yui.html) 07:19:11 INFO - PROCESS | 1921 | RSS: Main: 337301504 07:19:11 INFO - PROCESS | 1921 | 07:22:14 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:56447/tests/dromaeo/cssquery-yui.html (next: http://localhost:56447/tests/dromaeo/cssquery-dojo.html) 07:22:15 INFO - PROCESS | 1921 | RSS: Main: 508571648 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | __start_tp_report 07:22:15 INFO - PROCESS | 1921 | _x_x_mozilla_page_load 07:22:15 INFO - PROCESS | 1921 | _x_x_mozilla_page_load_details 07:22:15 INFO - PROCESS | 1921 | |i|pagename|runs| 07:22:15 INFO - PROCESS | 1921 | |0;dojo.html;3307.1566750478623;3339.148517128132;3339.415602269604;3369.292448585797;3380.5436266104075;5678.914816277759;5732.197492351074;5811.418858114192;5897.882042359156;5921.970390148049;4919.655624106314;5737.909797138551;5787.623804452707;5863.970680146604;5873.706314684259;5178.766955487012;5211.140161873286;5243.606729495303;5280.630355875091;5284.682919024852;5332.3601167859915;5346.03771321162;5347.679139251638;5363.329583802025;5400.567954563645;5157;5189.351331083614;5207.739613019372;5253.763580638881;5319.9202011969855;5247.763850626731;5260.605454590921;5263.894722105575;5264.236685680555;5273.7626806793405;5169.1212493875755;5211.062008838408;5211.296474975868;5214.556762675177;5248.685078895241;5042.117629414838;5505.889882202374;5751.3961034091235;5751.683657398841;5760.164776107483;5208.713520756357;6252.968735156341;6278.4035516625845;6278.780242691484;6279.623222606612;6219.844503887393;6265.028920517281;6289.276733175698;6308.085327627514;6331.271903731038;5995.430434108753;6001.4298641628975;6016.458518733335;6034.849128771772;6044.214252147237;6308.179936608303;6375.904361434582;6389.041643753474;6395.488360931115;6401.679916004275;6092.025275955826;6115.755369785159;6115.938840611626;6128.533679014772;6301.180846489927;6289.96215624426;6299.968500157562;6300.558960872695;6301.275353334334;6321.1782468278825;6210.50315974721;6222.595531290452;6227.657478838617;6298.9921612541775;6299.307076221612;6343.682815859281;6358.205224346957;6367.204099487564;6374;6382.138411314413;4824.782884770194;4943.3573635427165;4948.455669876311;4951.455339912607;4973.651844370932;4337.501187363494;4346.978460061883;4426.203283409017;4435.711678740871;4513.097380523843;5739.512141468022;5744.942550574524;5746;5751.223584815996;5752.07966725322;6306.9684651576445;6309.085182648582;6323.52573556985;6333.018382150774;6341.778037768656;4256.87229383119;5662.207290979184;5736.942630573724;5773.711314434261;5813.76744930198;5476.315460567429;5484.862878427992;5490.917636235459;5491.093969494988;5505.834824955257;6447.0329450582785;6449.7097630605795;6455.451286640594;6456.451201647818;6481.09264702942;6225.564210505221;6287.056941458635;6302.401271879165;6338.461230795249;6368;6310.211223597051;6319.05214217871;6323.494120470444;6328.810135695937;6334.461570766536;5163.4578369272185;6213.751449941951;6225.750969961151;6234.937650623617;6290.21372328459;6312.968435157794;6323.747050118128;6335.3981371769605;6337.176167098248;6338.65137417428;6219.657918814328;6246.718897649525;6253.249610046823;6254.21822272216;6263.937360626335;5899.439553242435;6045.274567051982;6216.595921265103;6233.719482623203;6239.220097487814;5946;5948.702564871825;5956.642601443928;5959.880802383841;5963.86686529558;6117.510599152146;6119.602225855305;6126.08108783686;6126.448619624255;6131.816045518642;5930;5935.990881550233;5942.881142377042;5944.881102377842;5952.166696662384 07:22:15 INFO - PROCESS | 1921 | |1;ext.html;725.4305370284326;783.8314762326099;839.8152406470579;852.0882655558551;856.1139220906363;36761.81619091904;37411.62588374115;37523.624763752356;37712.811435942815;39124.71816304798;38080.61919380805;38316.61683383166;38345.84962451124;38473.61526384735;38478.42282365767;7219.458540609449;7405.851882962337;8882.467051976886;9025.819483610323;9040.41237319572;7266.2733726627175;7356.7057317707495;7359.411247100246;10649.893501064967;10907.29102608328;10807.67576972692;10875.945620271888;10889.128869690445;10902.400367979759;10924.945375273113;10767.946160269188;10819.080378167866;10840.295380800222;10841;10855.565777368896;7117.2882711728935;7298.2701729826595;7298.708051677927;10602.575896964112;10622.097121744584;26608.20175394741;26858.328541786417;36406.81796591;36941.445878311846;36954.63045369539;3327.434336162858;3773.7735735855936;3788.1287303920253;3792.3363411402893;3861.4787003754413;25947.740522594722;26135.346616334555;26275.343116422242;26512.60231096535;26607.46785064288;3003.0990702789295;3040.5743195952587;3065.555494453292;3066.2487690515745;3177.777555571111;236288;303290;304146;304384;305020;40672.729363417006;48495.54513364605;49226.753866231156;49264.75367623139;50502;50426.74786626117;53548;53795.46204537983;53807.730961345726;53848;12231.755364892651;12434.75130497385;12450.875491245153;12598.559050433374;13819.378127984264;10291.485425728684;10336.586536538605;11602.883971160349;11780.528778848922;11782.88217117835;12962.96296296294;13003.479860805463;13033.957283417303;13036.47854085826;13115.409806558728;4943.8022479101155;5812.941870581325;5848.502877255396;5888.263967004124;5895.94104058954;879.569011184515;1055.7360659835042;1063.994680026595;1065.9786804263872;1116.810142275815;23913.880430597736;24099.156529521733;26014.21957341283;26348.47303053928;26716.93132274726;1107;1119.7368618374676;1124.6738445850776;1132.6771870017171;1166.854143232096;13445;13508;13551;13822.37799299034;13857.51498697561;442718.7864060659;443957;445176;445469;446571;52209.47790522122;52439.68900777511;52603;52754.681132971986;52761.47238527566;1351.2973253907912;1399.1115641567678;1401.6355747505518;1408.6267139208119;1412.8587141285789;25275.747242528076;25661;25755.61366579465;25791.097311594003;25820.483590327713;42792;42869.78565107154;42899.57100428956;42902.570974291106;42917.14165716606;413985;414620;415227;415524;416608;26913.192604221906;27506;27579;27941.72058279391;28439.573406398507;35373.64626353703;40655.39016914689;40779.59220407758;43436.91407714832;43450.782746086064;32813.17967050843;33044.00867973964;33776.83111584427;35091.473627895095;35178.47232291466;25220.747792522572;33881.66118338785;34851;34923.47614785729;35304;31093.378132436774;31511.84244078765;35674.64325356817;35799;35829.82085089662;20896.47758806042;26857.462850742486;26936.730632693423;28509;29110.7088929108;20053.699194511802;20742.896285518476;21915.342539723835;22361.664575031064;22421.66367504456 07:22:15 INFO - PROCESS | 1921 | |2;jquery.html;371.65993116298586;391.2976207707164;405.1471652172178;415.60102301790283;431.1420273655427;13175.34123293835;18241.908790456047;20341.796582034192;21125.57748845022;22151.556968860612;20359.69460458094;20973.580528389462;21804;22695.319140425774;23009.4247643809;6356.904646430307;6360.681965901709;6572.40848323652;6770.322967703215;6831.146106736658;6608.372204640552;6714.597124172566;6750.493712971523;6773.1872175338785;6776.627285499296;6564.277929427759;6597.63712995785;6725.192976842785;6752.189737231539;6771.559848609849;6374.745010199586;6608.339166083378;6671.2995135510555;6680.632565208887;6681.632510211936;6402.839929001812;6481.157449531531;6486.870262594722;6488.416042556192;6492.9350706492805;21309.786902130934;25706.74293257062;26271.737282627313;26382.73617263841;26686.866565667242;2820.9153725388064;2920.4597149527403;2937.720916512928;2953.2321596385095;2989.8355590442516;12719.42762575677;16358.427455039135;16427.58931026722;16472.670546589;16803.655707543367;1947.591005888765;1953.2089503751004;1988.7911769264163;2008.98995505023;2029.4013266086392;128208.99999999907;132498;136084;137441.62558374388;138577;14787.630309242355;18282.725759113622;19490.317838875853;19688.507787305432;19750.70373944392;28501.857490712413;29269.853650732035;29302.853485732434;29436.411271774443;29486.852565737034;8346.374021948379;8724.302055835518;9108.772280692903;9827.75430614226;9866.076115157619;8023.83952320962;8219.013718353715;8220.958895205486;8300.916990830136;8309.95845020771;8390.874136887951;8599.61301741423;9192.770180745534;9242.3530352876;9444.811103778024;3581.659742324475;3651.9817400912825;3653.5615726113037;3659.524261845943;3665.9266814663556;826.2274773087063;924.5377311344328;1024.6567399920962;1028.18773169197;1072.0137473524376;20444.897775511326;21114.89442552808;21303.68044479334;21459.03434345427;21473.355799326044;866.4757821518017;893.2496702769705;909.5552899517471;916.9770755731026;929.8930622978309;9484.810303793885;10259.692209233735;11115.277506962022;11149.832752508719;11253.606123785792;676351;689796.4693354124;699505;701441;723719;101522.98477015283;109614;155965.22017389841;157499;159282.20358898133;977.3647129365969;981.9901800982042;999.8300288950895;1000.5697550053401;1003.5885287032136;17999.460016199537;18519.722204167218;18533.53666158357;18539.629207416045;18576.7213491795;58063.4193658058;58201.70899145477;58493.830123396445;58790;59480.70259648674;82458;84270.57864710638;84586;85673;86391;6845.452363810983;9200.711900334092;12346.876531234573;12572.245665260114;13038.348082596021;12949.158304710163;13908.51320203788;14005.299735013412;14370;14608.707825843636;5914.497267732118;7964.681412743425;11122.054625356936;11839.744070380715;12119.878801211875;11616.88383116158;11825.172237943261;11862.762744745229;11955.462004210005;12146.514139434677;11877;12171.939140304241;12258.693532661755;12260.570880019157;12394.070444716863;12644.936775316064;12871.678208044874;12897.161684490853;13259.933700331823;13447.327633618475;11827.467763950472;11828.70428239301;12164.08769342285;12177.452014659184;12221.205621634921 07:22:15 INFO - PROCESS | 1921 | |3;mootools.html;1384.280174309359;1438.6619144501044;1533.6855944531371;1552.8524790144932;1585.8414158584144;10337.948310258447;10912.50893709783;10912.563497460113;10926;10933.453327333631;10219.386836789798;10687.519061642226;10693.572257109707;10783.083437907768;10802.459877006138;2334.2647066174145;2363.4918492524102;2368.96446553301;2372.7152741671025;2373.2761507740133;2325.93022209334;2361.7917247373675;2363.326451961191;2363.917262895799;2367.0176876596192;2310.8266879983985;2322.5703244899664;2346.7066616672914;2349.8942547585316;2351.8471299365488;2294.4263934016494;2297.24191016964;2325.476767727265;2327.895244713992;2334.8365614407;2272.749997500274;2352.7059117610297;2355.9646605300936;2358.6108292131776;2366.6450032495263;10654;10755.516001779939;10759.946200269027;10772.569097236179;10774.299670521392;5474.288342515487;5604.523615492647;5804.941950580483;5812.651240925516;5815.127730840365;3373.207296285371;3581.1226249568763;3650.5984341722656;3661;3665.4135338345736;1116.6705821782593;1180.7815554122515;1182.2433642468827;1196.9820452693216;1228.1525747234468;11611.999999999916;13424.5301414451;13833.654158646114;14995.175265360402;15016.399344026226;4152.5432202457705;4657.022025374709;4699;4704.082703872712;4707.882302942454;11398.1451391146;11413.657590272305;11414.543418263342;11415.714607134889;11427.942860285646;4815.2054910940005;5026.623003274696;5680.602357834994;5707.143928410772;5716.114002329646;4248.320268756984;5189.325387699575;5221.895562088737;5248.317718696545;5259.289995850588;3585.4801053847045;3715.8142092895246;3771.377722675728;3811.9047023824073;3816.065064059323;893.6862811666839;991.7454420158361;1013.8276492996208;1015.2334987084704;1028.0387837371932;792.1523969352737;828.1345993436873;898.4250079948838;898.6854600889636;943.8867335919733;6261.812145635638;6313.526485513605;6532.444742196872;6536.346365363521;6573;877.359527544883;1000.8098461292332;1019.2604389588325;1021.6322124035341;1069.2996087562658;3049.8322592257196;3438.381091403521;3967.6429121379215;4109.671226301889;4257.829686812554;12501.062420318513;12732.618021459371;12888;12912.677183070311;12935.159214651017;12814.55149069778;12815.102942793916;12816.359182041047;12833.358332083359;12848.421821018077;9493.0981556752;9737.659181928599;9877.851832222523;9986.400815950921;10069.79860402788;5742.569307302053;6316.431521163117;6327.987521996459;6363.109164717036;6383.106365108795;11637.418129093681;12063.276203427822;12139.210951288138;12139.878601214228;12140.271583705005;11814.645560633195;12077.456514456695;12269.57056503018;12340;12340.876591233973;8867.73396798097;8873.955630222066;9061.456312621263;9065.184133428023;9067;9590.472524011246;9664.565094570902;9724.805503889742;9752;9768.169705575106;8496.872546911678;8527.360447966552;8654.78363040929;8770.693025744069;8874.156955089256;8519.914800851911;8581.65673373058;8589.055203927688;8621.87067194005;8687.739367818975;7251.274872512707;7647.9235207649435;7769.145394006542;7769.300762931363;7774.961125194338;5646.88706225865;5698.515626171656;5802.187693722798;5840.445157710011;5916.497097746567;5751.281089863767;5849.5612829037145;5856.531477481706;5871.2073870027;5936 07:22:15 INFO - PROCESS | 1921 | |4;prototype.html;368.37928091166384;371.24451740707667;375.4762106860929;375.9229357981614;380.0631443491792;5224.947750522494;5244.501772331632;5269.156934890409;5279.260903473512;5315.601329900253;4333.7399756014665;5043.16787730025;5095.949040509594;5175.948240517603;5226.379822255103;3153.858076386568;3865.7100717446165;4074.9812546863286;4111.403846442264;4136.73111247768;3893.792924193495;4127.938080928789;4128.669706423494;4164.4586203793615;4178.853740119096;3254.5606343143727;3285.6550062243477;3418.4958618208034;4138.317177665682;4149.170165966803;3793.6585707286476;4044.211378781124;4079.77561234132;4149.792510374499;4160.687948403866;3627.546556680415;3672.8347224374966;3675.320065787838;3675.5773086094905;3685.244524872395;4215.2623290924275;4656.650751193674;5177;5185.444366689978;5208.541608349668;4239.660827133853;4459.9331010034875;4675.644063221662;4765.546508314963;4845.951540484621;4621.399218101626;5022.246663000543;5039.472369341475;5158.1746920492915;5532.5297349724915;4105.876823695294;4109.794510274504;4120.301202712229;4121.608447197512;4131.256373852705;4871.780769865364;5577.972110139464;5600.767831077156;5794.942050579482;5845.970770146165;4436.822527098944;4949.406071271471;4988.850334489971;4998.775789615677;5002.574781143643;4468.687191896601;4597.770111494412;5138.38339399267;5148.742562871841;5195.68825870449;4303.892402689895;4550.832438908666;4568.223402021597;5281.521174071267;5317.867053323621;5647.752542288201;5708.40061793514;5713.857153571111;5725.799597014085;5766.625169364062;1563.601281673166;1609.8068231812024;1691.2473949092537;1725.6108832390046;1729.697302971975;1077;1146.3122126724065;1155.988510053703;1156.3351073132815;1171.1963576092721;4442.6890117691455;4462.509123996358;4723.622110231173;4886.511348865156;4920.6309526785635;5045.848624541196;5128.948710512922;5183.714895680774;5456.181572764117;5489.478499542537;3921.254961557295;4891.388576427947;4980.950190498049;5077.9434329096775;5179.119549676564;2382.7140743110936;2739.7260273972443;2888.321244507539;2915.9125226243245;2915.9271018224713;5163.457836927144;5327.413984461706;5413.566914646819;5448.591355648342;5727.5131613812455;4828.599706085266;4863.902721945541;5119.436861945183;5159.613029022838;5249.265102885599;5465.398806131322;5479.479449452296;5579.066757935646;5682.914756278659;5684.289463817023;4626.560476754703;5100.95430436767;5363.168708850135;5572.721363931868;5576.470235327637;4584.724916505021;5405.189301563087;5436.238926550207;5493.450654934474;5493.752781124939;4624.49130595641;5142;5448.6251086229995;5767.394423585463;5819.243498345188;4150.667946564328;4372.644480211017;4417.409732496363;4563.54364563541;4672.135654903854;4558.974230798044;5369.785208591768;5651.717414129195;5740.502881246671;5775.711214439178;4734.502877197982;4812.532177685839;5385.892282154413;5617.4101719320515;5652.604317697722;5403.9459605403445;5584.609077364546;5587.860303492445;5592.2170896075395;5640.661560306395;4831.227003679394;4982.825601103944;4985.401751789808;5262.605304602247;5435.537979271648;4841.426536375762;4963.528464795839;5174.6119041072825;5585.128981791146;5639.802606908738;4430.933535997027;4500.482444518922;4564.908701825879;5384.949934762683;5477 07:22:15 INFO - PROCESS | 1921 | |5;yui.html;712.7897270305259;722.5556282886023;740.4557650127156;768.6783388227136;820.8686610142377;14467.710645787078;15116.244187790622;15138.318775655094;15149.015314004595;15157.090574565535;11084;13547.18716876988;13761.518346857862;13882.167069975809;13965;931.9114684104999;944.4946953379944;950.0072424316571;951.9000504946985;953.5756588318201;915;920.9815803683922;921.9170274675278;924.5654542365078;941.7692665297012;1002.6791426743445;1008.5310330696225;1008.8083264179783;1008.8991100889889;1011.3022014809758;1002.1231422505308;1004.1866088468364;1004.8743907011624;1005;1007.6271779441654;744.0587656614388;744.162816831065;744.5197847388404;745.6756311004731;746.6080307838374;15079;15098.547795307355;15142.772858407132;15160.545183644508;15208.16355100469;13414.932925335312;13767.173969561858;13788.517401890886;13801.792973105412;13950.162990220619;11336;11389.601363952223;11431.828522572168;11562.53749850005;12138.968187704057;3584.5160903278247;3624.2932628137523;3685.1339935115225;3735.2902948439983;3744.0826997385543;90816.54591727065;92384;93600;93739;95745;8524.57377131141;8680.782980425414;10497.527611257512;10703.304285221435;10772.730681732863;21321.040553174833;21718.565628687655;21749.34751957444;21818.89090554537;21828.126874925143;7389.926100739031;7432.256774322633;7487.775366739006;7528.585927774025;7603.2776886195725;3772.773633581994;3896.5713771485116;3960.108975480494;3963.326234540135;3979.4428779970826;3359.227377703142;3441.63862794408;3453.8100404477996;3455.87904423344;3460.463628137643;517.4515014085082;595.4283887467992;606.9172753961283;612.8937268230798;628.3465196195997;623.9032949892774;652.1652285075112;680.1769858471305;691.1153723234269;707.989380159298;8266.917330826614;9144.268458523302;9795.902040979641;9881.75295617601;9939.453330066772;574.985151208118;623.2458724942779;646.9029645553111;662.2086606505276;676.1277951442584;3980.5820388859333;4039.131586708813;4756.524347565285;4769.308450274691;4777.761111944389;99111;99420.50289748504;100362.49818751005;100966;102292;46552.7672361636;68773.31226687669;75919;86852.56573717091;89759;69489.65255173692;69736.30263697502;69757.65121174463;69870;70333.73861690715;8532.488050716976;10062.647807326708;10404.164450035063;10642.361458312525;10669.413182274739;45015;45369.773151135356;45838.77080614575;45932.7703361481;46796.7660161697;55251.44748552463;55408.44591554033;55680.721596391755;56285.8742825133;56607.71696141493;10943.671689849318;11654.30074195551;12067.456964436797;12130.636080917586;12159.878401215874;10049.894511603863;11037;11925.880741192477;13663.111897726616;14570.708585828435;11544.59593914209;12017.218880772722;12236;13157.210567365988;13739;12961.611151665466;13057.673558161123;13249.933750331187;13413.646588352913;13913.02608817373;12913.418896149884;13179.67050823737;13408.530701425403;13832;13952.511662091778;10456.738581535523;10899.880840201111;10985.395803230898;11079.74032945965;11481.483333250191;8244.505329680238;9683.467409292556;10938.945305273422;11159.268669356912;11395.658130256106 07:22:15 INFO - PROCESS | 1921 | __end_tp_report 07:22:15 INFO - PROCESS | 1921 | __start_cc_report 07:22:15 INFO - PROCESS | 1921 | _x_x_mozilla_cycle_collect,3476 07:22:15 INFO - PROCESS | 1921 | __end_cc_report 07:22:15 INFO - PROCESS | 1921 | __startTimestamp1488468135032__endTimestamp 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | ------- Summary: start ------- 07:22:15 INFO - PROCESS | 1921 | Number of tests: 6 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | [#0] dojo.html Cycles:165 Average:5776.96 Median:5963.87 stddev:677.45 (11.4%) stddev-sans-first:651.24 07:22:15 INFO - PROCESS | 1921 | Values: 3307.2 3339.1 3339.4 3369.3 3380.5 5678.9 5732.2 5811.4 5897.9 5922.0 4919.7 5737.9 5787.6 5864.0 5873.7 5178.8 5211.1 5243.6 5280.6 5284.7 5332.4 5346.0 5347.7 5363.3 5400.6 5157.0 5189.4 5207.7 5253.8 5319.9 5247.8 5260.6 5263.9 5264.2 5273.8 5169.1 5211.1 5211.3 5214.6 5248.7 5042.1 5505.9 5751.4 5751.7 5760.2 5208.7 6253.0 6278.4 6278.8 6279.6 6219.8 6265.0 6289.3 6308.1 6331.3 5995.4 6001.4 6016.5 6034.8 6044.2 6308.2 6375.9 6389.0 6395.5 6401.7 6092.0 6115.8 6115.9 6128.5 6301.2 6290.0 6300.0 6300.6 6301.3 6321.2 6210.5 6222.6 6227.7 6299.0 6299.3 6343.7 6358.2 6367.2 6374.0 6382.1 4824.8 4943.4 4948.5 4951.5 4973.7 4337.5 4347.0 4426.2 4435.7 4513.1 5739.5 5744.9 5746.0 5751.2 5752.1 6307.0 6309.1 6323.5 6333.0 6341.8 4256.9 5662.2 5736.9 5773.7 5813.8 5476.3 5484.9 5490.9 5491.1 5505.8 6447.0 6449.7 6455.5 6456.5 6481.1 6225.6 6287.1 6302.4 6338.5 6368.0 6310.2 6319.1 6323.5 6328.8 6334.5 5163.5 6213.8 6225.8 6234.9 6290.2 6313.0 6323.7 6335.4 6337.2 6338.7 6219.7 6246.7 6253.2 6254.2 6263.9 5899.4 6045.3 6216.6 6233.7 6239.2 5946.0 5948.7 5956.6 5959.9 5963.9 6117.5 6119.6 6126.1 6126.4 6131.8 5930.0 5936.0 5942.9 5944.9 5952.2 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | [#1] ext.html Cycles:180 Average:51799.23 Median:31302.61 stddev:103390.83 (330.3%) stddev-sans-first:103609.75 07:22:15 INFO - PROCESS | 1921 | Values: 725.4 783.8 839.8 852.1 856.1 36761.8 37411.6 37523.6 37712.8 39124.7 38080.6 38316.6 38345.8 38473.6 38478.4 7219.5 7405.9 8882.5 9025.8 9040.4 7266.3 7356.7 7359.4 10649.9 10907.3 10807.7 10875.9 10889.1 10902.4 10924.9 10767.9 10819.1 10840.3 10841.0 10855.6 7117.3 7298.3 7298.7 10602.6 10622.1 26608.2 26858.3 36406.8 36941.4 36954.6 3327.4 3773.8 3788.1 3792.3 3861.5 25947.7 26135.3 26275.3 26512.6 26607.5 3003.1 3040.6 3065.6 3066.2 3177.8 236288.0 303290.0 304146.0 304384.0 305020.0 40672.7 48495.5 49226.8 49264.8 50502.0 50426.7 53548.0 53795.5 53807.7 53848.0 12231.8 12434.8 12450.9 12598.6 13819.4 10291.5 10336.6 11602.9 11780.5 11782.9 12963.0 13003.5 13034.0 13036.5 13115.4 4943.8 5812.9 5848.5 5888.3 5895.9 879.6 1055.7 1064.0 1066.0 1116.8 23913.9 24099.2 26014.2 26348.5 26716.9 1107.0 1119.7 1124.7 1132.7 1166.9 13445.0 13508.0 13551.0 13822.4 13857.5 442718.8 443957.0 445176.0 445469.0 446571.0 52209.5 52439.7 52603.0 52754.7 52761.5 1351.3 1399.1 1401.6 1408.6 1412.9 25275.7 25661.0 25755.6 25791.1 25820.5 42792.0 42869.8 42899.6 42902.6 42917.1 413985.0 414620.0 415227.0 415524.0 416608.0 26913.2 27506.0 27579.0 27941.7 28439.6 35373.6 40655.4 40779.6 43436.9 43450.8 32813.2 33044.0 33776.8 35091.5 35178.5 25220.7 33881.7 34851.0 34923.5 35304.0 31093.4 31511.8 35674.6 35799.0 35829.8 20896.5 26857.5 26936.7 28509.0 29110.7 20053.7 20742.9 21915.3 22361.7 22421.7 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | [#2] jquery.html Cycles:180 Average:40205.10 Median:15661.39 stddev:116143.11 (741.6%) stddev-sans-first:116430.41 07:22:15 INFO - PROCESS | 1921 | Values: 371.7 391.3 405.1 415.6 431.1 13175.3 18241.9 20341.8 21125.6 22151.6 20359.7 20973.6 21804.0 22695.3 23009.4 6356.9 6360.7 6572.4 6770.3 6831.1 6608.4 6714.6 6750.5 6773.2 6776.6 6564.3 6597.6 6725.2 6752.2 6771.6 6374.7 6608.3 6671.3 6680.6 6681.6 6402.8 6481.2 6486.9 6488.4 6492.9 21309.8 25706.7 26271.7 26382.7 26686.9 2820.9 2920.5 2937.7 2953.2 2989.8 12719.4 16358.4 16427.6 16472.7 16803.7 1947.6 1953.2 1988.8 2009.0 2029.4 128209.0 132498.0 136084.0 137441.6 138577.0 14787.6 18282.7 19490.3 19688.5 19750.7 28501.9 29269.9 29302.9 29436.4 29486.9 8346.4 8724.3 9108.8 9827.8 9866.1 8023.8 8219.0 8221.0 8300.9 8310.0 8390.9 8599.6 9192.8 9242.4 9444.8 3581.7 3652.0 3653.6 3659.5 3665.9 826.2 924.5 1024.7 1028.2 1072.0 20444.9 21114.9 21303.7 21459.0 21473.4 866.5 893.2 909.6 917.0 929.9 9484.8 10259.7 11115.3 11149.8 11253.6 676351.0 689796.5 699505.0 701441.0 723719.0 101523.0 109614.0 155965.2 157499.0 159282.2 977.4 982.0 999.8 1000.6 1003.6 17999.5 18519.7 18533.5 18539.6 18576.7 58063.4 58201.7 58493.8 58790.0 59480.7 82458.0 84270.6 84586.0 85673.0 86391.0 6845.5 9200.7 12346.9 12572.2 13038.3 12949.2 13908.5 14005.3 14370.0 14608.7 5914.5 7964.7 11122.1 11839.7 12119.9 11616.9 11825.2 11862.8 11955.5 12146.5 11877.0 12171.9 12258.7 12260.6 12394.1 12644.9 12871.7 12897.2 13259.9 13447.3 11827.5 11828.7 12164.1 12177.5 12221.2 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | [#3] mootools.html Cycles:180 Average:6499.16 Median:3509.75 stddev:4017.74 (114.5%) stddev-sans-first:4010.63 07:22:15 INFO - PROCESS | 1921 | Values: 1384.3 1438.7 1533.7 1552.9 1585.8 10337.9 10912.5 10912.6 10926.0 10933.5 10219.4 10687.5 10693.6 10783.1 10802.5 2334.3 2363.5 2369.0 2372.7 2373.3 2325.9 2361.8 2363.3 2363.9 2367.0 2310.8 2322.6 2346.7 2349.9 2351.8 2294.4 2297.2 2325.5 2327.9 2334.8 2272.7 2352.7 2356.0 2358.6 2366.6 10654.0 10755.5 10759.9 10772.6 10774.3 5474.3 5604.5 5804.9 5812.7 5815.1 3373.2 3581.1 3650.6 3661.0 3665.4 1116.7 1180.8 1182.2 1197.0 1228.2 11612.0 13424.5 13833.7 14995.2 15016.4 4152.5 4657.0 4699.0 4704.1 4707.9 11398.1 11413.7 11414.5 11415.7 11427.9 4815.2 5026.6 5680.6 5707.1 5716.1 4248.3 5189.3 5221.9 5248.3 5259.3 3585.5 3715.8 3771.4 3811.9 3816.1 893.7 991.7 1013.8 1015.2 1028.0 792.2 828.1 898.4 898.7 943.9 6261.8 6313.5 6532.4 6536.3 6573.0 877.4 1000.8 1019.3 1021.6 1069.3 3049.8 3438.4 3967.6 4109.7 4257.8 12501.1 12732.6 12888.0 12912.7 12935.2 12814.6 12815.1 12816.4 12833.4 12848.4 9493.1 9737.7 9877.9 9986.4 10069.8 5742.6 6316.4 6328.0 6363.1 6383.1 11637.4 12063.3 12139.2 12139.9 12140.3 11814.6 12077.5 12269.6 12340.0 12340.9 8867.7 8874.0 9061.5 9065.2 9067.0 9590.5 9664.6 9724.8 9752.0 9768.2 8496.9 8527.4 8654.8 8770.7 8874.2 8519.9 8581.7 8589.1 8621.9 8687.7 7251.3 7647.9 7769.1 7769.3 7775.0 5646.9 5698.5 5802.2 5840.4 5916.5 5751.3 5849.6 5856.5 5871.2 5936.0 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | [#4] prototype.html Cycles:180 Average:4516.53 Median:4935.02 stddev:1263.84 (25.6%) stddev-sans-first:1228.43 07:22:15 INFO - PROCESS | 1921 | Values: 368.4 371.2 375.5 375.9 380.1 5224.9 5244.5 5269.2 5279.3 5315.6 4333.7 5043.2 5095.9 5175.9 5226.4 3153.9 3865.7 4075.0 4111.4 4136.7 3893.8 4127.9 4128.7 4164.5 4178.9 3254.6 3285.7 3418.5 4138.3 4149.2 3793.7 4044.2 4079.8 4149.8 4160.7 3627.5 3672.8 3675.3 3675.6 3685.2 4215.3 4656.7 5177.0 5185.4 5208.5 4239.7 4459.9 4675.6 4765.5 4846.0 4621.4 5022.2 5039.5 5158.2 5532.5 4105.9 4109.8 4120.3 4121.6 4131.3 4871.8 5578.0 5600.8 5794.9 5846.0 4436.8 4949.4 4988.9 4998.8 5002.6 4468.7 4597.8 5138.4 5148.7 5195.7 4303.9 4550.8 4568.2 5281.5 5317.9 5647.8 5708.4 5713.9 5725.8 5766.6 1563.6 1609.8 1691.2 1725.6 1729.7 1077.0 1146.3 1156.0 1156.3 1171.2 4442.7 4462.5 4723.6 4886.5 4920.6 5045.8 5128.9 5183.7 5456.2 5489.5 3921.3 4891.4 4981.0 5077.9 5179.1 2382.7 2739.7 2888.3 2915.9 2915.9 5163.5 5327.4 5413.6 5448.6 5727.5 4828.6 4863.9 5119.4 5159.6 5249.3 5465.4 5479.5 5579.1 5682.9 5684.3 4626.6 5101.0 5363.2 5572.7 5576.5 4584.7 5405.2 5436.2 5493.5 5493.8 4624.5 5142.0 5448.6 5767.4 5819.2 4150.7 4372.6 4417.4 4563.5 4672.1 4559.0 5369.8 5651.7 5740.5 5775.7 4734.5 4812.5 5385.9 5617.4 5652.6 5403.9 5584.6 5587.9 5592.2 5640.7 4831.2 4982.8 4985.4 5262.6 5435.5 4841.4 4963.5 5174.6 5585.1 5639.8 4430.9 4500.5 4564.9 5384.9 5477.0 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - PROCESS | 1921 | [#5] yui.html Cycles:180 Average:18703.09 Median:3710.21 stddev:26326.36 (709.6%) stddev-sans-first:26365.55 07:22:15 INFO - PROCESS | 1921 | Values: 712.8 722.6 740.5 768.7 820.9 14467.7 15116.2 15138.3 15149.0 15157.1 11084.0 13547.2 13761.5 13882.2 13965.0 931.9 944.5 950.0 951.9 953.6 915.0 921.0 921.9 924.6 941.8 1002.7 1008.5 1008.8 1008.9 1011.3 1002.1 1004.2 1004.9 1005.0 1007.6 744.1 744.2 744.5 745.7 746.6 15079.0 15098.5 15142.8 15160.5 15208.2 13414.9 13767.2 13788.5 13801.8 13950.2 11336.0 11389.6 11431.8 11562.5 12139.0 3584.5 3624.3 3685.1 3735.3 3744.1 90816.5 92384.0 93600.0 93739.0 95745.0 8524.6 8680.8 10497.5 10703.3 10772.7 21321.0 21718.6 21749.3 21818.9 21828.1 7389.9 7432.3 7487.8 7528.6 7603.3 3772.8 3896.6 3960.1 3963.3 3979.4 3359.2 3441.6 3453.8 3455.9 3460.5 517.5 595.4 606.9 612.9 628.3 623.9 652.2 680.2 691.1 708.0 8266.9 9144.3 9795.9 9881.8 9939.5 575.0 623.2 646.9 662.2 676.1 3980.6 4039.1 4756.5 4769.3 4777.8 99111.0 99420.5 100362.5 100966.0 102292.0 46552.8 68773.3 75919.0 86852.6 89759.0 69489.7 69736.3 69757.7 69870.0 70333.7 8532.5 10062.6 10404.2 10642.4 10669.4 45015.0 45369.8 45838.8 45932.8 46796.8 55251.4 55408.4 55680.7 56285.9 56607.7 10943.7 11654.3 12067.5 12130.6 12159.9 10049.9 11037.0 11925.9 13663.1 14570.7 11544.6 12017.2 12236.0 13157.2 13739.0 12961.6 13057.7 13249.9 13413.6 13913.0 12913.4 13179.7 13408.5 13832.0 13952.5 10456.7 10899.9 10985.4 11079.7 11481.5 8244.5 9683.5 10938.9 11159.3 11395.7 07:22:15 INFO - PROCESS | 1921 | -------- Summary: end -------- 07:22:15 INFO - PROCESS | 1921 | 07:22:15 INFO - TEST-INFO | 1921: exit 0 07:22:15 INFO - TEST-OK | dromaeo_css | took 1121445ms 07:22:15 INFO - TEST-START | kraken 07:22:15 INFO - operating with platform_type : mac_ 07:22:15 INFO - Initialising browser for kraken test... 07:22:15 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpuajguL/profile http://localhost:56447/getInfo.html) 07:22:17 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 07:22:17 INFO - PROCESS | 1925 | colorDepth:24 07:22:17 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 07:22:17 INFO - PROCESS | 1925 | __metrics 07:22:18 INFO - PROCESS | 1925 | 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" 07:22:18 INFO - PROCESS | 1925 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:22:18 INFO - TEST-INFO | 1925: exit 0 07:22:18 INFO - Browser initialized. 07:22:18 INFO - Running cycle 1/1 for kraken test... 07:22:18 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpuajguL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:22:31 INFO - PROCESS | 1926 | RSS: Main: 231817216 07:22:31 INFO - PROCESS | 1926 | 07:22:33 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56447/tests/kraken/driver.html?testName=audio-beat-detection) 07:22:34 INFO - PROCESS | 1926 | RSS: Main: 283860992 07:22:34 INFO - PROCESS | 1926 | 07:22:37 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56447/tests/kraken/driver.html?testName=audio-dft) 07:22:38 INFO - PROCESS | 1926 | RSS: Main: 285839360 07:22:38 INFO - PROCESS | 1926 | 07:22:41 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56447/tests/kraken/driver.html?testName=audio-fft) 07:22:42 INFO - PROCESS | 1926 | RSS: Main: 376512512 07:22:42 INFO - PROCESS | 1926 | 07:22:44 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56447/tests/kraken/driver.html?testName=audio-oscillator) 07:22:44 INFO - PROCESS | 1926 | RSS: Main: 282230784 07:22:44 INFO - PROCESS | 1926 | 07:22:46 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:22:47 INFO - PROCESS | 1926 | RSS: Main: 284721152 07:22:47 INFO - PROCESS | 1926 | 07:22:50 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56447/tests/kraken/driver.html?testName=imaging-darkroom) 07:22:51 INFO - PROCESS | 1926 | RSS: Main: 326037504 07:22:51 INFO - PROCESS | 1926 | 07:22:54 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56447/tests/kraken/driver.html?testName=imaging-desaturate) 07:22:54 INFO - PROCESS | 1926 | RSS: Main: 328310784 07:22:54 INFO - PROCESS | 1926 | 07:22:57 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56447/tests/kraken/driver.html?testName=json-parse-financial) 07:22:58 INFO - PROCESS | 1926 | RSS: Main: 327315456 07:22:58 INFO - PROCESS | 1926 | 07:23:00 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:23:00 INFO - PROCESS | 1926 | RSS: Main: 300920832 07:23:00 INFO - PROCESS | 1926 | 07:23:02 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:23:03 INFO - PROCESS | 1926 | RSS: Main: 305692672 07:23:03 INFO - PROCESS | 1926 | 07:23:05 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:23:06 INFO - PROCESS | 1926 | RSS: Main: 313417728 07:23:06 INFO - PROCESS | 1926 | 07:23:09 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:23:10 INFO - PROCESS | 1926 | RSS: Main: 325976064 07:23:10 INFO - PROCESS | 1926 | 07:23:12 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:23:13 INFO - PROCESS | 1926 | RSS: Main: 320811008 07:23:13 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:56447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56447/tests/kraken/driver.html?testName=ai-astar) 07:23:15 INFO - PROCESS | 1926 | RSS: Main: 365260800 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | __start_tp_report 07:23:15 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 07:23:15 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 07:23:15 INFO - PROCESS | 1926 | |i|pagename|runs| 07:23:15 INFO - PROCESS | 1926 | |0;ai-astar;117;119;118;118;118;119;118;118;118;117 07:23:15 INFO - PROCESS | 1926 | |1;audio-beat-detection;135;113;106;147;110;110;110;105;129;110 07:23:15 INFO - PROCESS | 1926 | |2;audio-dft;187;185;185;184;188;196;258;191;186;186 07:23:15 INFO - PROCESS | 1926 | |3;audio-fft;81;61;60;91;59;62;60;61;78;60 07:23:15 INFO - PROCESS | 1926 | |4;audio-oscillator;95;70;91;70;70;69;85;69;68;84 07:23:15 INFO - PROCESS | 1926 | |5;imaging-gaussian-blur;88;86;87;89;88;87;87;88;87;87 07:23:15 INFO - PROCESS | 1926 | |6;imaging-darkroom;96;94;94;95;95;94;94;95;96;94 07:23:15 INFO - PROCESS | 1926 | |7;imaging-desaturate;84;84;83;87;84;84;86;85;83;85 07:23:15 INFO - PROCESS | 1926 | |8;json-parse-financial;63;63;65;63;64;63;62;61;83;95 07:23:15 INFO - PROCESS | 1926 | |9;json-stringify-tinderbox;56;66;60;60;65;60;58;58;58;59 07:23:15 INFO - PROCESS | 1926 | |10;stanford-crypto-aes;89;90;90;88;87;90;86;88;93;94 07:23:15 INFO - PROCESS | 1926 | |11;stanford-crypto-ccm;143;166;149;148;141;139;142;138;183;159 07:23:15 INFO - PROCESS | 1926 | |12;stanford-crypto-pbkdf2;172;171;173;173;172;172;172;171;152;223 07:23:15 INFO - PROCESS | 1926 | |13;stanford-crypto-sha256-iterative;68;68;68;67;66;66;65;64;67;65 07:23:15 INFO - PROCESS | 1926 | __end_tp_report 07:23:15 INFO - PROCESS | 1926 | __start_cc_report 07:23:15 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,2168 07:23:15 INFO - PROCESS | 1926 | __end_cc_report 07:23:15 INFO - PROCESS | 1926 | __startTimestamp1488468195619__endTimestamp 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | ------- Summary: start ------- 07:23:15 INFO - PROCESS | 1926 | Number of tests: 14 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#0] ai-astar Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 07:23:15 INFO - PROCESS | 1926 | Values: 117.0 119.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 117.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:111.50 stddev:14.31 (12.8%) stddev-sans-first:13.70 07:23:15 INFO - PROCESS | 1926 | Values: 135.0 113.0 106.0 147.0 110.0 110.0 110.0 105.0 129.0 110.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#2] audio-dft Cycles:10 Average:194.60 Median:187.50 stddev:22.56 (12.0%) stddev-sans-first:23.76 07:23:15 INFO - PROCESS | 1926 | Values: 187.0 185.0 185.0 184.0 188.0 196.0 258.0 191.0 186.0 186.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.50 stddev:11.55 (18.8%) stddev-sans-first:11.13 07:23:15 INFO - PROCESS | 1926 | Values: 81.0 61.0 60.0 91.0 59.0 62.0 60.0 61.0 78.0 60.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.00 stddev:10.48 (13.6%) stddev-sans-first:8.89 07:23:15 INFO - PROCESS | 1926 | Values: 95.0 70.0 91.0 70.0 70.0 69.0 85.0 69.0 68.0 84.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:87.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 07:23:15 INFO - PROCESS | 1926 | Values: 88.0 86.0 87.0 89.0 88.0 87.0 87.0 88.0 87.0 87.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 07:23:15 INFO - PROCESS | 1926 | Values: 96.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 96.0 94.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:1.27 (1.5%) stddev-sans-first:1.33 07:23:15 INFO - PROCESS | 1926 | Values: 84.0 84.0 83.0 87.0 84.0 84.0 86.0 85.0 83.0 85.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:63.50 stddev:11.37 (17.9%) stddev-sans-first:11.90 07:23:15 INFO - PROCESS | 1926 | Values: 63.0 63.0 65.0 63.0 64.0 63.0 62.0 61.0 83.0 95.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:3.16 (5.3%) stddev-sans-first:3.00 07:23:15 INFO - PROCESS | 1926 | Values: 56.0 66.0 60.0 60.0 65.0 60.0 58.0 58.0 58.0 59.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:90.00 stddev:2.51 (2.8%) stddev-sans-first:2.65 07:23:15 INFO - PROCESS | 1926 | Values: 89.0 90.0 90.0 88.0 87.0 90.0 86.0 88.0 93.0 94.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:148.50 stddev:14.47 (9.7%) stddev-sans-first:15.07 07:23:15 INFO - PROCESS | 1926 | Values: 143.0 166.0 149.0 148.0 141.0 139.0 142.0 138.0 183.0 159.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:172.00 stddev:17.98 (10.5%) stddev-sans-first:19.03 07:23:15 INFO - PROCESS | 1926 | Values: 172.0 171.0 173.0 173.0 172.0 172.0 172.0 171.0 152.0 223.0 07:23:15 INFO - PROCESS | 1926 | 07:23:15 INFO - PROCESS | 1926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.39 07:23:15 INFO - PROCESS | 1926 | Values: 68.0 68.0 68.0 67.0 66.0 66.0 65.0 64.0 67.0 65.0 07:23:15 INFO - PROCESS | 1926 | -------- Summary: end -------- 07:23:15 INFO - PROCESS | 1926 | 07:23:16 INFO - TEST-INFO | 1926: exit 0 07:23:16 INFO - TEST-OK | kraken | took 60884ms 07:23:16 INFO - SUITE-END | took 1182s 07:23:16 INFO - Completed test suite (00:19:42) 07:23:16 INFO - javascript benchmark 07:23:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7442.702331136615, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.1566750478623, 3339.148517128132, 3339.415602269604, 3369.292448585797, 3380.5436266104075, 5678.914816277759, 5732.197492351074, 5811.418858114192, 5897.882042359156, 5921.970390148049, 4919.655624106314, 5737.909797138551, 5787.623804452707, 5863.970680146604, 5873.706314684259, 5178.766955487012, 5211.140161873286, 5243.606729495303, 5280.630355875091, 5284.682919024852, 5332.3601167859915, 5346.03771321162, 5347.679139251638, 5363.329583802025, 5400.567954563645, 5157.0, 5189.351331083614, 5207.739613019372, 5253.763580638881, 5319.9202011969855, 5247.763850626731, 5260.605454590921, 5263.894722105575, 5264.236685680555, 5273.7626806793405, 5169.1212493875755, 5211.062008838408, 5211.296474975868, 5214.556762675177, 5248.685078895241, 5042.117629414838, 5505.889882202374, 5751.3961034091235, 5751.683657398841, 5760.164776107483, 5208.713520756357, 6252.968735156341, 6278.4035516625845, 6278.780242691484, 6279.623222606612, 6219.844503887393, 6265.028920517281, 6289.276733175698, 6308.085327627514, 6331.271903731038, 5995.430434108753, 6001.4298641628975, 6016.458518733335, 6034.849128771772, 6044.214252147237, 6308.179936608303, 6375.904361434582, 6389.041643753474, 6395.488360931115, 6401.679916004275, 6092.025275955826, 6115.755369785159, 6115.938840611626, 6128.533679014772, 6301.180846489927, 6289.96215624426, 6299.968500157562, 6300.558960872695, 6301.275353334334, 6321.1782468278825, 6210.50315974721, 6222.595531290452, 6227.657478838617, 6298.9921612541775, 6299.307076221612, 6343.682815859281, 6358.205224346957, 6367.204099487564, 6374.0, 6382.138411314413, 4824.782884770194, 4943.3573635427165, 4948.455669876311, 4951.455339912607, 4973.651844370932, 4337.501187363494, 4346.978460061883, 4426.203283409017, 4435.711678740871, 4513.097380523843, 5739.512141468022, 5744.942550574524, 5746.0, 5751.223584815996, 5752.07966725322, 6306.9684651576445, 6309.085182648582, 6323.52573556985, 6333.018382150774, 6341.778037768656, 4256.87229383119, 5662.207290979184, 5736.942630573724, 5773.711314434261, 5813.76744930198, 5476.315460567429, 5484.862878427992, 5490.917636235459, 5491.093969494988, 5505.834824955257, 6447.0329450582785, 6449.7097630605795, 6455.451286640594, 6456.451201647818, 6481.09264702942, 6225.564210505221, 6287.056941458635, 6302.401271879165, 6338.461230795249, 6368.0, 6310.211223597051, 6319.05214217871, 6323.494120470444, 6328.810135695937, 6334.461570766536, 5163.4578369272185, 6213.751449941951, 6225.750969961151, 6234.937650623617, 6290.21372328459, 6312.968435157794, 6323.747050118128, 6335.3981371769605, 6337.176167098248, 6338.65137417428, 6219.657918814328, 6246.718897649525, 6253.249610046823, 6254.21822272216, 6263.937360626335, 5899.439553242435, 6045.274567051982, 6216.595921265103, 6233.719482623203, 6239.220097487814, 5946.0, 5948.702564871825, 5956.642601443928, 5959.880802383841, 5963.86686529558, 6117.510599152146, 6119.602225855305, 6126.08108783686, 6126.448619624255, 6131.816045518642, 5930.0, 5935.990881550233, 5942.881142377042, 5944.881102377842, 5952.166696662384], "value": 5733.001618427968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.4305370284326, 783.8314762326099, 839.8152406470579, 852.0882655558551, 856.1139220906363, 36761.81619091904, 37411.62588374115, 37523.624763752356, 37712.811435942815, 39124.71816304798, 38080.61919380805, 38316.61683383166, 38345.84962451124, 38473.61526384735, 38478.42282365767, 7219.458540609449, 7405.851882962337, 8882.467051976886, 9025.819483610323, 9040.41237319572, 7266.2733726627175, 7356.7057317707495, 7359.411247100246, 10649.893501064967, 10907.29102608328, 10807.67576972692, 10875.945620271888, 10889.128869690445, 10902.400367979759, 10924.945375273113, 10767.946160269188, 10819.080378167866, 10840.295380800222, 10841.0, 10855.565777368896, 7117.2882711728935, 7298.2701729826595, 7298.708051677927, 10602.575896964112, 10622.097121744584, 26608.20175394741, 26858.328541786417, 36406.81796591, 36941.445878311846, 36954.63045369539, 3327.434336162858, 3773.7735735855936, 3788.1287303920253, 3792.3363411402893, 3861.4787003754413, 25947.740522594722, 26135.346616334555, 26275.343116422242, 26512.60231096535, 26607.46785064288, 3003.0990702789295, 3040.5743195952587, 3065.555494453292, 3066.2487690515745, 3177.777555571111, 236288.0, 303290.0, 304146.0, 304384.0, 305020.0, 40672.729363417006, 48495.54513364605, 49226.753866231156, 49264.75367623139, 50502.0, 50426.74786626117, 53548.0, 53795.46204537983, 53807.730961345726, 53848.0, 12231.755364892651, 12434.75130497385, 12450.875491245153, 12598.559050433374, 13819.378127984264, 10291.485425728684, 10336.586536538605, 11602.883971160349, 11780.528778848922, 11782.88217117835, 12962.96296296294, 13003.479860805463, 13033.957283417303, 13036.47854085826, 13115.409806558728, 4943.8022479101155, 5812.941870581325, 5848.502877255396, 5888.263967004124, 5895.94104058954, 879.569011184515, 1055.7360659835042, 1063.994680026595, 1065.9786804263872, 1116.810142275815, 23913.880430597736, 24099.156529521733, 26014.21957341283, 26348.47303053928, 26716.93132274726, 1107.0, 1119.7368618374676, 1124.6738445850776, 1132.6771870017171, 1166.854143232096, 13445.0, 13508.0, 13551.0, 13822.37799299034, 13857.51498697561, 442718.7864060659, 443957.0, 445176.0, 445469.0, 446571.0, 52209.47790522122, 52439.68900777511, 52603.0, 52754.681132971986, 52761.47238527566, 1351.2973253907912, 1399.1115641567678, 1401.6355747505518, 1408.6267139208119, 1412.8587141285789, 25275.747242528076, 25661.0, 25755.61366579465, 25791.097311594003, 25820.483590327713, 42792.0, 42869.78565107154, 42899.57100428956, 42902.570974291106, 42917.14165716606, 413985.0, 414620.0, 415227.0, 415524.0, 416608.0, 26913.192604221906, 27506.0, 27579.0, 27941.72058279391, 28439.573406398507, 35373.64626353703, 40655.39016914689, 40779.59220407758, 43436.91407714832, 43450.782746086064, 32813.17967050843, 33044.00867973964, 33776.83111584427, 35091.473627895095, 35178.47232291466, 25220.747792522572, 33881.66118338785, 34851.0, 34923.47614785729, 35304.0, 31093.378132436774, 31511.84244078765, 35674.64325356817, 35799.0, 35829.82085089662, 20896.47758806042, 26857.462850742486, 26936.730632693423, 28509.0, 29110.7088929108, 20053.699194511802, 20742.896285518476, 21915.342539723835, 22361.664575031064, 22421.66367504456], "value": 17762.15305566507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.65993116298586, 391.2976207707164, 405.1471652172178, 415.60102301790283, 431.1420273655427, 13175.34123293835, 18241.908790456047, 20341.796582034192, 21125.57748845022, 22151.556968860612, 20359.69460458094, 20973.580528389462, 21804.0, 22695.319140425774, 23009.4247643809, 6356.904646430307, 6360.681965901709, 6572.40848323652, 6770.322967703215, 6831.146106736658, 6608.372204640552, 6714.597124172566, 6750.493712971523, 6773.1872175338785, 6776.627285499296, 6564.277929427759, 6597.63712995785, 6725.192976842785, 6752.189737231539, 6771.559848609849, 6374.745010199586, 6608.339166083378, 6671.2995135510555, 6680.632565208887, 6681.632510211936, 6402.839929001812, 6481.157449531531, 6486.870262594722, 6488.416042556192, 6492.9350706492805, 21309.786902130934, 25706.74293257062, 26271.737282627313, 26382.73617263841, 26686.866565667242, 2820.9153725388064, 2920.4597149527403, 2937.720916512928, 2953.2321596385095, 2989.8355590442516, 12719.42762575677, 16358.427455039135, 16427.58931026722, 16472.670546589, 16803.655707543367, 1947.591005888765, 1953.2089503751004, 1988.7911769264163, 2008.98995505023, 2029.4013266086392, 128208.99999999907, 132498.0, 136084.0, 137441.62558374388, 138577.0, 14787.630309242355, 18282.725759113622, 19490.317838875853, 19688.507787305432, 19750.70373944392, 28501.857490712413, 29269.853650732035, 29302.853485732434, 29436.411271774443, 29486.852565737034, 8346.374021948379, 8724.302055835518, 9108.772280692903, 9827.75430614226, 9866.076115157619, 8023.83952320962, 8219.013718353715, 8220.958895205486, 8300.916990830136, 8309.95845020771, 8390.874136887951, 8599.61301741423, 9192.770180745534, 9242.3530352876, 9444.811103778024, 3581.659742324475, 3651.9817400912825, 3653.5615726113037, 3659.524261845943, 3665.9266814663556, 826.2274773087063, 924.5377311344328, 1024.6567399920962, 1028.18773169197, 1072.0137473524376, 20444.897775511326, 21114.89442552808, 21303.68044479334, 21459.03434345427, 21473.355799326044, 866.4757821518017, 893.2496702769705, 909.5552899517471, 916.9770755731026, 929.8930622978309, 9484.810303793885, 10259.692209233735, 11115.277506962022, 11149.832752508719, 11253.606123785792, 676351.0, 689796.4693354124, 699505.0, 701441.0, 723719.0, 101522.98477015283, 109614.0, 155965.22017389841, 157499.0, 159282.20358898133, 977.3647129365969, 981.9901800982042, 999.8300288950895, 1000.5697550053401, 1003.5885287032136, 17999.460016199537, 18519.722204167218, 18533.53666158357, 18539.629207416045, 18576.7213491795, 58063.4193658058, 58201.70899145477, 58493.830123396445, 58790.0, 59480.70259648674, 82458.0, 84270.57864710638, 84586.0, 85673.0, 86391.0, 6845.452363810983, 9200.711900334092, 12346.876531234573, 12572.245665260114, 13038.348082596021, 12949.158304710163, 13908.51320203788, 14005.299735013412, 14370.0, 14608.707825843636, 5914.497267732118, 7964.681412743425, 11122.054625356936, 11839.744070380715, 12119.878801211875, 11616.88383116158, 11825.172237943261, 11862.762744745229, 11955.462004210005, 12146.514139434677, 11877.0, 12171.939140304241, 12258.693532661755, 12260.570880019157, 12394.070444716863, 12644.936775316064, 12871.678208044874, 12897.161684490853, 13259.933700331823, 13447.327633618475, 11827.467763950472, 11828.70428239301, 12164.08769342285, 12177.452014659184, 12221.205621634921], "value": 11150.416607399065, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.280174309359, 1438.6619144501044, 1533.6855944531371, 1552.8524790144932, 1585.8414158584144, 10337.948310258447, 10912.50893709783, 10912.563497460113, 10926.0, 10933.453327333631, 10219.386836789798, 10687.519061642226, 10693.572257109707, 10783.083437907768, 10802.459877006138, 2334.2647066174145, 2363.4918492524102, 2368.96446553301, 2372.7152741671025, 2373.2761507740133, 2325.93022209334, 2361.7917247373675, 2363.326451961191, 2363.917262895799, 2367.0176876596192, 2310.8266879983985, 2322.5703244899664, 2346.7066616672914, 2349.8942547585316, 2351.8471299365488, 2294.4263934016494, 2297.24191016964, 2325.476767727265, 2327.895244713992, 2334.8365614407, 2272.749997500274, 2352.7059117610297, 2355.9646605300936, 2358.6108292131776, 2366.6450032495263, 10654.0, 10755.516001779939, 10759.946200269027, 10772.569097236179, 10774.299670521392, 5474.288342515487, 5604.523615492647, 5804.941950580483, 5812.651240925516, 5815.127730840365, 3373.207296285371, 3581.1226249568763, 3650.5984341722656, 3661.0, 3665.4135338345736, 1116.6705821782593, 1180.7815554122515, 1182.2433642468827, 1196.9820452693216, 1228.1525747234468, 11611.999999999916, 13424.5301414451, 13833.654158646114, 14995.175265360402, 15016.399344026226, 4152.5432202457705, 4657.022025374709, 4699.0, 4704.082703872712, 4707.882302942454, 11398.1451391146, 11413.657590272305, 11414.543418263342, 11415.714607134889, 11427.942860285646, 4815.2054910940005, 5026.623003274696, 5680.602357834994, 5707.143928410772, 5716.114002329646, 4248.320268756984, 5189.325387699575, 5221.895562088737, 5248.317718696545, 5259.289995850588, 3585.4801053847045, 3715.8142092895246, 3771.377722675728, 3811.9047023824073, 3816.065064059323, 893.6862811666839, 991.7454420158361, 1013.8276492996208, 1015.2334987084704, 1028.0387837371932, 792.1523969352737, 828.1345993436873, 898.4250079948838, 898.6854600889636, 943.8867335919733, 6261.812145635638, 6313.526485513605, 6532.444742196872, 6536.346365363521, 6573.0, 877.359527544883, 1000.8098461292332, 1019.2604389588325, 1021.6322124035341, 1069.2996087562658, 3049.8322592257196, 3438.381091403521, 3967.6429121379215, 4109.671226301889, 4257.829686812554, 12501.062420318513, 12732.618021459371, 12888.0, 12912.677183070311, 12935.159214651017, 12814.55149069778, 12815.102942793916, 12816.359182041047, 12833.358332083359, 12848.421821018077, 9493.0981556752, 9737.659181928599, 9877.851832222523, 9986.400815950921, 10069.79860402788, 5742.569307302053, 6316.431521163117, 6327.987521996459, 6363.109164717036, 6383.106365108795, 11637.418129093681, 12063.276203427822, 12139.210951288138, 12139.878601214228, 12140.271583705005, 11814.645560633195, 12077.456514456695, 12269.57056503018, 12340.0, 12340.876591233973, 8867.73396798097, 8873.955630222066, 9061.456312621263, 9065.184133428023, 9067.0, 9590.472524011246, 9664.565094570902, 9724.805503889742, 9752.0, 9768.169705575106, 8496.872546911678, 8527.360447966552, 8654.78363040929, 8770.693025744069, 8874.156955089256, 8519.914800851911, 8581.65673373058, 8589.055203927688, 8621.87067194005, 8687.739367818975, 7251.274872512707, 7647.9235207649435, 7769.145394006542, 7769.300762931363, 7774.961125194338, 5646.88706225865, 5698.515626171656, 5802.187693722798, 5840.445157710011, 5916.497097746567, 5751.281089863767, 5849.5612829037145, 5856.531477481706, 5871.2073870027, 5936.0], "value": 4972.346391864401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.37928091166384, 371.24451740707667, 375.4762106860929, 375.9229357981614, 380.0631443491792, 5224.947750522494, 5244.501772331632, 5269.156934890409, 5279.260903473512, 5315.601329900253, 4333.7399756014665, 5043.16787730025, 5095.949040509594, 5175.948240517603, 5226.379822255103, 3153.858076386568, 3865.7100717446165, 4074.9812546863286, 4111.403846442264, 4136.73111247768, 3893.792924193495, 4127.938080928789, 4128.669706423494, 4164.4586203793615, 4178.853740119096, 3254.5606343143727, 3285.6550062243477, 3418.4958618208034, 4138.317177665682, 4149.170165966803, 3793.6585707286476, 4044.211378781124, 4079.77561234132, 4149.792510374499, 4160.687948403866, 3627.546556680415, 3672.8347224374966, 3675.320065787838, 3675.5773086094905, 3685.244524872395, 4215.2623290924275, 4656.650751193674, 5177.0, 5185.444366689978, 5208.541608349668, 4239.660827133853, 4459.9331010034875, 4675.644063221662, 4765.546508314963, 4845.951540484621, 4621.399218101626, 5022.246663000543, 5039.472369341475, 5158.1746920492915, 5532.5297349724915, 4105.876823695294, 4109.794510274504, 4120.301202712229, 4121.608447197512, 4131.256373852705, 4871.780769865364, 5577.972110139464, 5600.767831077156, 5794.942050579482, 5845.970770146165, 4436.822527098944, 4949.406071271471, 4988.850334489971, 4998.775789615677, 5002.574781143643, 4468.687191896601, 4597.770111494412, 5138.38339399267, 5148.742562871841, 5195.68825870449, 4303.892402689895, 4550.832438908666, 4568.223402021597, 5281.521174071267, 5317.867053323621, 5647.752542288201, 5708.40061793514, 5713.857153571111, 5725.799597014085, 5766.625169364062, 1563.601281673166, 1609.8068231812024, 1691.2473949092537, 1725.6108832390046, 1729.697302971975, 1077.0, 1146.3122126724065, 1155.988510053703, 1156.3351073132815, 1171.1963576092721, 4442.6890117691455, 4462.509123996358, 4723.622110231173, 4886.511348865156, 4920.6309526785635, 5045.848624541196, 5128.948710512922, 5183.714895680774, 5456.181572764117, 5489.478499542537, 3921.254961557295, 4891.388576427947, 4980.950190498049, 5077.9434329096775, 5179.119549676564, 2382.7140743110936, 2739.7260273972443, 2888.321244507539, 2915.9125226243245, 2915.9271018224713, 5163.457836927144, 5327.413984461706, 5413.566914646819, 5448.591355648342, 5727.5131613812455, 4828.599706085266, 4863.902721945541, 5119.436861945183, 5159.613029022838, 5249.265102885599, 5465.398806131322, 5479.479449452296, 5579.066757935646, 5682.914756278659, 5684.289463817023, 4626.560476754703, 5100.95430436767, 5363.168708850135, 5572.721363931868, 5576.470235327637, 4584.724916505021, 5405.189301563087, 5436.238926550207, 5493.450654934474, 5493.752781124939, 4624.49130595641, 5142.0, 5448.6251086229995, 5767.394423585463, 5819.243498345188, 4150.667946564328, 4372.644480211017, 4417.409732496363, 4563.54364563541, 4672.135654903854, 4558.974230798044, 5369.785208591768, 5651.717414129195, 5740.502881246671, 5775.711214439178, 4734.502877197982, 4812.532177685839, 5385.892282154413, 5617.4101719320515, 5652.604317697722, 5403.9459605403445, 5584.609077364546, 5587.860303492445, 5592.2170896075395, 5640.661560306395, 4831.227003679394, 4982.825601103944, 4985.401751789808, 5262.605304602247, 5435.537979271648, 4841.426536375762, 4963.528464795839, 5174.6119041072825, 5585.128981791146, 5639.802606908738, 4430.933535997027, 4500.482444518922, 4564.908701825879, 5384.949934762683, 5477.0], "value": 4155.114463761882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.7897270305259, 722.5556282886023, 740.4557650127156, 768.6783388227136, 820.8686610142377, 14467.710645787078, 15116.244187790622, 15138.318775655094, 15149.015314004595, 15157.090574565535, 11084.0, 13547.18716876988, 13761.518346857862, 13882.167069975809, 13965.0, 931.9114684104999, 944.4946953379944, 950.0072424316571, 951.9000504946985, 953.5756588318201, 915.0, 920.9815803683922, 921.9170274675278, 924.5654542365078, 941.7692665297012, 1002.6791426743445, 1008.5310330696225, 1008.8083264179783, 1008.8991100889889, 1011.3022014809758, 1002.1231422505308, 1004.1866088468364, 1004.8743907011624, 1005.0, 1007.6271779441654, 744.0587656614388, 744.162816831065, 744.5197847388404, 745.6756311004731, 746.6080307838374, 15079.0, 15098.547795307355, 15142.772858407132, 15160.545183644508, 15208.16355100469, 13414.932925335312, 13767.173969561858, 13788.517401890886, 13801.792973105412, 13950.162990220619, 11336.0, 11389.601363952223, 11431.828522572168, 11562.53749850005, 12138.968187704057, 3584.5160903278247, 3624.2932628137523, 3685.1339935115225, 3735.2902948439983, 3744.0826997385543, 90816.54591727065, 92384.0, 93600.0, 93739.0, 95745.0, 8524.57377131141, 8680.782980425414, 10497.527611257512, 10703.304285221435, 10772.730681732863, 21321.040553174833, 21718.565628687655, 21749.34751957444, 21818.89090554537, 21828.126874925143, 7389.926100739031, 7432.256774322633, 7487.775366739006, 7528.585927774025, 7603.2776886195725, 3772.773633581994, 3896.5713771485116, 3960.108975480494, 3963.326234540135, 3979.4428779970826, 3359.227377703142, 3441.63862794408, 3453.8100404477996, 3455.87904423344, 3460.463628137643, 517.4515014085082, 595.4283887467992, 606.9172753961283, 612.8937268230798, 628.3465196195997, 623.9032949892774, 652.1652285075112, 680.1769858471305, 691.1153723234269, 707.989380159298, 8266.917330826614, 9144.268458523302, 9795.902040979641, 9881.75295617601, 9939.453330066772, 574.985151208118, 623.2458724942779, 646.9029645553111, 662.2086606505276, 676.1277951442584, 3980.5820388859333, 4039.131586708813, 4756.524347565285, 4769.308450274691, 4777.761111944389, 99111.0, 99420.50289748504, 100362.49818751005, 100966.0, 102292.0, 46552.7672361636, 68773.31226687669, 75919.0, 86852.56573717091, 89759.0, 69489.65255173692, 69736.30263697502, 69757.65121174463, 69870.0, 70333.73861690715, 8532.488050716976, 10062.647807326708, 10404.164450035063, 10642.361458312525, 10669.413182274739, 45015.0, 45369.773151135356, 45838.77080614575, 45932.7703361481, 46796.7660161697, 55251.44748552463, 55408.44591554033, 55680.721596391755, 56285.8742825133, 56607.71696141493, 10943.671689849318, 11654.30074195551, 12067.456964436797, 12130.636080917586, 12159.878401215874, 10049.894511603863, 11037.0, 11925.880741192477, 13663.111897726616, 14570.708585828435, 11544.59593914209, 12017.218880772722, 12236.0, 13157.210567365988, 13739.0, 12961.611151665466, 13057.673558161123, 13249.933750331187, 13413.646588352913, 13913.02608817373, 12913.418896149884, 13179.67050823737, 13408.530701425403, 13832.0, 13952.511662091778, 10456.738581535523, 10899.880840201111, 10985.395803230898, 11079.74032945965, 11481.483333250191, 8244.505329680238, 9683.467409292556, 10938.945305273422, 11159.268669356912, 11395.658130256106], "value": 7244.858806708096, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1451.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 113.0, 106.0, 147.0, 110.0, 110.0, 110.0, 105.0, 129.0, 110.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 185.0, 184.0, 188.0, 196.0, 258.0, 191.0, 186.0, 186.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 60.0, 91.0, 59.0, 62.0, 60.0, 61.0, 78.0, 60.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 70.0, 91.0, 70.0, 70.0, 69.0, 85.0, 69.0, 68.0, 84.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 89.0, 88.0, 87.0, 87.0, 88.0, 87.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 87.0, 84.0, 84.0, 86.0, 85.0, 83.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 63.0, 64.0, 63.0, 62.0, 61.0, 83.0, 95.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 66.0, 60.0, 60.0, 65.0, 60.0, 58.0, 58.0, 58.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 90.0, 88.0, 87.0, 90.0, 86.0, 88.0, 93.0, 94.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 166.0, 149.0, 148.0, 141.0, 139.0, 142.0, 138.0, 183.0, 159.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 173.0, 173.0, 172.0, 172.0, 172.0, 171.0, 152.0, 223.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 66.0, 66.0, 65.0, 64.0, 67.0, 65.0], "value": 66.4, "unit": "score"}]}]} 07:23:16 INFO - Return code: 0 07:23:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:23:16 ERROR - # TBPL SUCCESS # 07:23:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:23:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:23:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:23:16 INFO - 2017-03-02 07:23:16.930 screenresolution[1930:23405] starting screenresolution argv=screenresolution get 07:23:16 INFO - 2017-03-02 07:23:16.935 screenresolution[1930:23405] Display 0: 1600x1200x32@60 07:23:16 INFO - 2017-03-02 07:23:16.941 screenresolution[1931:23408] starting screenresolution argv=screenresolution list 07:23:16 INFO - Available Modes on Display 0 07:23:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:23:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:23:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:23:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:23:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:23:17 INFO - Intel Iris: 07:23:17 INFO - Chipset Model: Intel Iris 07:23:17 INFO - Type: GPU 07:23:17 INFO - Bus: Built-In 07:23:17 INFO - VRAM (Dynamic, Max): 1536 MB 07:23:17 INFO - Vendor: Intel (0x8086) 07:23:17 INFO - Device ID: 0x0a2e 07:23:17 INFO - Revision ID: 0x0009 07:23:17 INFO - Displays: 07:23:17 INFO - Display: 07:23:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:23:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:23:17 INFO - Display Serial Number: 1600x1200 60 07:23:17 INFO - Main Display: Yes 07:23:17 INFO - Mirror: Off 07:23:17 INFO - Online: Yes 07:23:17 INFO - Rotation: Supported 07:23:17 INFO - Return code: 0 07:23:17 INFO - Running post-action listener: _resource_record_post_action 07:23:17 INFO - [mozharness: 2017-03-02 15:23:17.178902Z] Finished run-tests step (success) 07:23:17 INFO - Running post-run listener: _resource_record_post_run 07:23:17 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 434176; Write bytes: 510537728; Read time: 8; Write time: 1680 07:23:17 INFO - TinderboxPrint: CPU usage
53.7% 07:23:17 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 8 07:23:17 INFO - TinderboxPrint: I/O write bytes / time
510,537,728 / 1,680 07:23:17 INFO - TinderboxPrint: CPU idle
2,227.9 (46.3%) 07:23:17 INFO - TinderboxPrint: CPU system
958.4 (19.9%) 07:23:17 INFO - TinderboxPrint: CPU user
1,627.4 (33.8%) 07:23:17 INFO - TinderboxPrint: Swap in / out
211,312,640 / 0 07:23:17 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203944448; Write bytes: 203741184; Read time: 15718; Write time: 415 07:23:17 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 434176; Write bytes: 296126464; Read time: 8; Write time: 1230 07:23:17 INFO - Running post-run listener: _upload_blobber_files 07:23:17 INFO - Blob upload gear active. 07:23:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:23:17 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 07:23:17 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'] 07:23:17 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 07:23:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:23:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:18 INFO - (blobuploader) - INFO - Done attempting. 07:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:23:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:20 INFO - (blobuploader) - INFO - Done attempting. 07:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:23:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:21 INFO - (blobuploader) - INFO - Done attempting. 07:23:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:23:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:23:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:24 INFO - (blobuploader) - INFO - Done attempting. 07:23:24 INFO - (blobuploader) - INFO - Iteration through files over. 07:23:24 INFO - Return code: 0 07:23:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:23:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:23:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78ee210e357f15c1e7929ad72b1fced675221d7b627404e6e3f4adf94555bac5f9087cf74a10ba28ffabaae2cb7de8f1560b8034253dc75b4d65624b27a30b2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b2ef68967b76ebf2c01586d46915d58d062eb946d8480cc2333bded82903458e9c690c29fedd37fae24a3d6fe1a778606b2781c2854397e041235acc7a7eef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/426c7f16d5433b9bae518201b77e3976621101c254cde566b5e709eb5818b1d73255eff1cb1aa776f618b420bc0fe8992191de68bf78778e21bb96d9a13d0c26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef39f6ed8a121cf9b2da5996ff20197a7488b6c6c72d0e220adedf2acc4fbef0304f2cfab27e4c2f08ad4b7477ddf6791e2bdfb9b8123c2344b17956d28019fb"} 07:23:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:23:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:23:24 INFO - Contents: 07:23:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78ee210e357f15c1e7929ad72b1fced675221d7b627404e6e3f4adf94555bac5f9087cf74a10ba28ffabaae2cb7de8f1560b8034253dc75b4d65624b27a30b2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b2ef68967b76ebf2c01586d46915d58d062eb946d8480cc2333bded82903458e9c690c29fedd37fae24a3d6fe1a778606b2781c2854397e041235acc7a7eef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/426c7f16d5433b9bae518201b77e3976621101c254cde566b5e709eb5818b1d73255eff1cb1aa776f618b420bc0fe8992191de68bf78778e21bb96d9a13d0c26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef39f6ed8a121cf9b2da5996ff20197a7488b6c6c72d0e220adedf2acc4fbef0304f2cfab27e4c2f08ad4b7477ddf6791e2bdfb9b8123c2344b17956d28019fb"} 07:23:24 INFO - Running post-run listener: copy_logs_to_upload_dir 07:23:24 INFO - Copying logs to upload dir... 07:23:24 INFO - mkdir: /builds/slave/test/build/upload/logs 07:23:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.902298 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-02 07:23:24.242362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 07:23:24.246346) ========= 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.XVdvW2a4qp/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.a7AMydosqj/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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/78ee210e357f15c1e7929ad72b1fced675221d7b627404e6e3f4adf94555bac5f9087cf74a10ba28ffabaae2cb7de8f1560b8034253dc75b4d65624b27a30b2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b2ef68967b76ebf2c01586d46915d58d062eb946d8480cc2333bded82903458e9c690c29fedd37fae24a3d6fe1a778606b2781c2854397e041235acc7a7eef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/426c7f16d5433b9bae518201b77e3976621101c254cde566b5e709eb5818b1d73255eff1cb1aa776f618b420bc0fe8992191de68bf78778e21bb96d9a13d0c26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef39f6ed8a121cf9b2da5996ff20197a7488b6c6c72d0e220adedf2acc4fbef0304f2cfab27e4c2f08ad4b7477ddf6791e2bdfb9b8123c2344b17956d28019fb"} build_url:https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/d0xfMhg0QPGFTydySijucg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78ee210e357f15c1e7929ad72b1fced675221d7b627404e6e3f4adf94555bac5f9087cf74a10ba28ffabaae2cb7de8f1560b8034253dc75b4d65624b27a30b2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b2ef68967b76ebf2c01586d46915d58d062eb946d8480cc2333bded82903458e9c690c29fedd37fae24a3d6fe1a778606b2781c2854397e041235acc7a7eef7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/426c7f16d5433b9bae518201b77e3976621101c254cde566b5e709eb5818b1d73255eff1cb1aa776f618b420bc0fe8992191de68bf78778e21bb96d9a13d0c26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef39f6ed8a121cf9b2da5996ff20197a7488b6c6c72d0e220adedf2acc4fbef0304f2cfab27e4c2f08ad4b7477ddf6791e2bdfb9b8123c2344b17956d28019fb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 07:23:24.283228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 07:23:24.283878) ========= 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.XVdvW2a4qp/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.a7AMydosqj/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005402 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 07:23:24.333127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 07:23:24.333689) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 07:23:24.334089) ========= ========= Total master_lag: 0.18 =========