builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0253 starttime: 1493913221.11 results: success (0) buildid: 20170504074819 builduid: 559598d21ecc42628a19321802e7f15e revision: 94d16b8d4a52f8a325888249ea77d98c6f6ebe18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.109339) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.109839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.110185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.144648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.145073) ========= 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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-05-04 08:53:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-05-04 08:53:41 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134638 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.305362) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.305718) ========= 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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.028372 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:41.357984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 08:53:41.358391) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 94d16b8d4a52f8a325888249ea77d98c6f6ebe18 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 94d16b8d4a52f8a325888249ea77d98c6f6ebe18 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.g6c3yWq2Wh/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.qP4GIskK4l/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-05-04 08:53:41,465 truncating revision to first 12 chars 2017-05-04 08:53:41,465 Setting DEBUG logging. 2017-05-04 08:53:41,465 attempt 1/10 2017-05-04 08:53:41,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/94d16b8d4a52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 08:53:42,519 unpacking tar archive at: mozilla-beta-94d16b8d4a52/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336429 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 08:53:42.719907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:42.720370) ========= script_repo_revision: 94d16b8d4a52f8a325888249ea77d98c6f6ebe18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:42.720802) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:42.721204) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 08:53:42.746595) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-04 08:53:42.747104) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.g6c3yWq2Wh/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.qP4GIskK4l/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:53:42 INFO - MultiFileLogger online at 20170504 08:53:42 in /builds/slave/test 08:53:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:53:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:42 INFO - {'append_to_log': False, 08:53:42 INFO - 'base_work_dir': '/builds/slave/test', 08:53:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:53:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:42 INFO - 'branch': 'Mozilla-Beta', 08:53:42 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:42 INFO - 'config_files': ('talos/mac_config.py',), 08:53:42 INFO - 'default_actions': ('clobber', 08:53:42 INFO - 'read-buildbot-config', 08:53:42 INFO - 'download-and-extract', 08:53:42 INFO - 'populate-webroot', 08:53:42 INFO - 'create-virtualenv', 08:53:42 INFO - 'install', 08:53:42 INFO - 'run-tests'), 08:53:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:42 INFO - 'download_minidump_stackwalk': True, 08:53:42 INFO - 'download_symbols': 'ondemand', 08:53:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:42 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:42 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:42 INFO - 'gecko_profile': False, 08:53:42 INFO - 'gecko_profile_interval': 0, 08:53:42 INFO - 'installer_path': 'installer.exe', 08:53:42 INFO - 'log_level': 'info', 08:53:42 INFO - 'log_name': 'talos', 08:53:42 INFO - 'log_to_console': True, 08:53:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:53:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:53:42 INFO - 'opt_config_files': (), 08:53:42 INFO - 'pip_index': False, 08:53:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:42 INFO - 'cmd': ('bash', 08:53:42 INFO - '-c', 08:53:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:42 INFO - 'enabled': True, 08:53:42 INFO - 'halt_on_failure': False, 08:53:42 INFO - 'name': 'check_screen_resolution'},), 08:53:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:42 INFO - 'cmd': ('bash', 08:53:42 INFO - '-c', 08:53:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:42 INFO - 'enabled': True, 08:53:42 INFO - 'halt_on_failure': False, 08:53:42 INFO - 'name': 'check_screen_resolution'},), 08:53:42 INFO - 'run_cmd_checks_enabled': True, 08:53:42 INFO - 'suite': 'dromaeojs', 08:53:42 INFO - 'system_bits': '32', 08:53:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:42 INFO - 'title': 't-yosemite-r7-0253', 08:53:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:42 INFO - 'use_talos_json': True, 08:53:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:42 INFO - 'work_dir': 'build'} 08:53:42 INFO - [mozharness: 2017-05-04 15:53:42.960215Z] Running clobber step. 08:53:42 INFO - Running pre-action listener: _resource_record_pre_action 08:53:42 INFO - Running main action method: clobber 08:53:42 INFO - rmtree: /builds/slave/test/build 08:53:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:45 INFO - Running post-action listener: _resource_record_post_action 08:53:45 INFO - [mozharness: 2017-05-04 15:53:45.456140Z] Finished clobber step (success) 08:53:45 INFO - [mozharness: 2017-05-04 15:53:45.456287Z] Running read-buildbot-config step. 08:53:45 INFO - Running pre-action listener: _resource_record_pre_action 08:53:45 INFO - Running main action method: read_buildbot_config 08:53:45 INFO - Using buildbot properties: 08:53:45 INFO - { 08:53:45 INFO - "project": "", 08:53:45 INFO - "product": "firefox", 08:53:45 INFO - "script_repo_revision": "production", 08:53:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:53:45 INFO - "repository": "", 08:53:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:53:45 INFO - "buildid": "20170504074819", 08:53:45 INFO - "pgo_build": "False", 08:53:45 INFO - "basedir": "/builds/slave/test", 08:53:45 INFO - "buildnumber": 25, 08:53:45 INFO - "slavename": "t-yosemite-r7-0253", 08:53:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:53:45 INFO - "platform": "yosemite_r7", 08:53:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:53:45 INFO - "branch": "mozilla-beta", 08:53:45 INFO - "repo_path": "releases/mozilla-beta", 08:53:45 INFO - "revision": "94d16b8d4a52f8a325888249ea77d98c6f6ebe18", 08:53:45 INFO - "stage_platform": "macosx64", 08:53:45 INFO - "builduid": "559598d21ecc42628a19321802e7f15e", 08:53:45 INFO - "slavebuilddir": "test" 08:53:45 INFO - } 08:53:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 08:53:45 INFO - Running post-action listener: _resource_record_post_action 08:53:45 INFO - [mozharness: 2017-05-04 15:53:45.459569Z] Finished read-buildbot-config step (success) 08:53:45 INFO - [mozharness: 2017-05-04 15:53:45.459674Z] Running download-and-extract step. 08:53:45 INFO - Running pre-action listener: _resource_record_pre_action 08:53:45 INFO - Running main action method: download_and_extract 08:53:45 INFO - mkdir: /builds/slave/test/build/tests 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - trying https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 08:53:45 INFO - Downloading https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 08:53:46 INFO - Downloaded 1287 bytes. 08:53:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:53:46 INFO - Using the following test package requirements: 08:53:46 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 08:53:46 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:53:46 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 08:53:46 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 08:53:46 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:53:46 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 08:53:46 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:53:46 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 08:53:46 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 08:53:46 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 08:53:46 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 08:53:46 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 08:53:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:53:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:53:46 INFO - Fetch https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:53:47 INFO - Expected file size: 51223838 08:53:47 INFO - Obtained file size: 51223838 08:54:03 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:54:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:54:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:54:03 INFO - Fetch https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:54:05 INFO - Expected file size: 51223838 08:54:05 INFO - Obtained file size: 51223838 08:54:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 08:54:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 08:54:21 INFO - Fetch https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 08:54:22 INFO - Expected file size: 14404449 08:54:22 INFO - Obtained file size: 14404449 08:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:22 INFO - trying https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:54:22 INFO - Downloading https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 08:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 08:54:24 INFO - Downloaded 59562141 bytes. 08:54:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:54:24 INFO - mkdir: /builds/slave/test/properties 08:54:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:24 INFO - Contents: 08:54:24 INFO - build_url:https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:54:25 INFO - Running post-action listener: _resource_record_post_action 08:54:25 INFO - Running post-action listener: set_extra_try_arguments 08:54:25 INFO - [mozharness: 2017-05-04 15:54:25.048334Z] Finished download-and-extract step (success) 08:54:25 INFO - [mozharness: 2017-05-04 15:54:25.048461Z] Running populate-webroot step. 08:54:25 INFO - Running pre-action listener: _resource_record_pre_action 08:54:25 INFO - Running main action method: populate_webroot 08:54:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:25 INFO - '--tppagecycles', 08:54:25 INFO - '7'], 08:54:25 INFO - 'tests': ['tsvgm']}}, 08:54:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:54:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:54:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:54:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:54:25 INFO - 'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:54:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:54:25 INFO - 'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['damp', 'tps']}, 08:54:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:54:25 INFO - 'tests': ['damp', 'tps']}, 08:54:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['dromaeo_dom']}, 08:54:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['basic_compositor_video']}, 08:54:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:54:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['a11yr', 08:54:25 INFO - 'ts_paint', 08:54:25 INFO - 'tpaint', 08:54:25 INFO - 'sessionrestore', 08:54:25 INFO - 'sessionrestore_no_auto_restore', 08:54:25 INFO - 'tabpaint']}, 08:54:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:54:25 INFO - 'ts_paint', 08:54:25 INFO - 'tpaint', 08:54:25 INFO - 'sessionrestore', 08:54:25 INFO - 'sessionrestore_no_auto_restore', 08:54:25 INFO - 'tabpaint']}, 08:54:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:54:25 INFO - 'ts_paint', 08:54:25 INFO - 'tpaint', 08:54:25 INFO - 'sessionrestore', 08:54:25 INFO - 'sessionrestore_no_auto_restore', 08:54:25 INFO - 'tabpaint']}, 08:54:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:54:25 INFO - 'ts_paint', 08:54:25 INFO - 'tpaint', 08:54:25 INFO - 'sessionrestore', 08:54:25 INFO - 'sessionrestore_no_auto_restore', 08:54:25 INFO - 'tabpaint']}, 08:54:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['a11yr', 08:54:25 INFO - 'ts_paint', 08:54:25 INFO - 'tpaint', 08:54:25 INFO - 'sessionrestore', 08:54:25 INFO - 'sessionrestore_no_auto_restore', 08:54:25 INFO - 'tabpaint']}, 08:54:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['a11yr', 08:54:25 INFO - 'ts_paint', 08:54:25 INFO - 'tpaint', 08:54:25 INFO - 'sessionrestore', 08:54:25 INFO - 'sessionrestore_no_auto_restore', 08:54:25 INFO - 'tabpaint']}, 08:54:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['tsvgx', 08:54:25 INFO - 'tsvgr_opacity', 08:54:25 INFO - 'tart', 08:54:25 INFO - 'tscrollx', 08:54:25 INFO - 'cart', 08:54:25 INFO - 'tsvg_static']}, 08:54:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:54:25 INFO - 'tsvgr_opacity', 08:54:25 INFO - 'tart', 08:54:25 INFO - 'tscrollx', 08:54:25 INFO - 'cart', 08:54:25 INFO - 'tsvg_static']}, 08:54:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:54:25 INFO - 'talos_options': ['--disable-e10s'], 08:54:25 INFO - 'tests': ['tp5o']}, 08:54:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:54:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:54:25 INFO - 'talos_options': ['--disable-e10s', 08:54:25 INFO - '--xperf_path', 08:54:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:25 INFO - 'tests': ['tp5n']}, 08:54:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:54:25 INFO - 'talos_options': ['--xperf_path', 08:54:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:25 INFO - 'tests': ['tp5n']}}, 08:54:25 INFO - 'talos.zip': {'path': '', 08:54:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:25 INFO - Running post-action listener: _resource_record_post_action 08:54:25 INFO - [mozharness: 2017-05-04 15:54:25.066808Z] Finished populate-webroot step (success) 08:54:25 INFO - [mozharness: 2017-05-04 15:54:25.066947Z] Running create-virtualenv step. 08:54:25 INFO - Running pre-action listener: _resource_record_pre_action 08:54:25 INFO - Running main action method: create_virtualenv 08:54:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:54:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:25 INFO - Using real prefix '/tools/python27' 08:54:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:28 INFO - Installing pip.................done. 08:54:28 INFO - Return code: 0 08:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:54:29 INFO - Reading from file tmpfile_stdout 08:54:29 INFO - Output received: 08:54:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:54:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:29 INFO - 'HOME': '/Users/cltbld', 08:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:29 INFO - 'LOGNAME': 'cltbld', 08:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:29 INFO - 'MOZ_NO_REMOTE': '1', 08:54:29 INFO - 'NO_EM_RESTART': '1', 08:54:29 INFO - 'PAGER': '/bin/cat', 08:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:29 INFO - 'PWD': '/builds/slave/test', 08:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:29 INFO - 'SHELL': '/bin/bash', 08:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:29 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:29 INFO - 'USER': 'cltbld', 08:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:29 INFO - 'XPC_FLAGS': '0x0', 08:54:29 INFO - 'XPC_SERVICE_NAME': '0', 08:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:54:29 INFO - Cleaning up... 08:54:29 INFO - Return code: 0 08:54:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:29 INFO - 'HOME': '/Users/cltbld', 08:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:29 INFO - 'LOGNAME': 'cltbld', 08:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:29 INFO - 'MOZ_NO_REMOTE': '1', 08:54:29 INFO - 'NO_EM_RESTART': '1', 08:54:29 INFO - 'PAGER': '/bin/cat', 08:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:29 INFO - 'PWD': '/builds/slave/test', 08:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:29 INFO - 'SHELL': '/bin/bash', 08:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:29 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:29 INFO - 'USER': 'cltbld', 08:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:29 INFO - 'XPC_FLAGS': '0x0', 08:54:29 INFO - 'XPC_SERVICE_NAME': '0', 08:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:29 INFO - Downloading/unpacking psutil>=3.1.1 08:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:32 INFO - Installing collected packages: psutil 08:54:32 INFO - Running setup.py install for psutil 08:54:32 INFO - building 'psutil._psutil_osx' extension 08:54:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:54:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:54:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:54:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:54:33 INFO - building 'psutil._psutil_posix' extension 08:54:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:54:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:54:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:54:33 INFO - ^ 08:54:33 INFO - 1 warning generated. 08:54:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:33 INFO - Successfully installed psutil 08:54:33 INFO - Cleaning up... 08:54:33 INFO - Return code: 0 08:54:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:33 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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:33 INFO - 'HOME': '/Users/cltbld', 08:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:33 INFO - 'LOGNAME': 'cltbld', 08:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:33 INFO - 'MOZ_NO_REMOTE': '1', 08:54:33 INFO - 'NO_EM_RESTART': '1', 08:54:33 INFO - 'PAGER': '/bin/cat', 08:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:33 INFO - 'PWD': '/builds/slave/test', 08:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:33 INFO - 'SHELL': '/bin/bash', 08:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:33 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:33 INFO - 'USER': 'cltbld', 08:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:33 INFO - 'XPC_FLAGS': '0x0', 08:54:33 INFO - 'XPC_SERVICE_NAME': '0', 08:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:54:35 INFO - Installing collected packages: mozsystemmonitor 08:54:35 INFO - Running setup.py install for mozsystemmonitor 08:54:35 INFO - Successfully installed mozsystemmonitor 08:54:35 INFO - Cleaning up... 08:54:35 INFO - Return code: 0 08:54:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:35 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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:35 INFO - 'HOME': '/Users/cltbld', 08:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:35 INFO - 'LOGNAME': 'cltbld', 08:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:35 INFO - 'MOZ_NO_REMOTE': '1', 08:54:35 INFO - 'NO_EM_RESTART': '1', 08:54:35 INFO - 'PAGER': '/bin/cat', 08:54:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:35 INFO - 'PWD': '/builds/slave/test', 08:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:35 INFO - 'SHELL': '/bin/bash', 08:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:35 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:35 INFO - 'USER': 'cltbld', 08:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:35 INFO - 'XPC_FLAGS': '0x0', 08:54:35 INFO - 'XPC_SERVICE_NAME': '0', 08:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:54:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:54:37 INFO - warning: no files found matching '*.txt' 08:54:37 INFO - no previously-included directories found matching 'build' 08:54:37 INFO - no previously-included directories found matching 'dist' 08:54:37 INFO - no previously-included directories found matching '.git*' 08:54:37 INFO - Installing collected packages: jsonschema, functools32 08:54:37 INFO - Running setup.py install for functools32 08:54:37 INFO - warning: no files found matching '*.txt' 08:54:37 INFO - no previously-included directories found matching 'build' 08:54:37 INFO - no previously-included directories found matching 'dist' 08:54:37 INFO - no previously-included directories found matching '.git*' 08:54:37 INFO - Successfully installed jsonschema functools32 08:54:37 INFO - Cleaning up... 08:54:37 INFO - Return code: 0 08:54:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:37 INFO - 'HOME': '/Users/cltbld', 08:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:37 INFO - 'LOGNAME': 'cltbld', 08:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:37 INFO - 'MOZ_NO_REMOTE': '1', 08:54:37 INFO - 'NO_EM_RESTART': '1', 08:54:37 INFO - 'PAGER': '/bin/cat', 08:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:37 INFO - 'PWD': '/builds/slave/test', 08:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:37 INFO - 'SHELL': '/bin/bash', 08:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:37 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:37 INFO - 'USER': 'cltbld', 08:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:37 INFO - 'XPC_FLAGS': '0x0', 08:54:37 INFO - 'XPC_SERVICE_NAME': '0', 08:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:54:37 INFO - Cleaning up... 08:54:37 INFO - Return code: 0 08:54:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:37 INFO - 'HOME': '/Users/cltbld', 08:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:37 INFO - 'LOGNAME': 'cltbld', 08:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:37 INFO - 'MOZ_NO_REMOTE': '1', 08:54:37 INFO - 'NO_EM_RESTART': '1', 08:54:37 INFO - 'PAGER': '/bin/cat', 08:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:37 INFO - 'PWD': '/builds/slave/test', 08:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:37 INFO - 'SHELL': '/bin/bash', 08:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:37 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:37 INFO - 'USER': 'cltbld', 08:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:37 INFO - 'XPC_FLAGS': '0x0', 08:54:37 INFO - 'XPC_SERVICE_NAME': '0', 08:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:54:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:40 INFO - Downloading docopt-0.6.1.tar.gz 08:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:40 INFO - Running setup.py install for blobuploader 08:54:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:54:40 INFO - Running setup.py install for requests 08:54:40 INFO - Running setup.py install for docopt 08:54:41 INFO - Successfully installed blobuploader requests docopt 08:54:41 INFO - Cleaning up... 08:54:41 INFO - Return code: 0 08:54:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:41 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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:41 INFO - 'HOME': '/Users/cltbld', 08:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:41 INFO - 'LOGNAME': 'cltbld', 08:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:41 INFO - 'MOZ_NO_REMOTE': '1', 08:54:41 INFO - 'NO_EM_RESTART': '1', 08:54:41 INFO - 'PAGER': '/bin/cat', 08:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:41 INFO - 'PWD': '/builds/slave/test', 08:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:41 INFO - 'SHELL': '/bin/bash', 08:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:41 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:41 INFO - 'USER': 'cltbld', 08:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:41 INFO - 'XPC_FLAGS': '0x0', 08:54:41 INFO - 'XPC_SERVICE_NAME': '0', 08:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:41 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ITiQD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:41 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-VFTmM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:41 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-AJxQ03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:41 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-gFUhQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:41 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-UhWBDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:41 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zygMPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:41 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-slVVkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-t0uiCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-lnYjwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ve9jFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-m1G2VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-efi0P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-S579z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-aicOmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-dHw_t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:42 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-QoNGzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:43 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-BY6bpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:43 INFO - Running setup.py install for manifestparser 08:54:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:54:43 INFO - Running setup.py install for mozcrash 08:54:43 INFO - Running setup.py install for mozdebug 08:54:43 INFO - Running setup.py install for mozdevice 08:54:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:54:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:54:43 INFO - Running setup.py install for mozfile 08:54:43 INFO - Running setup.py install for mozhttpd 08:54:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Running setup.py install for mozinfo 08:54:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Running setup.py install for mozInstall 08:54:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Running setup.py install for mozleak 08:54:44 INFO - Running setup.py install for mozlog 08:54:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Running setup.py install for moznetwork 08:54:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:54:44 INFO - Running setup.py install for mozprocess 08:54:44 INFO - Running setup.py install for mozprofile 08:54:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:54:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:54:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:54:45 INFO - Running setup.py install for mozrunner 08:54:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:54:45 INFO - Running setup.py install for mozscreenshot 08:54:45 INFO - Running setup.py install for moztest 08:54:45 INFO - Running setup.py install for mozversion 08:54:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:54:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:45 INFO - Cleaning up... 08:54:45 INFO - Return code: 0 08:54:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:45 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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:45 INFO - 'HOME': '/Users/cltbld', 08:54:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:45 INFO - 'LOGNAME': 'cltbld', 08:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:45 INFO - 'MOZ_NO_REMOTE': '1', 08:54:45 INFO - 'NO_EM_RESTART': '1', 08:54:45 INFO - 'PAGER': '/bin/cat', 08:54:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:45 INFO - 'PWD': '/builds/slave/test', 08:54:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:45 INFO - 'SHELL': '/bin/bash', 08:54:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:45 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:45 INFO - 'USER': 'cltbld', 08:54:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:45 INFO - 'XPC_FLAGS': '0x0', 08:54:45 INFO - 'XPC_SERVICE_NAME': '0', 08:54:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-_VR74y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-59_Wuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PkqStv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jEvrAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jiYenz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ODGd5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-CkY8jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-8FrYiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-u0hF0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-6Vxha2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:47 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-fgr7lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:47 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-NA_VUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:47 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)) 08:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:47 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-I3UO7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:47 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-OUWKR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:47 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-skyKgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:47 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-uc6M8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:47 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)) 08:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:47 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zd4RSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:49 INFO - Downloading blessings-1.6.tar.gz 08:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:49 INFO - Installing collected packages: blessings 08:54:49 INFO - Running setup.py install for blessings 08:54:49 INFO - Successfully installed blessings 08:54:49 INFO - Cleaning up... 08:54:49 INFO - Return code: 0 08:54:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:54:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:49 INFO - Reading from file tmpfile_stdout 08:54:49 INFO - Current package versions: 08:54:49 INFO - blessings == 1.6 08:54:49 INFO - blobuploader == 1.2.4 08:54:49 INFO - docopt == 0.6.1 08:54:49 INFO - functools32 == 3.2.3-2 08:54:49 INFO - jsonschema == 2.5.1 08:54:49 INFO - manifestparser == 1.1 08:54:49 INFO - mozInstall == 1.12 08:54:49 INFO - mozcrash == 1.0 08:54:49 INFO - mozdebug == 0.1 08:54:49 INFO - mozdevice == 0.49 08:54:49 INFO - mozfile == 1.2 08:54:49 INFO - mozhttpd == 0.7 08:54:49 INFO - mozinfo == 0.9 08:54:49 INFO - mozleak == 0.1 08:54:49 INFO - mozlog == 3.4 08:54:49 INFO - moznetwork == 0.27 08:54:49 INFO - mozprocess == 0.25 08:54:49 INFO - mozprofile == 0.28 08:54:49 INFO - mozrunner == 6.13 08:54:49 INFO - mozscreenshot == 0.1 08:54:49 INFO - mozsystemmonitor == 0.3 08:54:49 INFO - moztest == 0.8 08:54:49 INFO - mozversion == 1.4 08:54:49 INFO - psutil == 3.1.1 08:54:49 INFO - requests == 1.2.3 08:54:49 INFO - wsgiref == 0.1.2 08:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:49 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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:49 INFO - 'HOME': '/Users/cltbld', 08:54:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:49 INFO - 'LOGNAME': 'cltbld', 08:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:49 INFO - 'MOZ_NO_REMOTE': '1', 08:54:49 INFO - 'NO_EM_RESTART': '1', 08:54:49 INFO - 'PAGER': '/bin/cat', 08:54:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:49 INFO - 'PWD': '/builds/slave/test', 08:54:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:49 INFO - 'SHELL': '/bin/bash', 08:54:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:49 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:49 INFO - 'USER': 'cltbld', 08:54:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:49 INFO - 'XPC_FLAGS': '0x0', 08:54:49 INFO - 'XPC_SERVICE_NAME': '0', 08:54:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:54:49 INFO - Cleaning up... 08:54:50 INFO - Return code: 0 08:54:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:50 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 0x1058d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8651d71e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, '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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:50 INFO - 'HOME': '/Users/cltbld', 08:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:50 INFO - 'LOGNAME': 'cltbld', 08:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:50 INFO - 'MOZ_NO_REMOTE': '1', 08:54:50 INFO - 'NO_EM_RESTART': '1', 08:54:50 INFO - 'PAGER': '/bin/cat', 08:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:50 INFO - 'PWD': '/builds/slave/test', 08:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:50 INFO - 'SHELL': '/bin/bash', 08:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:54:50 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:50 INFO - 'USER': 'cltbld', 08:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:50 INFO - 'XPC_FLAGS': '0x0', 08:54:50 INFO - 'XPC_SERVICE_NAME': '0', 08:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:54:50 INFO - Cleaning up... 08:54:50 INFO - Return code: 0 08:54:50 INFO - Running post-action listener: _resource_record_post_action 08:54:50 INFO - Running post-action listener: _start_resource_monitoring 08:54:50 INFO - Starting resource monitoring. 08:54:50 INFO - [mozharness: 2017-05-04 15:54:50.300582Z] Finished create-virtualenv step (success) 08:54:50 INFO - [mozharness: 2017-05-04 15:54:50.301543Z] Running install step. 08:54:50 INFO - Running pre-action listener: _resource_record_pre_action 08:54:50 INFO - Running main action method: install 08:54:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:50 INFO - Reading from file tmpfile_stdout 08:54:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:54:50 INFO - Reading from file tmpfile_stdout 08:54:50 INFO - Output received: 08:54:50 INFO - Usage: mozinstall [options] installer 08:54:50 INFO - Options: 08:54:50 INFO - -h, --help show this help message and exit 08:54:50 INFO - -d DEST, --destination=DEST 08:54:50 INFO - Directory to install application into. [default: 08:54:50 INFO - "/builds/slave/test"] 08:54:50 INFO - --app=APP Application being installed. [default: firefox] 08:54:50 INFO - mkdir: /builds/slave/test/build/application 08:54:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:55:05 INFO - Reading from file tmpfile_stdout 08:55:05 INFO - Output received: 08:55:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:55:05 INFO - Running post-action listener: _resource_record_post_action 08:55:05 INFO - [mozharness: 2017-05-04 15:55:05.228056Z] Finished install step (success) 08:55:05 INFO - [mozharness: 2017-05-04 15:55:05.228210Z] Running run-tests step. 08:55:05 INFO - Running pre-action listener: _resource_record_pre_action 08:55:05 INFO - Running main action method: run_tests 08:55:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:55:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:55:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:55:05 INFO - 2017-05-04 08:55:05.242 screenresolution[1641:10062] starting screenresolution argv=screenresolution get 08:55:05 INFO - 2017-05-04 08:55:05.245 screenresolution[1641:10062] Display 0: 1600x1200x32@60 08:55:05 INFO - 2017-05-04 08:55:05.250 screenresolution[1642:10064] starting screenresolution argv=screenresolution list 08:55:05 INFO - Available Modes on Display 0 08:55:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:55:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:55:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:55:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:55:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:55:05 INFO - Intel Iris: 08:55:05 INFO - Chipset Model: Intel Iris 08:55:05 INFO - Type: GPU 08:55:05 INFO - Bus: Built-In 08:55:05 INFO - VRAM (Dynamic, Max): 1536 MB 08:55:05 INFO - Vendor: Intel (0x8086) 08:55:05 INFO - Device ID: 0x0a2e 08:55:05 INFO - Revision ID: 0x0009 08:55:05 INFO - Displays: 08:55:05 INFO - Display: 08:55:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:55:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:55:05 INFO - Display Serial Number: 1600x1200 60 08:55:05 INFO - Main Display: Yes 08:55:05 INFO - Mirror: Off 08:55:05 INFO - Online: Yes 08:55:05 INFO - Rotation: Supported 08:55:05 INFO - Return code: 0 08:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:05 INFO - Python 2.7.3 08:55:05 INFO - Return code: 0 08:55:05 INFO - grabbing minidump binary from tooltool 08:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:05 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 0x1056b6d30>, '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 0x1055dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056abbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:55:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:55:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:55:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:05 INFO - Return code: 0 08:55:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:55:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:05 INFO - ENV: RUST_BACKTRACE is now 1 08:55:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:55:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0253 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g6c3yWq2Wh/Render', 08:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:05 INFO - 'HOME': '/Users/cltbld', 08:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:05 INFO - 'LOGNAME': 'cltbld', 08:55:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:05 INFO - 'MOZ_NO_REMOTE': '1', 08:55:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:05 INFO - 'NO_EM_RESTART': '1', 08:55:05 INFO - 'PAGER': '/bin/cat', 08:55:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:05 INFO - 'PWD': '/builds/slave/test', 08:55:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:05 INFO - 'RUST_BACKTRACE': '1', 08:55:05 INFO - 'SHELL': '/bin/bash', 08:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qP4GIskK4l/Listeners', 08:55:05 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 08:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:05 INFO - 'USER': 'cltbld', 08:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:05 INFO - 'XPC_FLAGS': '0x0', 08:55:05 INFO - 'XPC_SERVICE_NAME': '0', 08:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:55:05 INFO - mozversion application_buildid: 20170504074819 08:55:05 INFO - mozversion application_changeset: 94d16b8d4a52f8a325888249ea77d98c6f6ebe18 08:55:05 INFO - mozversion application_display_name: Firefox 08:55:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:05 INFO - mozversion application_name: Firefox 08:55:05 INFO - mozversion application_remotingname: firefox 08:55:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:55:05 INFO - mozversion application_vendor: Mozilla 08:55:05 INFO - mozversion application_version: 54.0 08:55:05 INFO - mozversion platform_buildid: 20170504074819 08:55:05 INFO - mozversion platform_changeset: 94d16b8d4a52f8a325888249ea77d98c6f6ebe18 08:55:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:55:05 INFO - mozversion platform_version: 54.0 08:55:05 INFO - using testdate: 1493913305 08:55:05 INFO - actual date: 1493913305 08:55:05 INFO - starting webserver on 'localhost:49237' 08:55:05 INFO - SUITE-START | Running 2 tests 08:55:05 INFO - TEST-START | dromaeo_css 08:55:05 INFO - operating with platform_type : mac_ 08:55:05 INFO - Initialising browser for dromaeo_css test... 08:55:05 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpOCfHq3/profile http://localhost:49237/getInfo.html) 08:55:08 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:55:08 INFO - PROCESS | 1652 | colorDepth:24 08:55:08 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:55:08 INFO - PROCESS | 1652 | __metrics 08:55:08 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:08 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:08 INFO - TEST-INFO | 1652: exit 0 08:55:08 INFO - Browser initialized. 08:55:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:55:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpOCfHq3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:20 INFO - PROCESS | 1656 | RSS: Main: 165113856 08:55:20 INFO - PROCESS | 1656 | 08:58:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 08:58:26 INFO - PROCESS | 1656 | RSS: Main: 280625152 08:58:26 INFO - PROCESS | 1656 | 09:01:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 09:01:29 INFO - PROCESS | 1656 | RSS: Main: 306290688 09:01:29 INFO - PROCESS | 1656 | 09:04:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 09:04:32 INFO - PROCESS | 1656 | RSS: Main: 271773696 09:04:32 INFO - PROCESS | 1656 | 09:07:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 09:07:35 INFO - PROCESS | 1656 | RSS: Main: 275173376 09:07:35 INFO - PROCESS | 1656 | 09:10:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 09:10:39 INFO - PROCESS | 1656 | RSS: Main: 271179776 09:10:39 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 09:13:43 INFO - PROCESS | 1656 | RSS: Main: 305876992 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | __start_tp_report 09:13:43 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:13:43 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:13:43 INFO - PROCESS | 1656 | |i|pagename|runs| 09:13:43 INFO - PROCESS | 1656 | |0;dojo.html;3463.718424183053;3494.388482015648;3501.8093848091644;3526.8941931742056;3535.2752685699434;6068.120122582223;6092.878142437148;6104.603200791946;6124.3263241043505;6153.569250152491;6101.145839582462;6115.663638499881;6135.417135372144;6151.41561551653;6153.230846144232;5386.245925570423;5400.486953739389;5439.5376393006445;5450.264214331074;5532.723363831812;5310.8141215057485;5332.520073193412;5372.516473517383;5528.834134975958;5575.358833734112;5416.620836541444;5420.457954204588;5428.4028756836715;5430.402655707869;5448.101063324547;5404.08130617792;5416.647917885364;5424.810131645393;5427.348718153827;5429.484199001088;5255.527002569787;5375.919361209585;5389.568834493231;5391.703456309901;5405.945940540583;6081.878362432726;6094.786682466092;6097.4036925702085;6124.540659450559;6137.11011903276;6369.426751592333;6406.487481001509;6426.1003459515705;6426.518011149183;6431.292557818636;6574.243961944389;6574.276829548746;6577.539572229945;6577.638229897401;6579.276279609239;6036.305824830113;6222.377762223787;6228.937710622927;6238.656873871935;6296.779612713579;6456.3543645636;6459.61242325462;6610.4711623071;6637.834054148685;6701.329867013357;6416.550841441148;6426.068220108152;6429.710663020175;6434.099226108348;6438;6501.349865013555;6507.446867016357;6515.54391192612;6522.934770652233;6558;6263.655498947602;6316.494680425555;6347.174867267226;6429.710663020175;6450.129232553639;6420.807375778734;6460.870782584416;6490.993895946041;6492.642904640195;6504.772332968418;5187.247849061865;5217.713025783618;5221.373435187802;5223.242629818731;5263.157894736823;4532.093581283756;4548.704334218265;4549.431321084864;4669.136209801198;4683.648726345537;6140.320203811457;6146.262448506119;6159.260888693296;6168.506519478431;6178.505719542426;6509.316521765241;6514.5114116441455;6518.934810651833;6520.054592084121;6525.314841941527;6210.968945155336;6211.534134939898;6219.720112594944;6239.656818874914;6240.282367527701;4800.807967681254;5047.192449208183;5531.474509921551;5613.915791263134;5617.943820561742;6705.094812200388;6761.087253220949;6773.695183716646;6779.220389655055;6802.3537763912345;5948.732307046107;6111.808197401464;6543.70553325092;6554;6577.835554111186;6398.392152745481;6512.6743662815725;6608.900866487103;6697.430718388991;6772.492063095189;6400.871982560416;6423.710933008119;6428.292887782433;6440.42036216724;6451;6310.873782524415;6478.352164783484;6491.4806815455595;6495.740170393131;6497.382748638872;6213.9067913982235;6275.748970041147;6277.560570760185;6342.270638876588;6373.458256048288;6231.501479881508;6246.656433896179;6272.937270627235;6297.149884765498;6316.652584107918;6317.052442133717;6322.905156422566;6334.208223972004;6335.809925702236;6346.841328966812;6181;6196.81409557714;6234.594751341148;6255.9374406257175;6292.622442653455;6281.277653069773;6300.810975670737;6303.054541818764;6307.085472606538;6308.842278943063 09:13:43 INFO - PROCESS | 1656 | |1;ext.html;744.1591002167552;815.1522416686646;842.8145807922257;897.8383890899639;910.9180173784358;29977.700222997762;30246;31078.29069401182;31158.2210444739;31248.906288279886;30277;42035;42522;44886;44938.325925111065;9625.807483850318;9784.510774461249;9796.706098817047;9805.607775688964;9823.803523929517;7887.329576985963;9644.517774111266;9763.414195148278;9772.755681107994;9797.90202097977;8027;11667.358295293756;11812.350320732356;11814.113941454425;11837.940810295937;10734.033936945712;11040.723981900437;11800.940995295012;11842.111841611828;11861.110416718737;11634.825477617758;11728.120390970711;11745.706357341049;11746.177767556275;11752.64742057731;41305.586944130475;41372;41497.79251103755;41538.792306038275;41612.79193604013;3995.98002009991;4071.6131967463043;4081.4898137732785;4089.3661482470266;4155.8753237402925;28336.716632833613;28668.139955801358;30095.097147085624;30503;30820.537691934638;3109.176068341891;3321.4353559894635;3358.3115461330367;3417.8632854685784;3427.5715535558056;354985;355230;355258;355427;355737;53876.73061634667;54130.481518701155;54138.72930635322;54429.36711898649;54600.726996365556;55593.72203138958;55594.444055558924;55622.72188639031;55662.72168639212;55703.164452533245;15679.843201567839;15762.921185394;15768.290426930816;15769.763453548207;15774.842251577338;13296.867031329757;13323.467061317633;13341.19952802835;13342;13365.465381384636;10783.622573210057;11033.613823516138;11772.646820595395;12493.12548121641;12493.437795299233;4542.818287268472;4680.578747912704;4700.341952126705;5068.746562671851;5222.4255331913455;917.8072604752944;961.5672947173659;1177.9705507362385;1189.1319336884123;1228.263042174688;21733.022014009406;23319.650205246933;29555.852220738758;29947.251318717208;31014.534781978287;950.339514037751;991.0139411285817;1053.0943388685878;1076.9461526923621;1113.838493418466;15091.924540377227;15643.374265029272;15675.040619922509;15708.528744137466;15903.443379481663;482820;483657;483991;484605;486263;45337.54662453333;58800.70599646975;58832.705836470544;58909;59011.40988590145;1322.7883538633773;1475.2107622421952;1515.143943671822;1524.5502576739666;1535.616095976006;29899.092177038438;31336.68663313429;31400.388955270435;31736.523952141197;31986;43660.12679746451;43894;43916.341254880565;43947.78026109849;43988.560114398446;436488;437839;477013;567559;589322;32204.516932246504;32408.35183296368;32508.349833003682;32586.674133258362;32604;38132.6186738129;43688.68933931987;44330;44473.55526444694;45409.77295113503;30374.84812575923;30613.54079688851;30926.558708462617;31006.534901976036;31691.20771980719;30850.845745771127;31494.685053150093;31601.367972640877;31836;31883.7246510137;34080.48879266763;34100;35977.46033809547;36012;37100.25799484049;28652.42695146044;28960.42079158363;29319.706802931698;29319.85340073286;29865.104046878627;18636.906815465834;20053.598928021067;23261.76738232596;23873.52252954966;24019.260869131598 09:13:43 INFO - PROCESS | 1656 | |2;jquery.html;410.1653135868508;441.35341724373785;450.3649853706275;453.1458201290567;460.53255945215614;19067.618647627056;19410.126544305524;21568.568628627418;21658.3502494925;21900.795456249918;22552.097916083378;22779.77220227797;23101;23304.718240496764;23558.82205889703;6703.229128650207;6881.44948404129;6999.930000699978;7003.684834182449;7011.5091943563975;6602.1417215761885;6733.865322693543;6844.726210951556;6852.486063545254;6860.759873404432;6532.08550802888;6778.118844550201;6785.620546038901;6809;6833.9316606834045;6460.192475940507;6709.228438729536;6763.086983257271;6772.424343930772;6783.084283621697;6539.117219175446;6615.569987950767;6625.436837868787;6627.701753421107;6628.2046154461295;21022.2642207522;21996.560068798695;25781.7109144542;25930.611040834403;26393.604095938575;3020.2449387653087;3023.3953209358215;3080.3069309405205;3097.752179825631;3098.752099832008;16217.264212849748;16374.263158157912;16411.261493232832;16486.34054637825;16714.247858846258;1804.3774897660287;2080.178329559815;2086.895655217248;2093.3719884034726;2133.0934352900113;91881;107864.46067769612;110919.44540277327;111172.44413777879;139561;14610.123392596479;15628.140452275235;17446.912765436093;21723.34829955104;22022.33932982013;36572.63427365692;37129.81435092861;37162.814185928895;37184.44223336652;37220.25559488795;10957.83563246552;11195.776084478264;11431.856239534194;11482.253653512495;11715.00422464083;7306.050213472215;8949.865752013726;9273.860892086625;9305.162535371714;9439.669611563562;10290.3825770454;10352.5341359639;10396.584136634601;10478.790424191473;10522.264211305115;3993.740406873602;4007.338789099824;4043.4137050127565;4067.2272268268935;4070.531888832822;739.530398197138;922.2529750901657;929.177677755178;969.1955676788249;977.3207620703685;16812.91593542049;22157.335279941628;22167.556648866932;22195.889020555118;22326.218582349866;866.2982983783156;925.9537023148815;951.7144856543148;962.7256231973994;974.8683927669674;7919.851621514848;9871.30900836949;10698.41158736277;11682.831716828248;11953.342566158944;699870;761233;782026;785964.2105368424;798848;95804.84896661423;135468;135669;138004;139886;1248.6503778941728;1285.6207418811473;1329.1692692067652;1330.886874615649;1333.8732820382243;16299.022058676517;19697.522685798907;20817.687734683688;20907;20929.744215347127;57104.714476427354;57494.13758793538;57927.71036144961;58066.709666451396;59403;80662.3867522658;81083.78374324508;81086.59456702678;83090;85443;11801.831490857237;12150.21023633461;12169.634910952685;12404.441800118835;12419.627411177678;12224.266544007389;13006.869931300565;13054.282014489294;13386.129901556757;13471.595852124452;9451.432914025181;11237.887621124011;11241.38172400493;11525.481353338952;11564.537418503165;10640.733981650521;10662.040416362564;10696.62561810333;10840.403777791982;10964.232503724981;11100.666979990614;11600;11617.012553932673;11998.280103193836;12027;11428.25716328436;11632.011279041377;11657.358845263592;12014.939925300318;12042.879571204176;11124.165687573302;11273.041791447818;11275.66173014811;11294.887051129384;11625.6512304631 09:13:43 INFO - PROCESS | 1656 | |3;mootools.html;1604.9197540123005;1627.79652543432;1641.7537369394586;1643.1373528897327;1666.6583350413166;10767.784644307108;11389.715257118556;11390.202685811997;11412.828807567894;11427.600033998811;10474.319169253993;10651.627193048245;10817.296875703094;10944.507497162627;11002.50488728007;2172.837531920423;2436.3909022744315;2451.129848903636;2492.1277552856536;2498.4503409249937;2387.5821731197057;2458.21337172105;2494.3639371960126;2496.463260399014;2509.2346834215555;2410.301012706313;2483.7640424159767;2490.1906880263896;2490.713567939692;2492.663490428796;2424;2438.9390265243424;2459.077845807822;2467.6421918821848;2475.2450502596703;2442.7068751749903;2459.3605662527693;2468.938276543083;2475.777180053804;2476.938076548083;11040.116790656808;11298.661040168727;11309.377984210865;11314.547418103266;11319.490622921989;5309.65487243328;5826.572489739999;5857.970710146465;6031.306399764039;6068.211132552784;3644.6355364463607;3736.8505259789576;3805.2389522095414;3825.8278377472802;3872.0900588361715;1207.8067509198486;1236.4714159543755;1252.4238850128952;1276.540445439641;1302.6873550347943;13832.446702132003;14140.646483837883;14562.781558276634;15615.29731162089;15773.76339354899;4110.856120035784;4776.593989510861;4867.148249056401;4917.385326834145;4948.480409557017;10273.434961077062;10460.581576736997;11938.462769175409;11958.521659133712;11961.983231425427;5837.824865254049;6019.819405417845;6039.969800150971;6042.607230530001;6058.0610005449225;5304.257403963448;5438.592105592017;5441.2654291670115;5518.91721624176;5519.889602207933;3403.6256011838677;4009.0578714002186;4024.5170579530645;4048.858289959896;4096.446979657708;1078.229066217658;1079.2175672637275;1091.6070214722693;1096.31480324797;1096.528492748126;953.5899563187896;978.6623614852864;989.8614194012844;1000.0749306891097;1008.168261184511;6620.702068406933;6709.899351509731;6772.390484856386;6819.079424277659;6871.587704737732;938.5025936253796;987.4568987057233;1033.478093562761;1035.471909326234;1065.408698172506;4027.3153563894207;4178.12259425524;4291.785410729451;4383.473983122046;4415.161119387306;13451.461941522426;13971.86028139726;13982.091164074303;14001.859981400055;14015.649608759863;12936.547220847226;13906.51327203543;13935.372908219155;13948;13985.930070349787;10031.648892288735;10303.690889273334;10306.278560500694;10314.690559283234;10315.742106447398;6829.931700683128;6909.372579395857;7021.508494405342;7052.365287124184;7115.288471152843;10926.78146437051;11124.833127502932;12604;12612.873871261538;12624.495020199089;10620.362778233331;12326.260424374566;12518.061145413949;13015.154014988995;13140.145890517086;9247.352685312233;9498.620055197714;9511.381760185566;9533.332666713264;9534.284928630519;9999.650012249536;10364.119049880845;10484.21368397358;10486.213533984828;10503.94748026255;8738.21356077956;8789.956050219964;8937.776555586162;9144.58849351794;9175.908240917772;8330.708425205088;8410.957945210235;8712.651493940171;8721.258693011165;8778.648854045767;8250.834983300421;8282.213189746964;8282.627281772455;8292.212239837207;8301.086880443267;5412.404635490014;5613.57898157648;5984.910226346521;6040.516758659209;6245.7189426476825;5908.172855800105;6086.147939288591;6216;6260.311365749672;6264.444654297335 09:13:43 INFO - PROCESS | 1656 | |4;prototype.html;384.9961500384997;394.86377199866047;402.2257154976669;402.98849886784166;407.54558667086206;4602.8032711495;4880.487548807378;5108.310378098965;5170.810713535889;5174.715390653512;3951.7628942263486;4250.532441431448;4435.77821108944;4739.838739508817;5052.762073292049;3782.4681004193208;4453.621442177418;4461.843835465759;4479.512597068598;4525.841595544157;3988.561258261589;4012.418199361091;4494.101179764044;4495.370648109268;4505.594496495315;3680.9815950920206;4196.853110141145;4254.298280687719;4268.1890440816305;4271.295236286009;3536.0806190390426;3988.7207895447186;4287.3140297552245;4301.118270754488;4309.547497512779;3563.768355056913;3980.1641655252142;3992.6207010333974;4000.3599424092004;4001.47980762499;4612.677112602119;4781.832635857728;4999.850004499871;5023;5030.974845125751;4956.355673762424;4957.429895562021;4960.50394960501;4963.553280204763;4994.950050499521;4946.985867897072;5513.283273174502;5535.03136951032;5549.667019978814;5551.8889622207325;4099.893028882185;4279.587736047097;4367.1831668573595;4371.671568237805;4417.7349359038235;5414.91877621836;5701.57238207132;5771.8557036074435;5777.508911742507;5817.272840894888;4054.0743147004937;4276.636485898734;4384.473863136444;4552.339910712928;4561.110583436198;4331.7184383015;4444.466664000341;4530.847847272519;4532.79602417892;4637.675362724577;4745.311929770164;4827.348307978448;4905.607551395879;4924.482929292444;4931.556159945622;4527.932081018787;4790.856274311776;5254.791397978486;5493.395726470085;5576.358718747315;1428.8285405751376;1470.1402725552184;1555.7631682812191;1574.0948954351293;1598.6562888978926;1072.1958531101673;1098.291601916775;1136.323887287063;1139.1375101708766;1192.8012347590616;4582.495925448198;4883.609311255091;5066.693310685888;5123;5167.302414174113;5165.560927321145;5472.589555783332;5657.001789051809;5682.9147562785765;5702.714864256771;4213.073123912734;4540.137373898949;4874.902501949941;5152.3044389007755;5155.510226528474;2732.972670273272;2891.277180704824;2939.1923966760714;2947.778916581265;2961.644602647696;5242.5281724644965;5455.536279416215;5525.668459892419;5719.57103217252;5948.464638182584;4853.56819738171;5439.374471935699;5842.59101862874;5851.050540884886;5883.882322353529;5939.446038203614;5950.523958083343;5976.342602313742;6026.578139530278;6029.517638588903;5044.949550504448;5388.488093631099;5735.680793417454;5764.942350576608;5853.326867410302;5453.809116680897;5645.689487078086;5663.603547751783;5665.943340566541;5684.403137670485;5164.870878227924;5406.162044883049;5881.911846308447;5998.93036902268;6041.9395806041375;3865.8595714263797;4228.70399072062;4514.954850451453;4546.909061818811;4607.677462577722;4754.787529180037;5081.466446023114;5100.821471248489;5294.596931813149;5746.075064853321;4719.38647975761;4875.585575226146;5304.920426193533;5416.945830541802;5419.295491586068;5138.409082955508;5147.382314122329;5266.867623460974;5518.2826232591115;5550.7510810067415;4680.297955306732;4766.809327626856;4959.007998561048;5149.48505149482;5286.76209570578;4971.477994810492;5449.395261004445;5506.889862202814;5513.779448822002;5527.336719593674;4212.326027835532;4721.409823772028;4787.832425865078;5359.732013399393;5382.596305277041 09:13:43 INFO - PROCESS | 1656 | |5;yui.html;748.8951546783451;767.0565204798102;785.1873311122989;878.5958459108809;893.7899593595506;16659.83340166598;17211.741823872653;17331.91334043331;17466.650666986654;17500.12499375031;16010.119443430607;16251.024938503699;16256.349746010146;16260.674786504293;16261.83738162621;993.1657407777466;1013.5489707080352;1047.4710271313015;1048.5700862646318;1059.3749687684265;1005.9990309641917;1020.7346090016612;1025.4513835098223;1027.0551092994426;1027.250107421579;1074.1943542343242;1074.3607553505651;1077.224398433127;1077.4774234496263;1080.1466841195447;1062.5696592879897;1064.7391389109641;1065.1585247654343;1066.9306495077872;1067.738404090995;796.6733639207955;797.2904115337296;799.0730752327272;801.9839603207903;804.2560631415917;16057.919710401373;16387.42644007454;16856.57858553546;16933.91533042339;16937.237824297936;14621.853781462261;14801.259937003108;14868;14880.62798430037;14896.329665165094;12041.39793010346;12140.392980350947;12157.270563766115;12190.756184876342;12475.064370172182;3718.1448266898765;3769.8869033929027;3844.8077596120083;3901.707371947087;3993.62060604245;81006;87921.12078879193;103234;103387;104475.77621118914;11178.664640060812;11268.323900565829;11430.428478576205;11450;11567.652970410902;22886.313410597708;23183;23742;23766.524669506514;23775.643365349533;7899.188092016174;7965;7968.402369822286;8053.758387248392;8144.022717273847;4501.88745281364;4555.794989225493;4603.769811509411;4688.789004494806;4700.670953033323;3651.9634803652157;3750.456183853326;3751.0622344413896;3753.042974041602;3759.3984962405884;634.2230767310008;653.8256763413654;672.1631568697004;673.1854456108066;679.2290749998787;691.5193940211606;693.5734523268254;718.2888939949412;735.9043324367798;760.8334449288548;10526.263161578616;10949.56201751921;10965.396903170402;11043.282186657842;11280.379579123062;702.9543079699803;711.2745000099869;725.6371814092954;734.5812886654555;752.9058867641545;4883.487233840467;5185.611079169077;5285.68285902847;5305.495977882095;5307;78803;95993;108807.91192088136;109815;114882;60835;62680.37319626745;66458.66770666116;80292.5985370081;86628.26743465096;62114.68942655258;73023;78115;79417.41165176779;80692.59653701694;11205.04757095656;11340.262882912913;11484.712882178012;11546.769064618493;11609.3614851184;38911.221775564896;49581.752091239316;50246.49753502418;53238;54087.45912540824;62535.37464625295;62753.372466274755;63174.68412658091;64372;64872;12832.294223817406;13182.736345273233;13359;13549.729005420033;13641;14304.213268270345;14869.925650371679;15203.935724499179;15741;15879.68240635204;14556.344964476835;14665.193414362313;14849.480268190562;15036.398544058115;15483.380664773284;13582.79625805594;14280.857191427953;14399.640008999859;14957.476488322856;15474.690506190038;14085.788713169515;14124.364403601658;14544.345504452114;14713.33789979432;14818.703625927637;10016.949915250378;10675.786484270116;10825.837612435977;10827.783444331228;11169;11616.651500455;11644.941775291409;11749.823752643546;11837.171398002058;11942 09:13:43 INFO - PROCESS | 1656 | __end_tp_report 09:13:43 INFO - PROCESS | 1656 | __start_cc_report 09:13:43 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1092 09:13:43 INFO - PROCESS | 1656 | __end_cc_report 09:13:43 INFO - PROCESS | 1656 | __startTimestamp1493914423641__endTimestamp 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:13:43 INFO - PROCESS | 1656 | Number of tests: 6 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:6016.69 Median:6255.94 stddev:679.86 (10.9%) stddev-sans-first:651.78 09:13:43 INFO - PROCESS | 1656 | Values: 3463.7 3494.4 3501.8 3526.9 3535.3 6068.1 6092.9 6104.6 6124.3 6153.6 6101.1 6115.7 6135.4 6151.4 6153.2 5386.2 5400.5 5439.5 5450.3 5532.7 5310.8 5332.5 5372.5 5528.8 5575.4 5416.6 5420.5 5428.4 5430.4 5448.1 5404.1 5416.6 5424.8 5427.3 5429.5 5255.5 5375.9 5389.6 5391.7 5405.9 6081.9 6094.8 6097.4 6124.5 6137.1 6369.4 6406.5 6426.1 6426.5 6431.3 6574.2 6574.3 6577.5 6577.6 6579.3 6036.3 6222.4 6228.9 6238.7 6296.8 6456.4 6459.6 6610.5 6637.8 6701.3 6416.6 6426.1 6429.7 6434.1 6438.0 6501.3 6507.4 6515.5 6522.9 6558.0 6263.7 6316.5 6347.2 6429.7 6450.1 6420.8 6460.9 6491.0 6492.6 6504.8 5187.2 5217.7 5221.4 5223.2 5263.2 4532.1 4548.7 4549.4 4669.1 4683.6 6140.3 6146.3 6159.3 6168.5 6178.5 6509.3 6514.5 6518.9 6520.1 6525.3 6211.0 6211.5 6219.7 6239.7 6240.3 4800.8 5047.2 5531.5 5613.9 5617.9 6705.1 6761.1 6773.7 6779.2 6802.4 5948.7 6111.8 6543.7 6554.0 6577.8 6398.4 6512.7 6608.9 6697.4 6772.5 6400.9 6423.7 6428.3 6440.4 6451.0 6310.9 6478.4 6491.5 6495.7 6497.4 6213.9 6275.7 6277.6 6342.3 6373.5 6231.5 6246.7 6272.9 6297.1 6316.7 6317.1 6322.9 6334.2 6335.8 6346.8 6181.0 6196.8 6234.6 6255.9 6292.6 6281.3 6300.8 6303.1 6307.1 6308.8 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:58433.38 Median:32595.34 stddev:120605.75 (370.0%) stddev-sans-first:120866.30 09:13:43 INFO - PROCESS | 1656 | Values: 744.2 815.2 842.8 897.8 910.9 29977.7 30246.0 31078.3 31158.2 31248.9 30277.0 42035.0 42522.0 44886.0 44938.3 9625.8 9784.5 9796.7 9805.6 9823.8 7887.3 9644.5 9763.4 9772.8 9797.9 8027.0 11667.4 11812.4 11814.1 11837.9 10734.0 11040.7 11800.9 11842.1 11861.1 11634.8 11728.1 11745.7 11746.2 11752.6 41305.6 41372.0 41497.8 41538.8 41612.8 3996.0 4071.6 4081.5 4089.4 4155.9 28336.7 28668.1 30095.1 30503.0 30820.5 3109.2 3321.4 3358.3 3417.9 3427.6 354985.0 355230.0 355258.0 355427.0 355737.0 53876.7 54130.5 54138.7 54429.4 54600.7 55593.7 55594.4 55622.7 55662.7 55703.2 15679.8 15762.9 15768.3 15769.8 15774.8 13296.9 13323.5 13341.2 13342.0 13365.5 10783.6 11033.6 11772.6 12493.1 12493.4 4542.8 4680.6 4700.3 5068.7 5222.4 917.8 961.6 1178.0 1189.1 1228.3 21733.0 23319.7 29555.9 29947.3 31014.5 950.3 991.0 1053.1 1076.9 1113.8 15091.9 15643.4 15675.0 15708.5 15903.4 482820.0 483657.0 483991.0 484605.0 486263.0 45337.5 58800.7 58832.7 58909.0 59011.4 1322.8 1475.2 1515.1 1524.6 1535.6 29899.1 31336.7 31400.4 31736.5 31986.0 43660.1 43894.0 43916.3 43947.8 43988.6 436488.0 437839.0 477013.0 567559.0 589322.0 32204.5 32408.4 32508.3 32586.7 32604.0 38132.6 43688.7 44330.0 44473.6 45409.8 30374.8 30613.5 30926.6 31006.5 31691.2 30850.8 31494.7 31601.4 31836.0 31883.7 34080.5 34100.0 35977.5 36012.0 37100.3 28652.4 28960.4 29319.7 29319.9 29865.1 18636.9 20053.6 23261.8 23873.5 24019.3 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:41583.58 Median:22261.05 stddev:126294.73 (567.3%) stddev-sans-first:126611.18 09:13:43 INFO - PROCESS | 1656 | Values: 410.2 441.4 450.4 453.1 460.5 19067.6 19410.1 21568.6 21658.4 21900.8 22552.1 22779.8 23101.0 23304.7 23558.8 6703.2 6881.4 6999.9 7003.7 7011.5 6602.1 6733.9 6844.7 6852.5 6860.8 6532.1 6778.1 6785.6 6809.0 6833.9 6460.2 6709.2 6763.1 6772.4 6783.1 6539.1 6615.6 6625.4 6627.7 6628.2 21022.3 21996.6 25781.7 25930.6 26393.6 3020.2 3023.4 3080.3 3097.8 3098.8 16217.3 16374.3 16411.3 16486.3 16714.2 1804.4 2080.2 2086.9 2093.4 2133.1 91881.0 107864.5 110919.4 111172.4 139561.0 14610.1 15628.1 17446.9 21723.3 22022.3 36572.6 37129.8 37162.8 37184.4 37220.3 10957.8 11195.8 11431.9 11482.3 11715.0 7306.1 8949.9 9273.9 9305.2 9439.7 10290.4 10352.5 10396.6 10478.8 10522.3 3993.7 4007.3 4043.4 4067.2 4070.5 739.5 922.3 929.2 969.2 977.3 16812.9 22157.3 22167.6 22195.9 22326.2 866.3 926.0 951.7 962.7 974.9 7919.9 9871.3 10698.4 11682.8 11953.3 699870.0 761233.0 782026.0 785964.2 798848.0 95804.8 135468.0 135669.0 138004.0 139886.0 1248.7 1285.6 1329.2 1330.9 1333.9 16299.0 19697.5 20817.7 20907.0 20929.7 57104.7 57494.1 57927.7 58066.7 59403.0 80662.4 81083.8 81086.6 83090.0 85443.0 11801.8 12150.2 12169.6 12404.4 12419.6 12224.3 13006.9 13054.3 13386.1 13471.6 9451.4 11237.9 11241.4 11525.5 11564.5 10640.7 10662.0 10696.6 10840.4 10964.2 11100.7 11600.0 11617.0 11998.3 12027.0 11428.3 11632.0 11657.4 12014.9 12042.9 11124.2 11273.0 11275.7 11294.9 11625.7 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:6811.17 Median:2486.98 stddev:4180.76 (168.1%) stddev-sans-first:4174.18 09:13:43 INFO - PROCESS | 1656 | Values: 1604.9 1627.8 1641.8 1643.1 1666.7 10767.8 11389.7 11390.2 11412.8 11427.6 10474.3 10651.6 10817.3 10944.5 11002.5 2172.8 2436.4 2451.1 2492.1 2498.5 2387.6 2458.2 2494.4 2496.5 2509.2 2410.3 2483.8 2490.2 2490.7 2492.7 2424.0 2438.9 2459.1 2467.6 2475.2 2442.7 2459.4 2468.9 2475.8 2476.9 11040.1 11298.7 11309.4 11314.5 11319.5 5309.7 5826.6 5858.0 6031.3 6068.2 3644.6 3736.9 3805.2 3825.8 3872.1 1207.8 1236.5 1252.4 1276.5 1302.7 13832.4 14140.6 14562.8 15615.3 15773.8 4110.9 4776.6 4867.1 4917.4 4948.5 10273.4 10460.6 11938.5 11958.5 11962.0 5837.8 6019.8 6040.0 6042.6 6058.1 5304.3 5438.6 5441.3 5518.9 5519.9 3403.6 4009.1 4024.5 4048.9 4096.4 1078.2 1079.2 1091.6 1096.3 1096.5 953.6 978.7 989.9 1000.1 1008.2 6620.7 6709.9 6772.4 6819.1 6871.6 938.5 987.5 1033.5 1035.5 1065.4 4027.3 4178.1 4291.8 4383.5 4415.2 13451.5 13971.9 13982.1 14001.9 14015.6 12936.5 13906.5 13935.4 13948.0 13985.9 10031.6 10303.7 10306.3 10314.7 10315.7 6829.9 6909.4 7021.5 7052.4 7115.3 10926.8 11124.8 12604.0 12612.9 12624.5 10620.4 12326.3 12518.1 13015.2 13140.1 9247.4 9498.6 9511.4 9533.3 9534.3 9999.7 10364.1 10484.2 10486.2 10503.9 8738.2 8790.0 8937.8 9144.6 9175.9 8330.7 8411.0 8712.7 8721.3 8778.6 8250.8 8282.2 8282.6 8292.2 8301.1 5412.4 5613.6 5984.9 6040.5 6245.7 5908.2 6086.1 6216.0 6260.3 6264.4 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4580.59 Median:4894.61 stddev:1274.56 (26.0%) stddev-sans-first:1238.63 09:13:43 INFO - PROCESS | 1656 | Values: 385.0 394.9 402.2 403.0 407.5 4602.8 4880.5 5108.3 5170.8 5174.7 3951.8 4250.5 4435.8 4739.8 5052.8 3782.5 4453.6 4461.8 4479.5 4525.8 3988.6 4012.4 4494.1 4495.4 4505.6 3681.0 4196.9 4254.3 4268.2 4271.3 3536.1 3988.7 4287.3 4301.1 4309.5 3563.8 3980.2 3992.6 4000.4 4001.5 4612.7 4781.8 4999.9 5023.0 5031.0 4956.4 4957.4 4960.5 4963.6 4995.0 4947.0 5513.3 5535.0 5549.7 5551.9 4099.9 4279.6 4367.2 4371.7 4417.7 5414.9 5701.6 5771.9 5777.5 5817.3 4054.1 4276.6 4384.5 4552.3 4561.1 4331.7 4444.5 4530.8 4532.8 4637.7 4745.3 4827.3 4905.6 4924.5 4931.6 4527.9 4790.9 5254.8 5493.4 5576.4 1428.8 1470.1 1555.8 1574.1 1598.7 1072.2 1098.3 1136.3 1139.1 1192.8 4582.5 4883.6 5066.7 5123.0 5167.3 5165.6 5472.6 5657.0 5682.9 5702.7 4213.1 4540.1 4874.9 5152.3 5155.5 2733.0 2891.3 2939.2 2947.8 2961.6 5242.5 5455.5 5525.7 5719.6 5948.5 4853.6 5439.4 5842.6 5851.1 5883.9 5939.4 5950.5 5976.3 6026.6 6029.5 5044.9 5388.5 5735.7 5764.9 5853.3 5453.8 5645.7 5663.6 5665.9 5684.4 5164.9 5406.2 5881.9 5998.9 6041.9 3865.9 4228.7 4515.0 4546.9 4607.7 4754.8 5081.5 5100.8 5294.6 5746.1 4719.4 4875.6 5304.9 5416.9 5419.3 5138.4 5147.4 5266.9 5518.3 5550.8 4680.3 4766.8 4959.0 5149.5 5286.8 4971.5 5449.4 5506.9 5513.8 5527.3 4212.3 4721.4 4787.8 5359.7 5382.6 09:13:43 INFO - PROCESS | 1656 | 09:13:43 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:19972.15 Median:16324.63 stddev:27133.18 (166.2%) stddev-sans-first:27170.90 09:13:43 INFO - PROCESS | 1656 | Values: 748.9 767.1 785.2 878.6 893.8 16659.8 17211.7 17331.9 17466.7 17500.1 16010.1 16251.0 16256.3 16260.7 16261.8 993.2 1013.5 1047.5 1048.6 1059.4 1006.0 1020.7 1025.5 1027.1 1027.3 1074.2 1074.4 1077.2 1077.5 1080.1 1062.6 1064.7 1065.2 1066.9 1067.7 796.7 797.3 799.1 802.0 804.3 16057.9 16387.4 16856.6 16933.9 16937.2 14621.9 14801.3 14868.0 14880.6 14896.3 12041.4 12140.4 12157.3 12190.8 12475.1 3718.1 3769.9 3844.8 3901.7 3993.6 81006.0 87921.1 103234.0 103387.0 104475.8 11178.7 11268.3 11430.4 11450.0 11567.7 22886.3 23183.0 23742.0 23766.5 23775.6 7899.2 7965.0 7968.4 8053.8 8144.0 4501.9 4555.8 4603.8 4688.8 4700.7 3652.0 3750.5 3751.1 3753.0 3759.4 634.2 653.8 672.2 673.2 679.2 691.5 693.6 718.3 735.9 760.8 10526.3 10949.6 10965.4 11043.3 11280.4 703.0 711.3 725.6 734.6 752.9 4883.5 5185.6 5285.7 5305.5 5307.0 78803.0 95993.0 108807.9 109815.0 114882.0 60835.0 62680.4 66458.7 80292.6 86628.3 62114.7 73023.0 78115.0 79417.4 80692.6 11205.0 11340.3 11484.7 11546.8 11609.4 38911.2 49581.8 50246.5 53238.0 54087.5 62535.4 62753.4 63174.7 64372.0 64872.0 12832.3 13182.7 13359.0 13549.7 13641.0 14304.2 14869.9 15203.9 15741.0 15879.7 14556.3 14665.2 14849.5 15036.4 15483.4 13582.8 14280.9 14399.6 14957.5 15474.7 14085.8 14124.4 14544.3 14713.3 14818.7 10016.9 10675.8 10825.8 10827.8 11169.0 11616.7 11644.9 11749.8 11837.2 11942.0 09:13:43 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:13:43 INFO - PROCESS | 1656 | 09:13:44 INFO - TEST-INFO | 1656: exit 0 09:13:44 INFO - TEST-OK | dromaeo_css | took 1118373ms 09:13:44 INFO - TEST-START | kraken 09:13:44 INFO - operating with platform_type : mac_ 09:13:44 INFO - Initialising browser for kraken test... 09:13:44 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpKXn768/profile http://localhost:49237/getInfo.html) 09:13:46 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:13:46 INFO - PROCESS | 1661 | colorDepth:24 09:13:46 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:13:46 INFO - PROCESS | 1661 | __metrics 09:13:46 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:46 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:47 INFO - TEST-INFO | 1661: exit 0 09:13:47 INFO - Browser initialized. 09:13:47 INFO - Running cycle 1/1 for kraken test... 09:13:47 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpKXn768/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:59 INFO - PROCESS | 1663 | RSS: Main: 165244928 09:13:59 INFO - PROCESS | 1663 | 09:14:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:02 INFO - PROCESS | 1663 | RSS: Main: 215846912 09:14:02 INFO - PROCESS | 1663 | 09:14:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 09:14:06 INFO - PROCESS | 1663 | RSS: Main: 231231488 09:14:06 INFO - PROCESS | 1663 | 09:14:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 09:14:09 INFO - PROCESS | 1663 | RSS: Main: 328712192 09:14:09 INFO - PROCESS | 1663 | 09:14:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 09:14:12 INFO - PROCESS | 1663 | RSS: Main: 229617664 09:14:12 INFO - PROCESS | 1663 | 09:14:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:15 INFO - PROCESS | 1663 | RSS: Main: 232169472 09:14:15 INFO - PROCESS | 1663 | 09:14:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:18 INFO - PROCESS | 1663 | RSS: Main: 272158720 09:14:18 INFO - PROCESS | 1663 | 09:14:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:22 INFO - PROCESS | 1663 | RSS: Main: 274350080 09:14:22 INFO - PROCESS | 1663 | 09:14:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 09:14:25 INFO - PROCESS | 1663 | RSS: Main: 273256448 09:14:25 INFO - PROCESS | 1663 | 09:14:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:27 INFO - PROCESS | 1663 | RSS: Main: 247816192 09:14:27 INFO - PROCESS | 1663 | 09:14:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:30 INFO - PROCESS | 1663 | RSS: Main: 253132800 09:14:30 INFO - PROCESS | 1663 | 09:14:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:33 INFO - PROCESS | 1663 | RSS: Main: 257462272 09:14:33 INFO - PROCESS | 1663 | 09:14:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:36 INFO - PROCESS | 1663 | RSS: Main: 274063360 09:14:36 INFO - PROCESS | 1663 | 09:14:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:39 INFO - PROCESS | 1663 | RSS: Main: 267444224 09:14:39 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 09:14:41 INFO - PROCESS | 1663 | RSS: Main: 311877632 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | __start_tp_report 09:14:41 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 09:14:41 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 09:14:41 INFO - PROCESS | 1663 | |i|pagename|runs| 09:14:41 INFO - PROCESS | 1663 | |0;ai-astar;103;115;115;114;114;114;113;114;114;113 09:14:41 INFO - PROCESS | 1663 | |1;audio-beat-detection;141;107;104;164;141;137;108;108;127;107 09:14:41 INFO - PROCESS | 1663 | |2;audio-dft;183;184;185;186;196;261;210;184;183;183 09:14:41 INFO - PROCESS | 1663 | |3;audio-fft;80;59;58;91;61;58;57;60;72;58 09:14:41 INFO - PROCESS | 1663 | |4;audio-oscillator;90;69;111;101;99;68;82;69;68;83 09:14:41 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;86;86;85;86;86;86;86;86;86 09:14:41 INFO - PROCESS | 1663 | |6;imaging-darkroom;92;93;93;93;92;93;92;92;93;93 09:14:41 INFO - PROCESS | 1663 | |7;imaging-desaturate;85;85;86;83;85;84;85;86;85;83 09:14:41 INFO - PROCESS | 1663 | |8;json-parse-financial;61;59;60;57;60;64;65;64;64;64 09:14:41 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;54;66;66;59;61;58;57;57;58;57 09:14:41 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;84;81;81;81;83;80;82;84;82;81 09:14:41 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;134;133;133;132;126;134;125;138;172;145 09:14:41 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;153;159;160;160;166;214;170;159;159;159 09:14:41 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;64;64;63;63;64;62;65;66;58;63 09:14:41 INFO - PROCESS | 1663 | __end_tp_report 09:14:41 INFO - PROCESS | 1663 | __start_cc_report 09:14:41 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2012 09:14:41 INFO - PROCESS | 1663 | __end_cc_report 09:14:41 INFO - PROCESS | 1663 | __startTimestamp1493914481861__endTimestamp 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | ------- Summary: start ------- 09:14:41 INFO - PROCESS | 1663 | Number of tests: 14 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.54 (3.1%) stddev-sans-first:0.71 09:14:41 INFO - PROCESS | 1663 | Values: 103.0 115.0 115.0 114.0 114.0 114.0 113.0 114.0 114.0 113.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:132.00 stddev:20.67 (15.7%) stddev-sans-first:21.03 09:14:41 INFO - PROCESS | 1663 | Values: 141.0 107.0 104.0 164.0 141.0 137.0 108.0 108.0 127.0 107.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:195.50 Median:185.50 stddev:24.57 (13.2%) stddev-sans-first:25.64 09:14:41 INFO - PROCESS | 1663 | Values: 183.0 184.0 185.0 186.0 196.0 261.0 210.0 184.0 183.0 183.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.50 stddev:11.72 (19.4%) stddev-sans-first:11.18 09:14:41 INFO - PROCESS | 1663 | Values: 80.0 59.0 58.0 91.0 61.0 58.0 57.0 60.0 72.0 58.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:75.50 stddev:15.80 (20.9%) stddev-sans-first:16.61 09:14:41 INFO - PROCESS | 1663 | Values: 90.0 69.0 111.0 101.0 99.0 68.0 82.0 69.0 68.0 83.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 09:14:41 INFO - PROCESS | 1663 | Values: 87.0 86.0 86.0 85.0 86.0 86.0 86.0 86.0 86.0 86.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 09:14:41 INFO - PROCESS | 1663 | Values: 92.0 93.0 93.0 93.0 92.0 93.0 92.0 92.0 93.0 93.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 09:14:41 INFO - PROCESS | 1663 | Values: 85.0 85.0 86.0 83.0 85.0 84.0 85.0 86.0 85.0 83.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:64.00 stddev:2.74 (4.3%) stddev-sans-first:2.89 09:14:41 INFO - PROCESS | 1663 | Values: 61.0 59.0 60.0 57.0 60.0 64.0 65.0 64.0 64.0 64.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:58.50 stddev:3.95 (6.7%) stddev-sans-first:3.69 09:14:41 INFO - PROCESS | 1663 | Values: 54.0 66.0 66.0 59.0 61.0 58.0 57.0 57.0 58.0 57.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.37 (1.7%) stddev-sans-first:1.22 09:14:41 INFO - PROCESS | 1663 | Values: 84.0 81.0 81.0 81.0 83.0 80.0 82.0 84.0 82.0 81.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:134.00 stddev:13.46 (10.0%) stddev-sans-first:14.22 09:14:41 INFO - PROCESS | 1663 | Values: 134.0 133.0 133.0 132.0 126.0 134.0 125.0 138.0 172.0 145.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:160.00 stddev:17.50 (10.9%) stddev-sans-first:17.93 09:14:41 INFO - PROCESS | 1663 | Values: 153.0 159.0 160.0 160.0 166.0 214.0 170.0 159.0 159.0 159.0 09:14:41 INFO - PROCESS | 1663 | 09:14:41 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:64.00 stddev:2.15 (3.4%) stddev-sans-first:2.26 09:14:41 INFO - PROCESS | 1663 | Values: 64.0 64.0 63.0 63.0 64.0 62.0 65.0 66.0 58.0 63.0 09:14:41 INFO - PROCESS | 1663 | -------- Summary: end -------- 09:14:41 INFO - PROCESS | 1663 | 09:14:42 INFO - TEST-INFO | 1663: exit 0 09:14:42 INFO - TEST-OK | kraken | took 58552ms 09:14:42 INFO - SUITE-END | took 1176s 09:14:43 INFO - Completed test suite (00:19:37) 09:14:43 INFO - javascript benchmark 09:14:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7831.667589966564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3463.718424183053, 3494.388482015648, 3501.8093848091644, 3526.8941931742056, 3535.2752685699434, 6068.120122582223, 6092.878142437148, 6104.603200791946, 6124.3263241043505, 6153.569250152491, 6101.145839582462, 6115.663638499881, 6135.417135372144, 6151.41561551653, 6153.230846144232, 5386.245925570423, 5400.486953739389, 5439.5376393006445, 5450.264214331074, 5532.723363831812, 5310.8141215057485, 5332.520073193412, 5372.516473517383, 5528.834134975958, 5575.358833734112, 5416.620836541444, 5420.457954204588, 5428.4028756836715, 5430.402655707869, 5448.101063324547, 5404.08130617792, 5416.647917885364, 5424.810131645393, 5427.348718153827, 5429.484199001088, 5255.527002569787, 5375.919361209585, 5389.568834493231, 5391.703456309901, 5405.945940540583, 6081.878362432726, 6094.786682466092, 6097.4036925702085, 6124.540659450559, 6137.11011903276, 6369.426751592333, 6406.487481001509, 6426.1003459515705, 6426.518011149183, 6431.292557818636, 6574.243961944389, 6574.276829548746, 6577.539572229945, 6577.638229897401, 6579.276279609239, 6036.305824830113, 6222.377762223787, 6228.937710622927, 6238.656873871935, 6296.779612713579, 6456.3543645636, 6459.61242325462, 6610.4711623071, 6637.834054148685, 6701.329867013357, 6416.550841441148, 6426.068220108152, 6429.710663020175, 6434.099226108348, 6438.0, 6501.349865013555, 6507.446867016357, 6515.54391192612, 6522.934770652233, 6558.0, 6263.655498947602, 6316.494680425555, 6347.174867267226, 6429.710663020175, 6450.129232553639, 6420.807375778734, 6460.870782584416, 6490.993895946041, 6492.642904640195, 6504.772332968418, 5187.247849061865, 5217.713025783618, 5221.373435187802, 5223.242629818731, 5263.157894736823, 4532.093581283756, 4548.704334218265, 4549.431321084864, 4669.136209801198, 4683.648726345537, 6140.320203811457, 6146.262448506119, 6159.260888693296, 6168.506519478431, 6178.505719542426, 6509.316521765241, 6514.5114116441455, 6518.934810651833, 6520.054592084121, 6525.314841941527, 6210.968945155336, 6211.534134939898, 6219.720112594944, 6239.656818874914, 6240.282367527701, 4800.807967681254, 5047.192449208183, 5531.474509921551, 5613.915791263134, 5617.943820561742, 6705.094812200388, 6761.087253220949, 6773.695183716646, 6779.220389655055, 6802.3537763912345, 5948.732307046107, 6111.808197401464, 6543.70553325092, 6554.0, 6577.835554111186, 6398.392152745481, 6512.6743662815725, 6608.900866487103, 6697.430718388991, 6772.492063095189, 6400.871982560416, 6423.710933008119, 6428.292887782433, 6440.42036216724, 6451.0, 6310.873782524415, 6478.352164783484, 6491.4806815455595, 6495.740170393131, 6497.382748638872, 6213.9067913982235, 6275.748970041147, 6277.560570760185, 6342.270638876588, 6373.458256048288, 6231.501479881508, 6246.656433896179, 6272.937270627235, 6297.149884765498, 6316.652584107918, 6317.052442133717, 6322.905156422566, 6334.208223972004, 6335.809925702236, 6346.841328966812, 6181.0, 6196.81409557714, 6234.594751341148, 6255.9374406257175, 6292.622442653455, 6281.277653069773, 6300.810975670737, 6303.054541818764, 6307.085472606538, 6308.842278943063], "value": 5971.730843690345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.1591002167552, 815.1522416686646, 842.8145807922257, 897.8383890899639, 910.9180173784358, 29977.700222997762, 30246.0, 31078.29069401182, 31158.2210444739, 31248.906288279886, 30277.0, 42035.0, 42522.0, 44886.0, 44938.325925111065, 9625.807483850318, 9784.510774461249, 9796.706098817047, 9805.607775688964, 9823.803523929517, 7887.329576985963, 9644.517774111266, 9763.414195148278, 9772.755681107994, 9797.90202097977, 8027.0, 11667.358295293756, 11812.350320732356, 11814.113941454425, 11837.940810295937, 10734.033936945712, 11040.723981900437, 11800.940995295012, 11842.111841611828, 11861.110416718737, 11634.825477617758, 11728.120390970711, 11745.706357341049, 11746.177767556275, 11752.64742057731, 41305.586944130475, 41372.0, 41497.79251103755, 41538.792306038275, 41612.79193604013, 3995.98002009991, 4071.6131967463043, 4081.4898137732785, 4089.3661482470266, 4155.8753237402925, 28336.716632833613, 28668.139955801358, 30095.097147085624, 30503.0, 30820.537691934638, 3109.176068341891, 3321.4353559894635, 3358.3115461330367, 3417.8632854685784, 3427.5715535558056, 354985.0, 355230.0, 355258.0, 355427.0, 355737.0, 53876.73061634667, 54130.481518701155, 54138.72930635322, 54429.36711898649, 54600.726996365556, 55593.72203138958, 55594.444055558924, 55622.72188639031, 55662.72168639212, 55703.164452533245, 15679.843201567839, 15762.921185394, 15768.290426930816, 15769.763453548207, 15774.842251577338, 13296.867031329757, 13323.467061317633, 13341.19952802835, 13342.0, 13365.465381384636, 10783.622573210057, 11033.613823516138, 11772.646820595395, 12493.12548121641, 12493.437795299233, 4542.818287268472, 4680.578747912704, 4700.341952126705, 5068.746562671851, 5222.4255331913455, 917.8072604752944, 961.5672947173659, 1177.9705507362385, 1189.1319336884123, 1228.263042174688, 21733.022014009406, 23319.650205246933, 29555.852220738758, 29947.251318717208, 31014.534781978287, 950.339514037751, 991.0139411285817, 1053.0943388685878, 1076.9461526923621, 1113.838493418466, 15091.924540377227, 15643.374265029272, 15675.040619922509, 15708.528744137466, 15903.443379481663, 482820.0, 483657.0, 483991.0, 484605.0, 486263.0, 45337.54662453333, 58800.70599646975, 58832.705836470544, 58909.0, 59011.40988590145, 1322.7883538633773, 1475.2107622421952, 1515.143943671822, 1524.5502576739666, 1535.616095976006, 29899.092177038438, 31336.68663313429, 31400.388955270435, 31736.523952141197, 31986.0, 43660.12679746451, 43894.0, 43916.341254880565, 43947.78026109849, 43988.560114398446, 436488.0, 437839.0, 477013.0, 567559.0, 589322.0, 32204.516932246504, 32408.35183296368, 32508.349833003682, 32586.674133258362, 32604.0, 38132.6186738129, 43688.68933931987, 44330.0, 44473.55526444694, 45409.77295113503, 30374.84812575923, 30613.54079688851, 30926.558708462617, 31006.534901976036, 31691.20771980719, 30850.845745771127, 31494.685053150093, 31601.367972640877, 31836.0, 31883.7246510137, 34080.48879266763, 34100.0, 35977.46033809547, 36012.0, 37100.25799484049, 28652.42695146044, 28960.42079158363, 29319.706802931698, 29319.85340073286, 29865.104046878627, 18636.906815465834, 20053.598928021067, 23261.76738232596, 23873.52252954966, 24019.260869131598], "value": 19084.324595474594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.1653135868508, 441.35341724373785, 450.3649853706275, 453.1458201290567, 460.53255945215614, 19067.618647627056, 19410.126544305524, 21568.568628627418, 21658.3502494925, 21900.795456249918, 22552.097916083378, 22779.77220227797, 23101.0, 23304.718240496764, 23558.82205889703, 6703.229128650207, 6881.44948404129, 6999.930000699978, 7003.684834182449, 7011.5091943563975, 6602.1417215761885, 6733.865322693543, 6844.726210951556, 6852.486063545254, 6860.759873404432, 6532.08550802888, 6778.118844550201, 6785.620546038901, 6809.0, 6833.9316606834045, 6460.192475940507, 6709.228438729536, 6763.086983257271, 6772.424343930772, 6783.084283621697, 6539.117219175446, 6615.569987950767, 6625.436837868787, 6627.701753421107, 6628.2046154461295, 21022.2642207522, 21996.560068798695, 25781.7109144542, 25930.611040834403, 26393.604095938575, 3020.2449387653087, 3023.3953209358215, 3080.3069309405205, 3097.752179825631, 3098.752099832008, 16217.264212849748, 16374.263158157912, 16411.261493232832, 16486.34054637825, 16714.247858846258, 1804.3774897660287, 2080.178329559815, 2086.895655217248, 2093.3719884034726, 2133.0934352900113, 91881.0, 107864.46067769612, 110919.44540277327, 111172.44413777879, 139561.0, 14610.123392596479, 15628.140452275235, 17446.912765436093, 21723.34829955104, 22022.33932982013, 36572.63427365692, 37129.81435092861, 37162.814185928895, 37184.44223336652, 37220.25559488795, 10957.83563246552, 11195.776084478264, 11431.856239534194, 11482.253653512495, 11715.00422464083, 7306.050213472215, 8949.865752013726, 9273.860892086625, 9305.162535371714, 9439.669611563562, 10290.3825770454, 10352.5341359639, 10396.584136634601, 10478.790424191473, 10522.264211305115, 3993.740406873602, 4007.338789099824, 4043.4137050127565, 4067.2272268268935, 4070.531888832822, 739.530398197138, 922.2529750901657, 929.177677755178, 969.1955676788249, 977.3207620703685, 16812.91593542049, 22157.335279941628, 22167.556648866932, 22195.889020555118, 22326.218582349866, 866.2982983783156, 925.9537023148815, 951.7144856543148, 962.7256231973994, 974.8683927669674, 7919.851621514848, 9871.30900836949, 10698.41158736277, 11682.831716828248, 11953.342566158944, 699870.0, 761233.0, 782026.0, 785964.2105368424, 798848.0, 95804.84896661423, 135468.0, 135669.0, 138004.0, 139886.0, 1248.6503778941728, 1285.6207418811473, 1329.1692692067652, 1330.886874615649, 1333.8732820382243, 16299.022058676517, 19697.522685798907, 20817.687734683688, 20907.0, 20929.744215347127, 57104.714476427354, 57494.13758793538, 57927.71036144961, 58066.709666451396, 59403.0, 80662.3867522658, 81083.78374324508, 81086.59456702678, 83090.0, 85443.0, 11801.831490857237, 12150.21023633461, 12169.634910952685, 12404.441800118835, 12419.627411177678, 12224.266544007389, 13006.869931300565, 13054.282014489294, 13386.129901556757, 13471.595852124452, 9451.432914025181, 11237.887621124011, 11241.38172400493, 11525.481353338952, 11564.537418503165, 10640.733981650521, 10662.040416362564, 10696.62561810333, 10840.403777791982, 10964.232503724981, 11100.666979990614, 11600.0, 11617.012553932673, 11998.280103193836, 12027.0, 11428.25716328436, 11632.011279041377, 11657.358845263592, 12014.939925300318, 12042.879571204176, 11124.165687573302, 11273.041791447818, 11275.66173014811, 11294.887051129384, 11625.6512304631], "value": 11510.369749577187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1604.9197540123005, 1627.79652543432, 1641.7537369394586, 1643.1373528897327, 1666.6583350413166, 10767.784644307108, 11389.715257118556, 11390.202685811997, 11412.828807567894, 11427.600033998811, 10474.319169253993, 10651.627193048245, 10817.296875703094, 10944.507497162627, 11002.50488728007, 2172.837531920423, 2436.3909022744315, 2451.129848903636, 2492.1277552856536, 2498.4503409249937, 2387.5821731197057, 2458.21337172105, 2494.3639371960126, 2496.463260399014, 2509.2346834215555, 2410.301012706313, 2483.7640424159767, 2490.1906880263896, 2490.713567939692, 2492.663490428796, 2424.0, 2438.9390265243424, 2459.077845807822, 2467.6421918821848, 2475.2450502596703, 2442.7068751749903, 2459.3605662527693, 2468.938276543083, 2475.777180053804, 2476.938076548083, 11040.116790656808, 11298.661040168727, 11309.377984210865, 11314.547418103266, 11319.490622921989, 5309.65487243328, 5826.572489739999, 5857.970710146465, 6031.306399764039, 6068.211132552784, 3644.6355364463607, 3736.8505259789576, 3805.2389522095414, 3825.8278377472802, 3872.0900588361715, 1207.8067509198486, 1236.4714159543755, 1252.4238850128952, 1276.540445439641, 1302.6873550347943, 13832.446702132003, 14140.646483837883, 14562.781558276634, 15615.29731162089, 15773.76339354899, 4110.856120035784, 4776.593989510861, 4867.148249056401, 4917.385326834145, 4948.480409557017, 10273.434961077062, 10460.581576736997, 11938.462769175409, 11958.521659133712, 11961.983231425427, 5837.824865254049, 6019.819405417845, 6039.969800150971, 6042.607230530001, 6058.0610005449225, 5304.257403963448, 5438.592105592017, 5441.2654291670115, 5518.91721624176, 5519.889602207933, 3403.6256011838677, 4009.0578714002186, 4024.5170579530645, 4048.858289959896, 4096.446979657708, 1078.229066217658, 1079.2175672637275, 1091.6070214722693, 1096.31480324797, 1096.528492748126, 953.5899563187896, 978.6623614852864, 989.8614194012844, 1000.0749306891097, 1008.168261184511, 6620.702068406933, 6709.899351509731, 6772.390484856386, 6819.079424277659, 6871.587704737732, 938.5025936253796, 987.4568987057233, 1033.478093562761, 1035.471909326234, 1065.408698172506, 4027.3153563894207, 4178.12259425524, 4291.785410729451, 4383.473983122046, 4415.161119387306, 13451.461941522426, 13971.86028139726, 13982.091164074303, 14001.859981400055, 14015.649608759863, 12936.547220847226, 13906.51327203543, 13935.372908219155, 13948.0, 13985.930070349787, 10031.648892288735, 10303.690889273334, 10306.278560500694, 10314.690559283234, 10315.742106447398, 6829.931700683128, 6909.372579395857, 7021.508494405342, 7052.365287124184, 7115.288471152843, 10926.78146437051, 11124.833127502932, 12604.0, 12612.873871261538, 12624.495020199089, 10620.362778233331, 12326.260424374566, 12518.061145413949, 13015.154014988995, 13140.145890517086, 9247.352685312233, 9498.620055197714, 9511.381760185566, 9533.332666713264, 9534.284928630519, 9999.650012249536, 10364.119049880845, 10484.21368397358, 10486.213533984828, 10503.94748026255, 8738.21356077956, 8789.956050219964, 8937.776555586162, 9144.58849351794, 9175.908240917772, 8330.708425205088, 8410.957945210235, 8712.651493940171, 8721.258693011165, 8778.648854045767, 8250.834983300421, 8282.213189746964, 8282.627281772455, 8292.212239837207, 8301.086880443267, 5412.404635490014, 5613.57898157648, 5984.910226346521, 6040.516758659209, 6245.7189426476825, 5908.172855800105, 6086.147939288591, 6216.0, 6260.311365749672, 6264.444654297335], "value": 5241.053322434382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.9961500384997, 394.86377199866047, 402.2257154976669, 402.98849886784166, 407.54558667086206, 4602.8032711495, 4880.487548807378, 5108.310378098965, 5170.810713535889, 5174.715390653512, 3951.7628942263486, 4250.532441431448, 4435.77821108944, 4739.838739508817, 5052.762073292049, 3782.4681004193208, 4453.621442177418, 4461.843835465759, 4479.512597068598, 4525.841595544157, 3988.561258261589, 4012.418199361091, 4494.101179764044, 4495.370648109268, 4505.594496495315, 3680.9815950920206, 4196.853110141145, 4254.298280687719, 4268.1890440816305, 4271.295236286009, 3536.0806190390426, 3988.7207895447186, 4287.3140297552245, 4301.118270754488, 4309.547497512779, 3563.768355056913, 3980.1641655252142, 3992.6207010333974, 4000.3599424092004, 4001.47980762499, 4612.677112602119, 4781.832635857728, 4999.850004499871, 5023.0, 5030.974845125751, 4956.355673762424, 4957.429895562021, 4960.50394960501, 4963.553280204763, 4994.950050499521, 4946.985867897072, 5513.283273174502, 5535.03136951032, 5549.667019978814, 5551.8889622207325, 4099.893028882185, 4279.587736047097, 4367.1831668573595, 4371.671568237805, 4417.7349359038235, 5414.91877621836, 5701.57238207132, 5771.8557036074435, 5777.508911742507, 5817.272840894888, 4054.0743147004937, 4276.636485898734, 4384.473863136444, 4552.339910712928, 4561.110583436198, 4331.7184383015, 4444.466664000341, 4530.847847272519, 4532.79602417892, 4637.675362724577, 4745.311929770164, 4827.348307978448, 4905.607551395879, 4924.482929292444, 4931.556159945622, 4527.932081018787, 4790.856274311776, 5254.791397978486, 5493.395726470085, 5576.358718747315, 1428.8285405751376, 1470.1402725552184, 1555.7631682812191, 1574.0948954351293, 1598.6562888978926, 1072.1958531101673, 1098.291601916775, 1136.323887287063, 1139.1375101708766, 1192.8012347590616, 4582.495925448198, 4883.609311255091, 5066.693310685888, 5123.0, 5167.302414174113, 5165.560927321145, 5472.589555783332, 5657.001789051809, 5682.9147562785765, 5702.714864256771, 4213.073123912734, 4540.137373898949, 4874.902501949941, 5152.3044389007755, 5155.510226528474, 2732.972670273272, 2891.277180704824, 2939.1923966760714, 2947.778916581265, 2961.644602647696, 5242.5281724644965, 5455.536279416215, 5525.668459892419, 5719.57103217252, 5948.464638182584, 4853.56819738171, 5439.374471935699, 5842.59101862874, 5851.050540884886, 5883.882322353529, 5939.446038203614, 5950.523958083343, 5976.342602313742, 6026.578139530278, 6029.517638588903, 5044.949550504448, 5388.488093631099, 5735.680793417454, 5764.942350576608, 5853.326867410302, 5453.809116680897, 5645.689487078086, 5663.603547751783, 5665.943340566541, 5684.403137670485, 5164.870878227924, 5406.162044883049, 5881.911846308447, 5998.93036902268, 6041.9395806041375, 3865.8595714263797, 4228.70399072062, 4514.954850451453, 4546.909061818811, 4607.677462577722, 4754.787529180037, 5081.466446023114, 5100.821471248489, 5294.596931813149, 5746.075064853321, 4719.38647975761, 4875.585575226146, 5304.920426193533, 5416.945830541802, 5419.295491586068, 5138.409082955508, 5147.382314122329, 5266.867623460974, 5518.2826232591115, 5550.7510810067415, 4680.297955306732, 4766.809327626856, 4959.007998561048, 5149.48505149482, 5286.76209570578, 4971.477994810492, 5449.395261004445, 5506.889862202814, 5513.779448822002, 5527.336719593674, 4212.326027835532, 4721.409823772028, 4787.832425865078, 5359.732013399393, 5382.596305277041], "value": 4213.578085735605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.8951546783451, 767.0565204798102, 785.1873311122989, 878.5958459108809, 893.7899593595506, 16659.83340166598, 17211.741823872653, 17331.91334043331, 17466.650666986654, 17500.12499375031, 16010.119443430607, 16251.024938503699, 16256.349746010146, 16260.674786504293, 16261.83738162621, 993.1657407777466, 1013.5489707080352, 1047.4710271313015, 1048.5700862646318, 1059.3749687684265, 1005.9990309641917, 1020.7346090016612, 1025.4513835098223, 1027.0551092994426, 1027.250107421579, 1074.1943542343242, 1074.3607553505651, 1077.224398433127, 1077.4774234496263, 1080.1466841195447, 1062.5696592879897, 1064.7391389109641, 1065.1585247654343, 1066.9306495077872, 1067.738404090995, 796.6733639207955, 797.2904115337296, 799.0730752327272, 801.9839603207903, 804.2560631415917, 16057.919710401373, 16387.42644007454, 16856.57858553546, 16933.91533042339, 16937.237824297936, 14621.853781462261, 14801.259937003108, 14868.0, 14880.62798430037, 14896.329665165094, 12041.39793010346, 12140.392980350947, 12157.270563766115, 12190.756184876342, 12475.064370172182, 3718.1448266898765, 3769.8869033929027, 3844.8077596120083, 3901.707371947087, 3993.62060604245, 81006.0, 87921.12078879193, 103234.0, 103387.0, 104475.77621118914, 11178.664640060812, 11268.323900565829, 11430.428478576205, 11450.0, 11567.652970410902, 22886.313410597708, 23183.0, 23742.0, 23766.524669506514, 23775.643365349533, 7899.188092016174, 7965.0, 7968.402369822286, 8053.758387248392, 8144.022717273847, 4501.88745281364, 4555.794989225493, 4603.769811509411, 4688.789004494806, 4700.670953033323, 3651.9634803652157, 3750.456183853326, 3751.0622344413896, 3753.042974041602, 3759.3984962405884, 634.2230767310008, 653.8256763413654, 672.1631568697004, 673.1854456108066, 679.2290749998787, 691.5193940211606, 693.5734523268254, 718.2888939949412, 735.9043324367798, 760.8334449288548, 10526.263161578616, 10949.56201751921, 10965.396903170402, 11043.282186657842, 11280.379579123062, 702.9543079699803, 711.2745000099869, 725.6371814092954, 734.5812886654555, 752.9058867641545, 4883.487233840467, 5185.611079169077, 5285.68285902847, 5305.495977882095, 5307.0, 78803.0, 95993.0, 108807.91192088136, 109815.0, 114882.0, 60835.0, 62680.37319626745, 66458.66770666116, 80292.5985370081, 86628.26743465096, 62114.68942655258, 73023.0, 78115.0, 79417.41165176779, 80692.59653701694, 11205.04757095656, 11340.262882912913, 11484.712882178012, 11546.769064618493, 11609.3614851184, 38911.221775564896, 49581.752091239316, 50246.49753502418, 53238.0, 54087.45912540824, 62535.37464625295, 62753.372466274755, 63174.68412658091, 64372.0, 64872.0, 12832.294223817406, 13182.736345273233, 13359.0, 13549.729005420033, 13641.0, 14304.213268270345, 14869.925650371679, 15203.935724499179, 15741.0, 15879.68240635204, 14556.344964476835, 14665.193414362313, 14849.480268190562, 15036.398544058115, 15483.380664773284, 13582.79625805594, 14280.857191427953, 14399.640008999859, 14957.476488322856, 15474.690506190038, 14085.788713169515, 14124.364403601658, 14544.345504452114, 14713.33789979432, 14818.703625927637, 10016.949915250378, 10675.786484270116, 10825.837612435977, 10827.783444331228, 11169.0, 11616.651500455, 11644.941775291409, 11749.823752643546, 11837.171398002058, 11942.0], "value": 7964.318353627131, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1414.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 104.0, 164.0, 141.0, 137.0, 108.0, 108.0, 127.0, 107.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 185.0, 186.0, 196.0, 261.0, 210.0, 184.0, 183.0, 183.0], "value": 195.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 91.0, 61.0, 58.0, 57.0, 60.0, 72.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 111.0, 101.0, 99.0, 68.0, 82.0, 69.0, 68.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 92.0, 93.0, 92.0, 92.0, 93.0, 93.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 83.0, 85.0, 84.0, 85.0, 86.0, 85.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 57.0, 60.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 66.0, 66.0, 59.0, 61.0, 58.0, 57.0, 57.0, 58.0, 57.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 81.0, 81.0, 83.0, 80.0, 82.0, 84.0, 82.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 133.0, 132.0, 126.0, 134.0, 125.0, 138.0, 172.0, 145.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 159.0, 160.0, 160.0, 166.0, 214.0, 170.0, 159.0, 159.0, 159.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 62.0, 65.0, 66.0, 58.0, 63.0], "value": 63.2, "unit": "score"}]}]} 09:14:43 INFO - Return code: 0 09:14:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:43 INFO - # TBPL SUCCESS # 09:14:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:43 INFO - 2017-05-04 09:14:43.177 screenresolution[1667:12273] starting screenresolution argv=screenresolution get 09:14:43 INFO - 2017-05-04 09:14:43.180 screenresolution[1667:12273] Display 0: 1600x1200x32@60 09:14:43 INFO - 2017-05-04 09:14:43.186 screenresolution[1668:12276] starting screenresolution argv=screenresolution list 09:14:43 INFO - Available Modes on Display 0 09:14:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:43 INFO - Intel Iris: 09:14:43 INFO - Chipset Model: Intel Iris 09:14:43 INFO - Type: GPU 09:14:43 INFO - Bus: Built-In 09:14:43 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:43 INFO - Vendor: Intel (0x8086) 09:14:43 INFO - Device ID: 0x0a2e 09:14:43 INFO - Revision ID: 0x0009 09:14:43 INFO - Displays: 09:14:43 INFO - Display: 09:14:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:43 INFO - Display Serial Number: 1600x1200 60 09:14:43 INFO - Main Display: Yes 09:14:43 INFO - Mirror: Off 09:14:43 INFO - Online: Yes 09:14:43 INFO - Rotation: Supported 09:14:43 INFO - Return code: 0 09:14:43 INFO - Running post-action listener: _resource_record_post_action 09:14:43 INFO - [mozharness: 2017-05-04 16:14:43.417254Z] Finished run-tests step (success) 09:14:43 INFO - Running post-run listener: _resource_record_post_run 09:14:43 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 33004544; Write bytes: 425455616; Read time: 196; Write time: 1412 09:14:43 INFO - TinderboxPrint: CPU usage
53.8% 09:14:43 INFO - TinderboxPrint: I/O read bytes / time
33,004,544 / 196 09:14:43 INFO - TinderboxPrint: I/O write bytes / time
425,455,616 / 1,412 09:14:43 INFO - TinderboxPrint: CPU idle
2,204.3 (46.2%) 09:14:43 INFO - TinderboxPrint: CPU system
950.9 (19.9%) 09:14:43 INFO - TinderboxPrint: CPU user
1,614.4 (33.8%) 09:14:43 INFO - TinderboxPrint: Swap in / out
150,794,240 / 0 09:14:43 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 110719488; Write bytes: 105834496; Read time: 9918; Write time: 237 09:14:43 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 32074752; Write bytes: 299833344; Read time: 184; Write time: 1121 09:14:43 INFO - Running post-run listener: _upload_blobber_files 09:14:43 INFO - Blob upload gear active. 09:14:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:43 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 09:14:43 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:43 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:44 INFO - (blobuploader) - INFO - Done attempting. 09:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:45 INFO - (blobuploader) - INFO - Done attempting. 09:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:46 INFO - (blobuploader) - INFO - Done attempting. 09:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:48 INFO - (blobuploader) - INFO - Done attempting. 09:14:48 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:48 INFO - Return code: 0 09:14:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0dfcdf99ec11472d9b6b3cbb86d383f352bb554bf601235670336003b4a01ad0721fa6cadf58bd5de71df22105dd9c265079217184e8d270ad142aa65a3e906d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1564300e331c3c7e2a138cd0dcd9de7648a3144adb53ef2b6da25e4df20fee88e707df2dcf512534d11d31961a4741f2f78e5ea367b392d1f1f5868eed9daa73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91ad4bbb6a17da7c0d333cf6eade564c86918db23690426ad954b886d86a340a463ac594f741140291521a12c7e3a7292ed017f22ba1c647b09f0d82e1646c50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bcde2a87d7110e58ab34a3f07ad959658cd8e7f78a4f725dd714e3d65a684ad7f3eb0dedefa27795ed5ffbc0e340cb541f70f1dc9db9fd8f47289cec7416ab4"} 09:14:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:48 INFO - Contents: 09:14:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0dfcdf99ec11472d9b6b3cbb86d383f352bb554bf601235670336003b4a01ad0721fa6cadf58bd5de71df22105dd9c265079217184e8d270ad142aa65a3e906d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1564300e331c3c7e2a138cd0dcd9de7648a3144adb53ef2b6da25e4df20fee88e707df2dcf512534d11d31961a4741f2f78e5ea367b392d1f1f5868eed9daa73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91ad4bbb6a17da7c0d333cf6eade564c86918db23690426ad954b886d86a340a463ac594f741140291521a12c7e3a7292ed017f22ba1c647b09f0d82e1646c50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bcde2a87d7110e58ab34a3f07ad959658cd8e7f78a4f725dd714e3d65a684ad7f3eb0dedefa27795ed5ffbc0e340cb541f70f1dc9db9fd8f47289cec7416ab4"} 09:14:48 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:48 INFO - Copying logs to upload dir... 09:14:48 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.962404 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-04 09:14:48.750517) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 09:14:48.754466) ========= 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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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/Mozilla-Beta/sha512/0dfcdf99ec11472d9b6b3cbb86d383f352bb554bf601235670336003b4a01ad0721fa6cadf58bd5de71df22105dd9c265079217184e8d270ad142aa65a3e906d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1564300e331c3c7e2a138cd0dcd9de7648a3144adb53ef2b6da25e4df20fee88e707df2dcf512534d11d31961a4741f2f78e5ea367b392d1f1f5868eed9daa73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91ad4bbb6a17da7c0d333cf6eade564c86918db23690426ad954b886d86a340a463ac594f741140291521a12c7e3a7292ed017f22ba1c647b09f0d82e1646c50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bcde2a87d7110e58ab34a3f07ad959658cd8e7f78a4f725dd714e3d65a684ad7f3eb0dedefa27795ed5ffbc0e340cb541f70f1dc9db9fd8f47289cec7416ab4"} build_url:https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010746 build_url: 'https://queue.taskcluster.net/v1/task/INXekcxKQAyq1gbOIJQw0g/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0dfcdf99ec11472d9b6b3cbb86d383f352bb554bf601235670336003b4a01ad0721fa6cadf58bd5de71df22105dd9c265079217184e8d270ad142aa65a3e906d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1564300e331c3c7e2a138cd0dcd9de7648a3144adb53ef2b6da25e4df20fee88e707df2dcf512534d11d31961a4741f2f78e5ea367b392d1f1f5868eed9daa73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91ad4bbb6a17da7c0d333cf6eade564c86918db23690426ad954b886d86a340a463ac594f741140291521a12c7e3a7292ed017f22ba1c647b09f0d82e1646c50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bcde2a87d7110e58ab34a3f07ad959658cd8e7f78a4f725dd714e3d65a684ad7f3eb0dedefa27795ed5ffbc0e340cb541f70f1dc9db9fd8f47289cec7416ab4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 09:14:48.789495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:14:48.789844) ========= 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.g6c3yWq2Wh/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.qP4GIskK4l/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:14:48.839294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 09:14:48.839647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 09:14:48.840021) ========= ========= Total master_lag: 0.18 =========