builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0253 starttime: 1482199768.3 results: success (0) buildid: 20161219164723 builduid: 4ea8dda7b5604ad982b8d3778ea373e4 revision: 567894f026558e6dada617a3998f29aed06ac7d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:28.301042) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:28.301451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:28.301727) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:29.054825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:29.055203) ========= 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.w62HZoRucx/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.g14vFiVrqd/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 --2016-12-19 18:09:29-- 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% 159M=0s 2016-12-19 18:09:29 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.587999 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:29.692825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:29.693135) ========= 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.w62HZoRucx/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.g14vFiVrqd/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.026288 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:29.754640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 18:09:29.754973) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 567894f026558e6dada617a3998f29aed06ac7d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 567894f026558e6dada617a3998f29aed06ac7d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w62HZoRucx/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.g14vFiVrqd/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 2016-12-19 18:09:29,879 truncating revision to first 12 chars 2016-12-19 18:09:29,879 Setting DEBUG logging. 2016-12-19 18:09:29,879 attempt 1/10 2016-12-19 18:09:29,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/567894f02655?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 18:09:31,141 unpacking tar archive at: mozilla-central-567894f02655/testing/mozharness/ program finished with exit code 0 elapsedTime=1.521121 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 18:09:31.331329) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:31.331630) ========= script_repo_revision: 567894f026558e6dada617a3998f29aed06ac7d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:31.332024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:31.332286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 18:09:31.351879) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-19 18:09:31.352199) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w62HZoRucx/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.g14vFiVrqd/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 18:09:31 INFO - MultiFileLogger online at 20161219 18:09:31 in /builds/slave/test 18:09:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:09:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:09:31 INFO - {'append_to_log': False, 18:09:31 INFO - 'base_work_dir': '/builds/slave/test', 18:09:31 INFO - 'blob_upload_branch': 'Firefox', 18:09:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:09:31 INFO - 'branch': 'Firefox', 18:09:31 INFO - 'buildbot_json_path': 'buildprops.json', 18:09:31 INFO - 'config_files': ('talos/mac_config.py',), 18:09:31 INFO - 'default_actions': ('clobber', 18:09:31 INFO - 'read-buildbot-config', 18:09:31 INFO - 'download-and-extract', 18:09:31 INFO - 'populate-webroot', 18:09:31 INFO - 'create-virtualenv', 18:09:31 INFO - 'install', 18:09:31 INFO - 'run-tests'), 18:09:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:09:31 INFO - 'download_minidump_stackwalk': True, 18:09:31 INFO - 'download_symbols': 'ondemand', 18:09:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:09:31 INFO - 'tooltool.py': '/tools/tooltool.py', 18:09:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:09:31 INFO - '/tools/misc-python/virtualenv.py')}, 18:09:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:09:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:09:31 INFO - 'installer_path': 'installer.exe', 18:09:31 INFO - 'log_level': 'info', 18:09:31 INFO - 'log_name': 'talos', 18:09:31 INFO - 'log_to_console': True, 18:09:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:09:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:09:31 INFO - 'opt_config_files': (), 18:09:31 INFO - 'pip_index': False, 18:09:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:31 INFO - 'cmd': ('bash', 18:09:31 INFO - '-c', 18:09:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:31 INFO - 'enabled': True, 18:09:31 INFO - 'halt_on_failure': False, 18:09:31 INFO - 'name': 'check_screen_resolution'},), 18:09:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:31 INFO - 'cmd': ('bash', 18:09:31 INFO - '-c', 18:09:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:31 INFO - 'enabled': True, 18:09:31 INFO - 'halt_on_failure': False, 18:09:31 INFO - 'name': 'check_screen_resolution'},), 18:09:31 INFO - 'run_cmd_checks_enabled': True, 18:09:31 INFO - 'sps_profile': False, 18:09:31 INFO - 'sps_profile_interval': 0, 18:09:31 INFO - 'suite': 'dromaeojs', 18:09:31 INFO - 'system_bits': '32', 18:09:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:09:31 INFO - 'title': 't-yosemite-r7-0253', 18:09:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:09:31 INFO - 'use_talos_json': True, 18:09:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:09:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:09:31 INFO - 'work_dir': 'build'} 18:09:31 INFO - [mozharness: 2016-12-20 02:09:31.554818Z] Running clobber step. 18:09:31 INFO - Running pre-action listener: _resource_record_pre_action 18:09:31 INFO - Running main action method: clobber 18:09:31 INFO - rmtree: /builds/slave/test/build 18:09:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:09:33 INFO - Running post-action listener: _resource_record_post_action 18:09:33 INFO - [mozharness: 2016-12-20 02:09:33.929574Z] Finished clobber step (success) 18:09:33 INFO - [mozharness: 2016-12-20 02:09:33.929764Z] Running read-buildbot-config step. 18:09:33 INFO - Running pre-action listener: _resource_record_pre_action 18:09:33 INFO - Running main action method: read_buildbot_config 18:09:33 INFO - Using buildbot properties: 18:09:33 INFO - { 18:09:33 INFO - "project": "", 18:09:33 INFO - "product": "firefox", 18:09:33 INFO - "script_repo_revision": "production", 18:09:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:09:33 INFO - "repository": "", 18:09:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:09:33 INFO - "buildid": "20161219164723", 18:09:33 INFO - "pgo_build": "False", 18:09:33 INFO - "basedir": "/builds/slave/test", 18:09:33 INFO - "buildnumber": 14, 18:09:33 INFO - "slavename": "t-yosemite-r7-0253", 18:09:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:09:33 INFO - "platform": "yosemite_r7", 18:09:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:09:33 INFO - "branch": "mozilla-central", 18:09:33 INFO - "repo_path": "mozilla-central", 18:09:33 INFO - "revision": "567894f026558e6dada617a3998f29aed06ac7d8", 18:09:33 INFO - "stage_platform": "macosx64", 18:09:33 INFO - "builduid": "4ea8dda7b5604ad982b8d3778ea373e4", 18:09:33 INFO - "slavebuilddir": "test" 18:09:33 INFO - } 18:09:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:09:33 INFO - Running post-action listener: _resource_record_post_action 18:09:33 INFO - [mozharness: 2016-12-20 02:09:33.933200Z] Finished read-buildbot-config step (success) 18:09:33 INFO - [mozharness: 2016-12-20 02:09:33.933287Z] Running download-and-extract step. 18:09:33 INFO - Running pre-action listener: _resource_record_pre_action 18:09:33 INFO - Running main action method: download_and_extract 18:09:33 INFO - mkdir: /builds/slave/test/build/tests 18:09: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')]} 18:09:33 INFO - trying https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:09:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 18:09:34 INFO - Downloaded 1199 bytes. 18:09:34 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:09:34 INFO - Using the following test package requirements: 18:09:34 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:09:34 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:09:34 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:09:34 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'jsshell-mac.zip'], 18:09:34 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:09:34 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:09:34 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:09:34 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:09:34 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:09:34 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:09:34 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:09:34 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:09:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:09:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:09:34 INFO - Fetch https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:09:35 INFO - Expected file size: 16276055 18:09:35 INFO - Obtained file size: 16276055 18:09:42 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:09:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:09:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:09:42 INFO - Fetch https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:09:43 INFO - Expected file size: 16276055 18:09:43 INFO - Obtained file size: 16276055 18:09:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:09:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:09:50 INFO - Fetch https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:09:51 INFO - Expected file size: 14409734 18:09:51 INFO - Obtained file size: 14409734 18:09:52 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')]} 18:09:52 INFO - trying https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:09:52 INFO - Downloading https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 18:09:55 INFO - Downloaded 69568882 bytes. 18:09:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:09:55 INFO - mkdir: /builds/slave/test/properties 18:09:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:55 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:55 INFO - Contents: 18:09:55 INFO - build_url:https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:09:55 INFO - Running post-action listener: _resource_record_post_action 18:09:55 INFO - Running post-action listener: set_extra_try_arguments 18:09:55 INFO - [mozharness: 2016-12-20 02:09:55.872342Z] Finished download-and-extract step (success) 18:09:55 INFO - [mozharness: 2016-12-20 02:09:55.872488Z] Running populate-webroot step. 18:09:55 INFO - Running pre-action listener: _resource_record_pre_action 18:09:55 INFO - Running main action method: populate_webroot 18:09:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:55 INFO - '--tppagecycles', 18:09:55 INFO - '7'], 18:09:55 INFO - 'tests': ['tsvgm']}}, 18:09:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:09:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:09:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:09:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:09:55 INFO - 'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:09:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:09:55 INFO - 'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['damp', 'tps']}, 18:09:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:09:55 INFO - 'tests': ['damp', 'tps']}, 18:09:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['dromaeo_dom']}, 18:09:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['basic_compositor_video']}, 18:09:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:09:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['a11yr', 18:09:55 INFO - 'ts_paint', 18:09:55 INFO - 'tpaint', 18:09:55 INFO - 'sessionrestore', 18:09:55 INFO - 'sessionrestore_no_auto_restore', 18:09:55 INFO - 'tabpaint']}, 18:09:55 INFO - 'other-e10s': {'tests': ['a11yr', 18:09:55 INFO - 'ts_paint', 18:09:55 INFO - 'tpaint', 18:09:55 INFO - 'sessionrestore', 18:09:55 INFO - 'sessionrestore_no_auto_restore', 18:09:55 INFO - 'tabpaint']}, 18:09:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:09:55 INFO - 'ts_paint', 18:09:55 INFO - 'tpaint', 18:09:55 INFO - 'sessionrestore', 18:09:55 INFO - 'sessionrestore_no_auto_restore', 18:09:55 INFO - 'tabpaint']}, 18:09:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:09:55 INFO - 'ts_paint', 18:09:55 INFO - 'tpaint', 18:09:55 INFO - 'sessionrestore', 18:09:55 INFO - 'sessionrestore_no_auto_restore', 18:09:55 INFO - 'tabpaint']}, 18:09:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['a11yr', 18:09:55 INFO - 'ts_paint', 18:09:55 INFO - 'tpaint', 18:09:55 INFO - 'sessionrestore', 18:09:55 INFO - 'sessionrestore_no_auto_restore', 18:09:55 INFO - 'tabpaint']}, 18:09:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['a11yr', 18:09:55 INFO - 'ts_paint', 18:09:55 INFO - 'tpaint', 18:09:55 INFO - 'sessionrestore', 18:09:55 INFO - 'sessionrestore_no_auto_restore', 18:09:55 INFO - 'tabpaint']}, 18:09:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['tsvgx', 18:09:55 INFO - 'tsvgr_opacity', 18:09:55 INFO - 'tart', 18:09:55 INFO - 'tscrollx', 18:09:55 INFO - 'cart', 18:09:55 INFO - 'tsvg_static']}, 18:09:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:09:55 INFO - 'tsvgr_opacity', 18:09:55 INFO - 'tart', 18:09:55 INFO - 'tscrollx', 18:09:55 INFO - 'cart', 18:09:55 INFO - 'tsvg_static']}, 18:09:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:09:55 INFO - 'talos_options': ['--disable-e10s'], 18:09:55 INFO - 'tests': ['tp5o']}, 18:09:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:09:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:09:55 INFO - 'talos_options': ['--disable-e10s', 18:09:55 INFO - '--xperf_path', 18:09:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:55 INFO - 'tests': ['tp5n']}, 18:09:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:09:55 INFO - 'talos_options': ['--xperf_path', 18:09:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:55 INFO - 'tests': ['tp5n']}}, 18:09:55 INFO - 'talos.zip': {'path': '', 18:09:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:55 INFO - Running post-action listener: _resource_record_post_action 18:09:55 INFO - [mozharness: 2016-12-20 02:09:55.890805Z] Finished populate-webroot step (success) 18:09:55 INFO - [mozharness: 2016-12-20 02:09:55.890913Z] Running create-virtualenv step. 18:09:55 INFO - Running pre-action listener: _resource_record_pre_action 18:09:55 INFO - Running main action method: create_virtualenv 18:09:55 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:55 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 18:09:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:56 INFO - Using real prefix '/tools/python27' 18:09:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:09:59 INFO - Installing pip.................done. 18:09:59 INFO - Return code: 0 18:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:09:59 INFO - Reading from file tmpfile_stdout 18:09:59 INFO - Output received: 18:09:59 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) 18:09:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:59 INFO - 'HOME': '/Users/cltbld', 18:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:59 INFO - 'LOGNAME': 'cltbld', 18:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:59 INFO - 'MOZ_NO_REMOTE': '1', 18:09:59 INFO - 'NO_EM_RESTART': '1', 18:09:59 INFO - 'PAGER': '/bin/cat', 18:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:59 INFO - 'PWD': '/builds/slave/test', 18:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:59 INFO - 'SHELL': '/bin/bash', 18:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:09:59 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:59 INFO - 'USER': 'cltbld', 18:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:59 INFO - 'XPC_FLAGS': '0x0', 18:09:59 INFO - 'XPC_SERVICE_NAME': '0', 18:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:00 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 18:10:00 INFO - Cleaning up... 18:10:00 INFO - Return code: 0 18:10:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:10:00 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')]} 18:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:00 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')]} 18:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:00 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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:00 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 18:10:00 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 18:10:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:00 INFO - 'HOME': '/Users/cltbld', 18:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:00 INFO - 'LOGNAME': 'cltbld', 18:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:00 INFO - 'MOZ_NO_REMOTE': '1', 18:10:00 INFO - 'NO_EM_RESTART': '1', 18:10:00 INFO - 'PAGER': '/bin/cat', 18:10:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:00 INFO - 'PWD': '/builds/slave/test', 18:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:00 INFO - 'SHELL': '/bin/bash', 18:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:00 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:00 INFO - 'USER': 'cltbld', 18:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:00 INFO - 'XPC_FLAGS': '0x0', 18:10:00 INFO - 'XPC_SERVICE_NAME': '0', 18:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:00 INFO - Downloading/unpacking psutil>=3.1.1 18:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:10:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:04 INFO - Installing collected packages: psutil 18:10:04 INFO - Running setup.py install for psutil 18:10:04 INFO - building 'psutil._psutil_osx' extension 18:10:04 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 18:10:04 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 18:10:05 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 18:10:05 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 18:10:05 INFO - building 'psutil._psutil_posix' extension 18:10:05 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 18:10:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:10:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:10:05 INFO - ^ 18:10:05 INFO - 1 warning generated. 18:10:05 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 18:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:05 INFO - Successfully installed psutil 18:10:05 INFO - Cleaning up... 18:10:05 INFO - Return code: 0 18:10:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:05 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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:05 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 18:10:05 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 18:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:05 INFO - 'HOME': '/Users/cltbld', 18:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:05 INFO - 'LOGNAME': 'cltbld', 18:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:05 INFO - 'MOZ_NO_REMOTE': '1', 18:10:05 INFO - 'NO_EM_RESTART': '1', 18:10:05 INFO - 'PAGER': '/bin/cat', 18:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:05 INFO - 'PWD': '/builds/slave/test', 18:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:05 INFO - 'SHELL': '/bin/bash', 18:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:05 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:05 INFO - 'USER': 'cltbld', 18:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:05 INFO - 'XPC_FLAGS': '0x0', 18:10:05 INFO - 'XPC_SERVICE_NAME': '0', 18:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:10:05 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 18:10:05 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 18:10:05 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 18:10:05 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 18:10:05 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 18:10:05 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 18:10:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:10:08 INFO - Installing collected packages: mozsystemmonitor 18:10:08 INFO - Running setup.py install for mozsystemmonitor 18:10:08 INFO - Successfully installed mozsystemmonitor 18:10:08 INFO - Cleaning up... 18:10:08 INFO - Return code: 0 18:10:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:08 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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:08 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 18:10:08 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 18:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:08 INFO - 'HOME': '/Users/cltbld', 18:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:08 INFO - 'LOGNAME': 'cltbld', 18:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:08 INFO - 'MOZ_NO_REMOTE': '1', 18:10:08 INFO - 'NO_EM_RESTART': '1', 18:10:08 INFO - 'PAGER': '/bin/cat', 18:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:08 INFO - 'PWD': '/builds/slave/test', 18:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:08 INFO - 'SHELL': '/bin/bash', 18:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:08 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:08 INFO - 'USER': 'cltbld', 18:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:08 INFO - 'XPC_FLAGS': '0x0', 18:10:08 INFO - 'XPC_SERVICE_NAME': '0', 18:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:08 INFO - Downloading/unpacking jsonschema==2.5.1 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:10:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:10:11 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 18:10:11 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 18:10:11 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 18:10:11 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 18:10:11 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 18:10:11 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 18:10:11 INFO - Downloading functools32-3.2.3-2.tar.gz 18:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:10:12 INFO - warning: no files found matching '*.txt' 18:10:12 INFO - no previously-included directories found matching 'build' 18:10:12 INFO - no previously-included directories found matching 'dist' 18:10:12 INFO - no previously-included directories found matching '.git*' 18:10:12 INFO - Installing collected packages: jsonschema, functools32 18:10:12 INFO - Running setup.py install for functools32 18:10:12 INFO - warning: no files found matching '*.txt' 18:10:12 INFO - no previously-included directories found matching 'build' 18:10:12 INFO - no previously-included directories found matching 'dist' 18:10:12 INFO - no previously-included directories found matching '.git*' 18:10:12 INFO - Successfully installed jsonschema functools32 18:10:12 INFO - Cleaning up... 18:10:12 INFO - Return code: 0 18:10:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:12 INFO - 'HOME': '/Users/cltbld', 18:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:12 INFO - 'LOGNAME': 'cltbld', 18:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:12 INFO - 'MOZ_NO_REMOTE': '1', 18:10:12 INFO - 'NO_EM_RESTART': '1', 18:10:12 INFO - 'PAGER': '/bin/cat', 18:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:12 INFO - 'PWD': '/builds/slave/test', 18:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:12 INFO - 'SHELL': '/bin/bash', 18:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:12 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:12 INFO - 'USER': 'cltbld', 18:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:12 INFO - 'XPC_FLAGS': '0x0', 18:10:12 INFO - 'XPC_SERVICE_NAME': '0', 18:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:10:12 INFO - Cleaning up... 18:10:12 INFO - Return code: 0 18:10:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:12 INFO - 'HOME': '/Users/cltbld', 18:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:12 INFO - 'LOGNAME': 'cltbld', 18:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:12 INFO - 'MOZ_NO_REMOTE': '1', 18:10:12 INFO - 'NO_EM_RESTART': '1', 18:10:12 INFO - 'PAGER': '/bin/cat', 18:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:12 INFO - 'PWD': '/builds/slave/test', 18:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:12 INFO - 'SHELL': '/bin/bash', 18:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:12 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:12 INFO - 'USER': 'cltbld', 18:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:12 INFO - 'XPC_FLAGS': '0x0', 18:10:12 INFO - 'XPC_SERVICE_NAME': '0', 18:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:12 INFO - Downloading/unpacking blobuploader==1.2.4 18:10:12 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 18:10:12 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 18:10:12 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 18:10:12 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 18:10:12 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 18:10:12 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 18:10:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:10:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:10:15 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 18:10:15 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 18:10:15 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 18:10:15 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 18:10:15 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 18:10:15 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 18:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:10:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:10:16 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 18:10:16 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 18:10:16 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 18:10:16 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 18:10:16 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 18:10:16 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 18:10:16 INFO - Downloading docopt-0.6.1.tar.gz 18:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:10:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:10:16 INFO - Running setup.py install for blobuploader 18:10:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:10:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:10:16 INFO - Running setup.py install for requests 18:10:17 INFO - Running setup.py install for docopt 18:10:17 INFO - Successfully installed blobuploader requests docopt 18:10:17 INFO - Cleaning up... 18:10:17 INFO - Return code: 0 18:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:17 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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:17 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 18:10:17 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 18:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:17 INFO - 'HOME': '/Users/cltbld', 18:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:17 INFO - 'LOGNAME': 'cltbld', 18:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:17 INFO - 'MOZ_NO_REMOTE': '1', 18:10:17 INFO - 'NO_EM_RESTART': '1', 18:10:17 INFO - 'PAGER': '/bin/cat', 18:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:17 INFO - 'PWD': '/builds/slave/test', 18:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:17 INFO - 'SHELL': '/bin/bash', 18:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:17 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:17 INFO - 'USER': 'cltbld', 18:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:17 INFO - 'XPC_FLAGS': '0x0', 18:10:17 INFO - 'XPC_SERVICE_NAME': '0', 18:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:17 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-hqhZ3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-A9EUow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-HMdwKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-lbaIvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PE3Btc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-pufrvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jsnELz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-9hEBSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-G6Rcpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-uBe8i3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-X0N2md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-fs0n_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zhsnEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-89lfBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-TYaIHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-HjiF7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GNe2A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:10:19 INFO - Running setup.py install for manifestparser 18:10:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:10:19 INFO - Running setup.py install for mozcrash 18:10:19 INFO - Running setup.py install for mozdebug 18:10:20 INFO - Running setup.py install for mozdevice 18:10:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Running setup.py install for mozfile 18:10:20 INFO - Running setup.py install for mozhttpd 18:10:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Running setup.py install for mozinfo 18:10:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Running setup.py install for mozInstall 18:10:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:10:20 INFO - Running setup.py install for mozleak 18:10:20 INFO - Running setup.py install for mozlog 18:10:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:10:21 INFO - Running setup.py install for moznetwork 18:10:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:10:21 INFO - Running setup.py install for mozprocess 18:10:21 INFO - Running setup.py install for mozprofile 18:10:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:10:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:10:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:10:21 INFO - Running setup.py install for mozrunner 18:10:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:10:21 INFO - Running setup.py install for mozscreenshot 18:10:21 INFO - Running setup.py install for moztest 18:10:22 INFO - Running setup.py install for mozversion 18:10:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:10:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:10:22 INFO - Cleaning up... 18:10:22 INFO - Return code: 0 18:10:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:22 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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:22 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 18:10:22 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 18:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:22 INFO - 'HOME': '/Users/cltbld', 18:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:22 INFO - 'LOGNAME': 'cltbld', 18:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:22 INFO - 'MOZ_NO_REMOTE': '1', 18:10:22 INFO - 'NO_EM_RESTART': '1', 18:10:22 INFO - 'PAGER': '/bin/cat', 18:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:22 INFO - 'PWD': '/builds/slave/test', 18:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:22 INFO - 'SHELL': '/bin/bash', 18:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:22 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:22 INFO - 'USER': 'cltbld', 18:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:22 INFO - 'XPC_FLAGS': '0x0', 18:10:22 INFO - 'XPC_SERVICE_NAME': '0', 18:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:22 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-RfDLUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:22 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)) 18:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:22 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-yuq5Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:22 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)) 18:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:22 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-FozYXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:22 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)) 18:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:22 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-TXMgpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:22 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)) 18:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:22 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-N7wvxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zO3LPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-iNvbM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-T20zbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Xz53iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-I9gYxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-N3nfiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-UGtw81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-mlY7Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:23 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)) 18:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-weYi5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:24 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)) 18:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-RdDapq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:24 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)) 18:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-9XyNRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-b_3sb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:24 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)) 18:10:24 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)) 18:10:24 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)) 18:10:24 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)) 18:10:24 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)) 18:10:24 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)) 18:10:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:10:24 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 18:10:24 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 18:10:24 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 18:10:24 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 18:10:24 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 18:10:24 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 18:10:26 INFO - Downloading blessings-1.6.tar.gz 18:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:10:27 INFO - Installing collected packages: blessings 18:10:27 INFO - Running setup.py install for blessings 18:10:27 INFO - Successfully installed blessings 18:10:27 INFO - Cleaning up... 18:10:27 INFO - Return code: 0 18:10:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:27 INFO - Reading from file tmpfile_stdout 18:10:27 INFO - Current package versions: 18:10:27 INFO - blessings == 1.6 18:10:27 INFO - blobuploader == 1.2.4 18:10:27 INFO - docopt == 0.6.1 18:10:27 INFO - functools32 == 3.2.3-2 18:10:27 INFO - jsonschema == 2.5.1 18:10:27 INFO - manifestparser == 1.1 18:10:27 INFO - mozInstall == 1.12 18:10:27 INFO - mozcrash == 1.0 18:10:27 INFO - mozdebug == 0.1 18:10:27 INFO - mozdevice == 0.49 18:10:27 INFO - mozfile == 1.2 18:10:27 INFO - mozhttpd == 0.7 18:10:27 INFO - mozinfo == 0.9 18:10:27 INFO - mozleak == 0.1 18:10:27 INFO - mozlog == 3.4 18:10:27 INFO - moznetwork == 0.27 18:10:27 INFO - mozprocess == 0.23 18:10:27 INFO - mozprofile == 0.28 18:10:27 INFO - mozrunner == 6.13 18:10:27 INFO - mozscreenshot == 0.1 18:10:27 INFO - mozsystemmonitor == 0.3 18:10:27 INFO - moztest == 0.7 18:10:27 INFO - mozversion == 1.4 18:10:27 INFO - psutil == 3.1.1 18:10:27 INFO - requests == 1.2.3 18:10:27 INFO - wsgiref == 0.1.2 18:10:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:27 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 18:10:27 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 18:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:27 INFO - 'HOME': '/Users/cltbld', 18:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:27 INFO - 'LOGNAME': 'cltbld', 18:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:27 INFO - 'MOZ_NO_REMOTE': '1', 18:10:27 INFO - 'NO_EM_RESTART': '1', 18:10:27 INFO - 'PAGER': '/bin/cat', 18:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:27 INFO - 'PWD': '/builds/slave/test', 18:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:27 INFO - 'SHELL': '/bin/bash', 18:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:27 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:27 INFO - 'USER': 'cltbld', 18:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:27 INFO - 'XPC_FLAGS': '0x0', 18:10:27 INFO - 'XPC_SERVICE_NAME': '0', 18:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 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)) 18:10:27 INFO - Cleaning up... 18:10:27 INFO - Return code: 0 18:10:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 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 0x10bbe5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbe8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6aad95aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, '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.w62HZoRucx/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.g14vFiVrqd/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 18:10:27 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 18:10:27 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 18:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:27 INFO - 'HOME': '/Users/cltbld', 18:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:27 INFO - 'LOGNAME': 'cltbld', 18:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:27 INFO - 'MOZ_NO_REMOTE': '1', 18:10:27 INFO - 'NO_EM_RESTART': '1', 18:10:27 INFO - 'PAGER': '/bin/cat', 18:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:27 INFO - 'PWD': '/builds/slave/test', 18:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:27 INFO - 'SHELL': '/bin/bash', 18:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:27 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:27 INFO - 'USER': 'cltbld', 18:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:27 INFO - 'XPC_FLAGS': '0x0', 18:10:27 INFO - 'XPC_SERVICE_NAME': '0', 18:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:10:28 INFO - Cleaning up... 18:10:28 INFO - Return code: 0 18:10:28 INFO - Running post-action listener: _resource_record_post_action 18:10:28 INFO - Running post-action listener: _start_resource_monitoring 18:10:28 INFO - Starting resource monitoring. 18:10:28 INFO - [mozharness: 2016-12-20 02:10:28.099923Z] Finished create-virtualenv step (success) 18:10:28 INFO - [mozharness: 2016-12-20 02:10:28.100928Z] Running install step. 18:10:28 INFO - Running pre-action listener: _resource_record_pre_action 18:10:28 INFO - Running main action method: install 18:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:28 INFO - Reading from file tmpfile_stdout 18:10:28 INFO - Detecting whether we're running mozinstall >=1.0... 18:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:10:28 INFO - Reading from file tmpfile_stdout 18:10:28 INFO - Output received: 18:10:28 INFO - Usage: mozinstall [options] installer 18:10:28 INFO - Options: 18:10:28 INFO - -h, --help show this help message and exit 18:10:28 INFO - -d DEST, --destination=DEST 18:10:28 INFO - Directory to install application into. [default: 18:10:28 INFO - "/builds/slave/test"] 18:10:28 INFO - --app=APP Application being installed. [default: firefox] 18:10:28 INFO - mkdir: /builds/slave/test/build/application 18:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:10:50 INFO - Reading from file tmpfile_stdout 18:10:50 INFO - Output received: 18:10:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:10:50 INFO - Running post-action listener: _resource_record_post_action 18:10:50 INFO - [mozharness: 2016-12-20 02:10:50.256912Z] Finished install step (success) 18:10:50 INFO - [mozharness: 2016-12-20 02:10:50.257049Z] Running run-tests step. 18:10:50 INFO - Running pre-action listener: _resource_record_pre_action 18:10:50 INFO - Running main action method: run_tests 18:10:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:10:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:10:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:10:50 INFO - 2016-12-19 18:10:50.271 screenresolution[1637:7938] starting screenresolution argv=screenresolution get 18:10:50 INFO - 2016-12-19 18:10:50.274 screenresolution[1637:7938] Display 0: 1600x1200x32@60 18:10:50 INFO - 2016-12-19 18:10:50.279 screenresolution[1638:7940] starting screenresolution argv=screenresolution list 18:10:50 INFO - Available Modes on Display 0 18:10:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:10:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:10:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:10:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:10:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:10:50 INFO - Intel Iris: 18:10:50 INFO - Chipset Model: Intel Iris 18:10:50 INFO - Type: GPU 18:10:50 INFO - Bus: Built-In 18:10:50 INFO - VRAM (Dynamic, Max): 1536 MB 18:10:50 INFO - Vendor: Intel (0x8086) 18:10:50 INFO - Device ID: 0x0a2e 18:10:50 INFO - Revision ID: 0x0009 18:10:50 INFO - Displays: 18:10:50 INFO - Display: 18:10:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:10:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:10:50 INFO - Display Serial Number: 1600x1200 60 18:10:50 INFO - Main Display: Yes 18:10:50 INFO - Mirror: Off 18:10:50 INFO - Online: Yes 18:10:50 INFO - Rotation: Supported 18:10:50 INFO - Return code: 0 18:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:10:50 INFO - Python 2.7.3 18:10:50 INFO - Return code: 0 18:10:50 INFO - grabbing minidump binary from tooltool 18:10: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')]} 18:10:50 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 0x10b9c3d30>, '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 0x10b8eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:10:50 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 18:10:50 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 18:10:50 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 18:10:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:10:50 INFO - Return code: 0 18:10:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:10:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:10:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:10:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:10:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.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 18:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.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 18:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w62HZoRucx/Render', 18:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:50 INFO - 'HOME': '/Users/cltbld', 18:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:50 INFO - 'LOGNAME': 'cltbld', 18:10:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:10:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:50 INFO - 'MOZ_NO_REMOTE': '1', 18:10:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:10:50 INFO - 'NO_EM_RESTART': '1', 18:10:50 INFO - 'PAGER': '/bin/cat', 18:10:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:50 INFO - 'PWD': '/builds/slave/test', 18:10:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:50 INFO - 'SHELL': '/bin/bash', 18:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g14vFiVrqd/Listeners', 18:10:50 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 18:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:50 INFO - 'USER': 'cltbld', 18:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:50 INFO - 'XPC_FLAGS': '0x0', 18:10:50 INFO - 'XPC_SERVICE_NAME': '0', 18:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.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 18:10:50 INFO - mozversion application_buildid: 20161219164723 18:10:50 INFO - mozversion application_changeset: 567894f026558e6dada617a3998f29aed06ac7d8 18:10:50 INFO - mozversion application_display_name: Nightly 18:10:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:10:50 INFO - mozversion application_name: Firefox 18:10:50 INFO - mozversion application_remotingname: firefox 18:10:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:10:50 INFO - mozversion application_vendor: Mozilla 18:10:50 INFO - mozversion application_version: 53.0a1 18:10:50 INFO - mozversion platform_buildid: 20161219164723 18:10:50 INFO - mozversion platform_changeset: 567894f026558e6dada617a3998f29aed06ac7d8 18:10:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:10:50 INFO - mozversion platform_version: 53.0a1 18:10:50 INFO - using testdate: 1482199850 18:10:50 INFO - actual date: 1482199850 18:10:50 INFO - starting webserver on 'localhost:49241' 18:10:50 INFO - SUITE-START | Running 2 tests 18:10:50 INFO - TEST-START | dromaeo_css 18:10:50 INFO - operating with platform_type : mac_ 18:10:50 INFO - Initialising browser for dromaeo_css test... 18:10:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpDn_Ab2/profile http://localhost:49241/getInfo.html) 18:10:53 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 18:10:53 INFO - PROCESS | 1648 | colorDepth:24 18:10:53 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 18:10:53 INFO - PROCESS | 1648 | __metrics 18:10:53 INFO - PROCESS | 1648 | 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" 18:10:53 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:10:54 INFO - TEST-INFO | 1648: exit 0 18:10:54 INFO - Browser initialized. 18:10:54 INFO - Running cycle 1/1 for dromaeo_css test... 18:10:54 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpDn_Ab2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:06 INFO - PROCESS | 1652 | RSS: Main: 237027328 18:11:06 INFO - PROCESS | 1652 | 18:11:57 INFO - PROCESS | 1652 | 1482199917534 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:14:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 18:14:11 INFO - PROCESS | 1652 | RSS: Main: 400584704 18:14:11 INFO - PROCESS | 1652 | 18:17:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 18:17:15 INFO - PROCESS | 1652 | RSS: Main: 377856000 18:17:15 INFO - PROCESS | 1652 | 18:20:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 18:20:18 INFO - PROCESS | 1652 | RSS: Main: 351477760 18:20:18 INFO - PROCESS | 1652 | 18:23:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 18:23:21 INFO - PROCESS | 1652 | RSS: Main: 337809408 18:23:21 INFO - PROCESS | 1652 | 18:26:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 18:26:25 INFO - PROCESS | 1652 | RSS: Main: 335593472 18:26:25 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 18:29:29 INFO - PROCESS | 1652 | RSS: Main: 441155584 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | __start_tp_report 18:29:29 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 18:29:29 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 18:29:29 INFO - PROCESS | 1652 | |i|pagename|runs| 18:29:29 INFO - PROCESS | 1652 | |0;dojo.html;2694.8517831519266;3354.3962086824363;3355.8154301513423;3369.612494563126;3372.6458721834206;5593.776248950047;5600.607957442976;5643.379228284885;5687.772489100436;5714.628549144302;5654.37801841797;5676.943230567693;5699.74351154198;5706.600537962344;5708.800191993281;4298.731874097149;5133.3326667533265;5141.588672906178;5163.509466600667;5246.606504512158;5170.09523333417;5261.526462618363;5267.367915850104;5269.578433725293;5280.1815718563685;5183.714895680736;5220.973895130538;5224.45143259958;5236.136037553799;5262.789488420459;5267.078261304257;5269.604779641523;5280.3663560373;5286.682799032032;5295.152775555893;5072.213806859906;5086.109930762102;5146.897062058738;5188.169892817131;5200.193969934666;5581.888362232773;5643.5767317451355;5644.520215781622;5665.036943719537;5699.715014249271;6215.192025036717;6228.657423841687;6248.281447633535;6253.749850005995;6254.405831446051;6121.493465094016;6159.568830181889;6215.782447614357;6270.435660790551;6289.119523266746;5732.22614946981;5760.423957604248;5771.163181338767;5771.567132465082;5824.213731146241;6266.843328916813;6300.905486417708;6313.242410910629;6319.368063193644;6330.145430366933;5985.700714964234;6069.696515174223;6079.331273559993;6093.086037094471;6100.9057437040565;5441.891162176735;5806.490312518691;6183.659898705614;6192.040233763774;6250.656213908188;6212.502999760009;6224.346443623445;6228.377162283826;6241.469475094577;6247.875042499216;6236.438720515084;6237.376262373817;6244.500439964792;6257.217847769029;6259.812205633838;4851.975740121347;4883;4888.926666100011;4905.828296009622;4920.75396230187;4365.039691267916;4392.758398288125;4405.977970110193;4425.822967081281;4467.5755803198645;5733.455321744427;5742.397048309867;5746.885062298814;5753;5756.913646295309;6232.283287422005;6247.250329960434;6253.468455181361;6256.405641464054;6273.592216505913;4601.217792975135;5542.86142846424;5644.548436125182;5647.124695672177;5714.314282286069;5256.579473642099;5273.050850846885;5285.867853303698;5310;5316.388615309212;6294.370562943761;6297.2128483939505;6297.275813281532;6305.873882522415;6315.179026726588;6083.391660833881;6089.512838972783;6133.417325354084;6141.240538582456;6143.201383820075;5270.920936185884;6271.780487683091;6274.309825919054;6317.210348706411;6354.777582784581;6192.473639740672;6200.255969283535;6202.131701561695;6217.378262173746;6226.3151053385;6124.510039196764;6212.254529456494;6266.2480502338185;6275.592086514362;6279.497640188865;5942.940570594239;6016.157737916783;6017.3681763414215;6021.066734656135;6105.358937311518;6087.969560152171;6090.817275481742;6090.817275481742;6091.7563297467605;6099.268087829489;4878.146324393146;5088.974555127201;5866.560007999332;5867.442592953663;5902.822915312548;5840.94159058404;5951.940480595139;6044.0933859919605;6054.485368743706;6102.0541816018585;4873.756312184448;4878.487758785418;5902.793402230901;5915.58590898633;5920.970395147997 18:29:29 INFO - PROCESS | 1652 | |1;ext.html;432.44646852029405;440.0868198488138;482.94446138694036;489.8317512732135;495.8958618690075;29967;38150.236995260115;39750.60249397505;39775.80112099436;40079.39880901789;41682.58317416825;41964;42075.94810129748;42156.789216053876;42218;9297.349185556997;9500.714978550655;9511.239100871948;9519.524023798816;9532.18976387008;8484.490930544187;8683.696070637528;11191.328520288767;11420.771584568303;11448.771024579504;11321.377324247203;11371.374574398405;11373.601923932663;11376.374299413528;11381.2033157679;11332.376719280437;11380.317180969168;11403.828942565786;11405.030572401356;11451.656450306504;7551.24487551246;8396.370272229608;8614.353923455767;8677.566121693953;11166.609168679057;31430.528542071886;38404;39138.412923806165;39186.21627567461;40856.978575535555;2797.244743919151;3426.9828650856834;3504.877329293488;3512.7541072124964;3746.400575907842;27481.86259068692;27910.860445697843;28094.859525702446;28502.572461413096;28838.567421488693;3142.5286207068893;3151.6060492438446;3166.208447888028;3268.1502809269523;3271.689189526991;458108;460509.6974515106;461600;462014;464185;53295.467045329824;53570;53598.176164145414;53641.09947905727;53721.73139134357;55321.34035978927;55525;55619.72190139104;55709.1643625346;55746;14577.416903323749;15006.624834379229;15012.624684382978;15017.624559386102;15036.62408439776;11529.827052594217;11641.825372619418;11658.950694437372;11680.883191167979;11691.356975366436;14434.639134021734;14953.775693364609;14960.177190254422;16288.348466061461;16700.49898503047;6093.542984276197;7218.448033672786;7330.450216233804;7358.96320518394;7364.963175184197;837.2339309531832;906.7007887397143;1010.368519675203;1021.9897801022043;1025.9689012542347;29065.564016539767;29298.560521591768;29377.706222937497;30179.849100754356;30249.395012099634;1067.8451624514403;1085.7122862441458;1109.606089838112;1117.3240189685287;1161.1523587780966;11959.820602690967;14894.404223831141;15269.869676716247;15349.539513814603;15749.685006300038;648815;652546;653878;655835;826650;47807.04385912332;56366.15450768242;57932.71033644805;58352.416475834696;60715.69642151849;1304.478208716521;1331.6803967048033;1342.9597112086653;1350.1696456678876;1350.230368689857;25567.360815979748;29404.55893161647;30401.847990759903;31024.91412800541;31144.065678029696;48547.27179092387;49007;49026.509734902196;49125;49134.75432622814;540594;541497;542939;544397;544899;24632.384190395383;25288.218295987794;25693;25863.482730345662;25882;39174.02064948285;39576.80211598924;39923.80038099791;40136.39795403013;40638.9840253996;33312;33580.14568761682;33638.663613363555;33681.663183367855;34438.48342274918;28594;32987.010389688345;33498;34053;34196.65803341935;32594.85917992859;33290.167745806546;33537.329253415286;33576.489057992934;33579.49630755589;27779.722202777713;30201;30276.5458518118;30291.091267262018;30304.84847575748;21009.73941563511;21406.357809265748;22366.77633223712;22806.885965570065;23141.53716925686 18:29:29 INFO - PROCESS | 1652 | |2;jquery.html;357.3317895535349;374.60104988187595;375.183974854691;385.36030189884787;401.5241938303111;14504.564863054113;14898.180600066991;16195.919020404881;19432.02839858005;20397.898010509925;17418.912905435485;19340.4197874064;19760.30838920638;20343.389698309038;20389.592208155864;5702.714864256781;5966.46301832835;5972.970135149319;5977.252843394575;5989.9101513477335;5078.619103567229;6394.520410969173;6467.029945508164;6504.284528701839;6514.674266286666;6227.346128656493;6432.42108210261;6454.806355809334;6462.870742585145;6468.3855033771715;6422.2614399343975;6452.580582262138;6459.612423254573;6468.191476065492;6480.384363485461;5164.741762911877;5173.482651734834;5489.64317319373;5490.478404551601;5631.267935168402;12894.161879477897;13042.021848361412;13076.673083172902;21987.570807897435;23092.88453557738;2104.9052792624216;2177.6080305544997;2190.9014094365634;2247.8426510144295;2279.3959600705825;9704.272179586489;9749.610015599368;9752.4636145012;10181.490925453698;10346.586136554528;1803.6573051120376;1834.238790901774;1848.4639454558162;1901.1634880652468;1902.1630482587755;114902.27646585308;114969.4251528737;115014;115049;129284.35357823245;10914.890851091388;11109.111271098292;11234.943825280821;11552.018078463425;11751.588694395656;14147.646308842155;14591.416343346147;14656;14698.191599461918;14700.55898323052;8219.301359384399;8341.708040218564;8360.581970901552;8393.118722534045;8456.196661317288;8097.433179677366;8132;8134.227248411392;8315.625796839156;8354.874676879852;4461.219286624828;4504.324351347259;4542.318652202196;4581.015081757439;4610.976945115253;1781.189558750791;1883.1808163448943;1928.8939108349175;1929.411529483521;1934.796846331115;709.5317090720204;767.7005967672612;778.5445514374042;794.6503538443067;899.0739538275456;18709.064546772606;19630.509237268896;20289.086991085438;20395.8980205101;21188.04653790583;829.8921140251729;847.5296210603175;886.9423487473423;895.6596493332491;900.4732231644431;8293.004839419187;10452.947735261276;10503.684889453329;11206.719832004102;11358.716032099264;501927;518744;538193;554928;556036;121066;130799.9999999981;131902.34048829693;133665.33167334102;136401.3179934094;934.3412893909777;934.7008957133788;955.3742298794301;956.5982287439292;979.7452662307851;13800.792988105388;17500.82499174992;18905.71641425407;19550.65392152951;19689.21243150258;44312;50176;51809.740951295;52773.7361313191;56775;60227.39772602218;73907.54433062884;75288;80905.78641320503;81658;7283.817904552428;7565.924340756522;8014.156743949041;8287.378446616407;8291.295239904675;9296.907030929604;10804;12314.938425308175;13127.277999710108;13290.86709132935;6649;10794.460276985963;11182.720431989266;11213.87861213872;11405;11064.28082174656;11113.833292500458;11287;11328.886711132784;11546.653600392001;11021.944890275498;11425.828612570653;11679.182457228253;11723.41382930867;11749.118816088656;7852.568108754073;7937.877480586584;8022.197780221931;8159.83680326402;8489.811426400433;8243.587820609066;9996.150327221976;10823.621173258898;11306.4912078955;11424.200305978502 18:29:29 INFO - PROCESS | 1652 | |3;mootools.html;1485.5246321177224;1514.2958524286207;1665.3005737590217;1701.9404320848773;1806.0608483588542;7913.683452661894;8313.127121652231;8323.875141872877;8323.876276702644;8331.375146863988;7421.554706717588;7650.770476885702;7667.8849817252785;7800.7269745558915;8095.190480951902;2253.3803204118917;2328.2200462844967;2330.685357476736;2331.813454923602;2337.777911098443;2316.1198744477074;2332.183735692511;2341.075275266269;2355.3051849704293;2355.882205889707;2053.0863765624304;2225.121077174515;2286.2455389721354;2289.061484791236;2292.8165746740306;2280.600894843396;2307.157887371114;2307.457747429361;2307.988460057689;2308.734495533002;1943.620993906189;2314.2825724025606;2344.847584906993;2345.026813872241;2350.4828937633692;8130.634121464489;8175.591220438954;8247.298979586682;8254.298384637314;8258.298044666211;5033;5199.350081239845;5200.583953283728;5200.843974680765;5211.7133557654315;3082.7842051056437;3247.707706306444;3508.438649816017;3508.456189290664;3511.3328467591077;904.9819003619957;1015.9644412445602;1048.224314007629;1053.578568572577;1062.2511129653576;10450.47747612624;10693;10695.83956240657;10705;10707.625233116803;4487.753173575485;4678.345031695498;4727.479977202505;4751.263554149113;4755.762211889391;8362.58187090643;8581.742547723577;8638;8657.653693852302;8680.522571258514;5084.618653600995;5094.643374963791;5096.668716533413;5100.974495127501;5114.693118412907;4591.95408045922;4717.481077081518;4777.928331075037;4791.137595232822;4806.375171227718;3491.528643633077;3570.107473131717;3599.4240921452965;3618.87333943316;3637.944561322844;1111.6442738323658;1130.5647325779635;1130.909527237819;1139.3733446604335;1147.8737338892715;864.7578677970179;867.7483529776295;878.9912100879037;906.7143849687327;924.9953750231206;5159.922601160985;5210.711128204875;5573.080441727151;5588.9720551397795;5721.685307308055;404.88056023473143;425.6339547988727;427.8930267433142;439.35634295756233;447.29997553828804;3492.5808902931813;3682.0794801299676;3707.2029513654693;3836.616338366141;3838.9424158637644;9377.578008989612;9827.754306142404;9831.75420614476;9844.114029737359;9858.162056225157;9762.707118786306;9767.365121267096;9772.413655180711;9775.022497750168;9806.264530160266;7434.3309102181065;7651.579163146081;7659.693612255447;7756;7758.4181186410115;5387.676739395492;5397.3523177218985;5653.717314134195;5654.123610840326;5690.032694442038;8763.868541971748;9011.684591039282;9152.130547597968;9191.770205744642;9252.768680783034;7085.6811443486195;7690.423218258541;9190.724278271662;9286.442813431217;9321.207697345802;6999.930000700131;7191.568505889454;7192.460565457716;7197.424206063607;7201.639918003974;7497.175310715707;7693.961530192313;7779.805504862424;7784.2215778421705;7798.649060792164;5580.944190558205;6937.479689023445;6991.755288565079;7063.258357872555;7132.072830531998;6926.896096558455;6931.341522555349;6987.091678081817;7047.577145371294;7066.717331306896;5572.60991730575;6480.805575832733;6530.771423000172;6577.3422657733845;6584.979328204136;4745;4768.66619336657;4784.330193772944;4790.8323208687525;4942.6293028023765;3983.462232598562;4664.6501512387385;4764.356811830358;4811.254255590389;4863.610911127172 18:29:29 INFO - PROCESS | 1652 | |4;prototype.html;347.5308333749439;352.8817846021583;357.7799653213274;366.8495916674164;369.66175949006674;4352.4994625618065;4398.318260669594;5205;5216.869878073154;5235.450277720832;3757.849686012556;4818.614510839133;4827.30004149399;5009.445182956691;5124.564412024983;3534.2754735279204;3808.276427478777;3877.856032470428;3905.8047097645144;3912.041549820298;3620.8732694355704;4017.292650623488;4058.715889887694;4091.6112969267874;4110.424540564323;3100.1474594486585;3375.5274261603395;3465.792052476847;3512.350215210194;4031.044943202559;3250.463673493871;3540.327337805809;4043.9595604044025;4058.370952502367;4096.97951510242;2888.9310954946595;3135.6550779414247;3607.3687104756823;3613.927721445583;3630.8547658093644;4079.5920407959266;4597.678172522888;4898.265260210961;4963.8086859153545;4979.759108401234;4372.256716358195;4627.537246275379;4658.860234192945;4683.3842324398365;4702.365180700596;4614.469336026366;5015.899682006376;5390.973045134789;5420.674759514442;5450.781968721247;3979.98010009951;3988.1824226033596;3992;3992.321305378093;4014.116894283253;5367.0339338918975;5653.247493277097;5672.234248376458;5703.344115426696;5780.277465316835;4046.069404037088;4061.878143655636;4077.6126268005087;4083.244599749056;4109.260333140004;3520.8591656333974;4069.89825254371;4103.4460347853255;4126.731762435432;4157.771322577288;4296.462942132233;4385.780710964439;4722.409698787652;4722.716637001791;4796.328514008042;4821.397325334333;4854.344663470457;4975.676581022222;5180.352455943007;5213.843584692465;1198.676357383519;1332.7467781121557;1337.8628166058772;1339.5713371720956;1349.3455673998103;799.428408687791;831.8710599857031;889.9199072083544;927.6150397585062;945.9263735660076;4216.620504154641;4283.807228674717;4632.2125238709505;4736.455307639597;4784.626838079146;4424.778761061934;4744.7390393528685;4801.4958429365115;5275.20871869215;5277.313949186581;3905.5508616508896;4451.488078870972;4608.493065762764;4723.385959825269;4838.080764654705;2435.356134609132;2695.757381835644;2709.6206531085663;2747.5272254970687;2765.778737700979;5073.771680274396;5371.301730775052;5393.784248630011;5406.243125962368;5412.864678382994;5003.3495645565845;5087;5288.682679039193;5311.981447050173;5436.891262174734;4791.736454494967;5097.515736005073;5254.816081437131;5385.515303622693;5393.379761327419;4396.472423309224;4460.620847228022;4970.7879993402585;4995.500449954975;5167.276581278699;4514.119746649372;4911.656184067081;5118;5177.301064356264;5188.351456067991;4267.594578515036;4520.90958180828;4929.852104436873;5373.408925018323;5456.645318054472;3227.7095061444584;3316.369889720945;3581.871710411212;3728.738988270795;3781.357169281174;4408.404865343137;4732.148213321635;4838.2016967201425;4931.753412329297;5424.294841670558;4480.843170489017;4655.557722016403;4745.549172828576;4994.076095922266;5194.4805519447755;4117.876463706094;4272.188284225987;4327.697061205686;5040.093927206444;5107.624954396224;3651.160233146338;4147.398627198979;4674.839392940354;4779.761011949458;4832.912594666172;4235.4917409911;4997.827682811652;5254.842354729364;5388.541973932103;5389.541888939327;5335.866603334947;5368.2484452177505;5372.247885295984;5383.37030154075;5390.568754499553 18:29:29 INFO - PROCESS | 1652 | |5;yui.html;716.2872941423283;723.5007844587232;735.8270806360508;746.8842329438935;748.345197951792;15175.848241517582;15362.308696108674;15712.214389280547;15726.68546629068;15763.68472630548;14009.29953502326;14053.859461405384;14307.427702891899;14507.274636268197;14539.636509087279;689.0697558296285;715.4920006795181;721;853.71827296992;878.3895192840978;709.8331892005375;712.4976891291627;714.3463730686416;843.3843294395095;874;928.4058202750211;935.948522831244;938.1556599060832;940.3135710931025;940.9482478463682;933.7945651956559;934.686879895236;934.9762010598384;935.7473482159813;939.0421769794839;696.8919817428307;697.7034760226883;697.7592730507967;698.0227681246245;698.8602279544111;11814.291142531476;12305.261684298881;14603.415863365453;15078.54764357071;15166.772498412533;14100.788488172686;14309.642258943506;14406.207658578878;14415.279236038261;14425.49510767118;11599.6520104397;11866.406679666068;12063.93968030163;12073.637790866289;12225.594056683507;3560.181158333572;3772.5661548921953;3777.338965680995;3813.103920578662;3820.5797362290127;98200;104045.47977260141;106444.4677776614;106542;106867;8989;10156.796864062677;10672.675313255673;11174.553017879194;11284.379359135326;22644.547109057727;22923.885380573323;22968;22976.770232297797;23187.88406057959;7414.591227666726;7469.9253007470315;7540.132884718218;7577.962110189414;7659.310662040331;4176.665866730655;4314.676399270067;4370.628496577763;4460.910781784346;4503.414556107685;3087.1818967973504;3440.415129428003;3469.8438570263893;3539.150603855108;3562.7327950403824;563.7068724263443;570.9486146246858;571.9227904232876;574.2592056247394;580.494969376645;590.2120668906971;623.8752249550108;639.3228134168646;669.5012215899089;700.4256509662029;7058.929410705828;7784.3772498200005;9119.407238529475;9235.584398702074;9551.082203651493;564.221374503183;629.6064959400375;634.6826586706646;649.3409189672486;683.4771399879096;4332.783360831946;4461.442319710036;4505.324201369821;4530.184566778012;4533.54664533544;83873;101121.98878011126;108926;109998.45000775105;111954;72094.63952680203;76556;84373;91278;94668;79944.60027699824;80424.98937526492;80826.78759818607;82291;83310.58344708238;8527.720841873768;8589.871151932852;8749.650013999624;8761.826819433727;8839.46963182211;36490.8175459121;52676.473235267156;53608.731956339965;53907.73046134901;54636.72681636566;71530.64234678794;74690;75501;76561;77020.61489692515;11799.882001180222;11897.167198296036;11910.422118784765;11919.940400297943;12330.19853709506;12737.808932866199;12951.676208094874;12970.675733106747;13175.341232938506;13511.594652160451;11792.351420671603;11959.940200298943;12053.517859285881;12407.689807754878;12545.686357840761;11663.650090497298;12000.699982500508;12043.397830108284;12168.148229623841;12171.208871423329;11845.289282643069;11920.165588408729;11972.76054478923;12009.879901201226;12356.38218089074;8079.8384032317845;8776.605052772513;9468.715938521855;9825.250616310137;10283.434411107162;8698.91301086981;9562.330636855353;9858.408495490294;10357.792844143225;10361.326513776581 18:29:29 INFO - PROCESS | 1652 | __end_tp_report 18:29:29 INFO - PROCESS | 1652 | __start_cc_report 18:29:29 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1787 18:29:29 INFO - PROCESS | 1652 | __end_cc_report 18:29:29 INFO - PROCESS | 1652 | __startTimestamp1482200969429__endTimestamp 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | ------- Summary: start ------- 18:29:29 INFO - PROCESS | 1652 | Number of tests: 6 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5674.52 Median:5840.94 stddev:673.22 (11.5%) stddev-sans-first:633.41 18:29:29 INFO - PROCESS | 1652 | Values: 2694.9 3354.4 3355.8 3369.6 3372.6 5593.8 5600.6 5643.4 5687.8 5714.6 5654.4 5676.9 5699.7 5706.6 5708.8 4298.7 5133.3 5141.6 5163.5 5246.6 5170.1 5261.5 5267.4 5269.6 5280.2 5183.7 5221.0 5224.5 5236.1 5262.8 5267.1 5269.6 5280.4 5286.7 5295.2 5072.2 5086.1 5146.9 5188.2 5200.2 5581.9 5643.6 5644.5 5665.0 5699.7 6215.2 6228.7 6248.3 6253.7 6254.4 6121.5 6159.6 6215.8 6270.4 6289.1 5732.2 5760.4 5771.2 5771.6 5824.2 6266.8 6300.9 6313.2 6319.4 6330.1 5985.7 6069.7 6079.3 6093.1 6100.9 5441.9 5806.5 6183.7 6192.0 6250.7 6212.5 6224.3 6228.4 6241.5 6247.9 6236.4 6237.4 6244.5 6257.2 6259.8 4852.0 4883.0 4888.9 4905.8 4920.8 4365.0 4392.8 4406.0 4425.8 4467.6 5733.5 5742.4 5746.9 5753.0 5756.9 6232.3 6247.3 6253.5 6256.4 6273.6 4601.2 5542.9 5644.5 5647.1 5714.3 5256.6 5273.1 5285.9 5310.0 5316.4 6294.4 6297.2 6297.3 6305.9 6315.2 6083.4 6089.5 6133.4 6141.2 6143.2 5270.9 6271.8 6274.3 6317.2 6354.8 6192.5 6200.3 6202.1 6217.4 6226.3 6124.5 6212.3 6266.2 6275.6 6279.5 5942.9 6016.2 6017.4 6021.1 6105.4 6088.0 6090.8 6090.8 6091.8 6099.3 4878.1 5089.0 5866.6 5867.4 5902.8 5840.9 5951.9 6044.1 6054.5 6102.1 4873.8 4878.5 5902.8 5915.6 5921.0 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:68147.15 Median:33517.66 stddev:153629.10 (458.4%) stddev-sans-first:153975.95 18:29:29 INFO - PROCESS | 1652 | Values: 432.4 440.1 482.9 489.8 495.9 29967.0 38150.2 39750.6 39775.8 40079.4 41682.6 41964.0 42075.9 42156.8 42218.0 9297.3 9500.7 9511.2 9519.5 9532.2 8484.5 8683.7 11191.3 11420.8 11448.8 11321.4 11371.4 11373.6 11376.4 11381.2 11332.4 11380.3 11403.8 11405.0 11451.7 7551.2 8396.4 8614.4 8677.6 11166.6 31430.5 38404.0 39138.4 39186.2 40857.0 2797.2 3427.0 3504.9 3512.8 3746.4 27481.9 27910.9 28094.9 28502.6 28838.6 3142.5 3151.6 3166.2 3268.2 3271.7 458108.0 460509.7 461600.0 462014.0 464185.0 53295.5 53570.0 53598.2 53641.1 53721.7 55321.3 55525.0 55619.7 55709.2 55746.0 14577.4 15006.6 15012.6 15017.6 15036.6 11529.8 11641.8 11659.0 11680.9 11691.4 14434.6 14953.8 14960.2 16288.3 16700.5 6093.5 7218.4 7330.5 7359.0 7365.0 837.2 906.7 1010.4 1022.0 1026.0 29065.6 29298.6 29377.7 30179.8 30249.4 1067.8 1085.7 1109.6 1117.3 1161.2 11959.8 14894.4 15269.9 15349.5 15749.7 648815.0 652546.0 653878.0 655835.0 826650.0 47807.0 56366.2 57932.7 58352.4 60715.7 1304.5 1331.7 1343.0 1350.2 1350.2 25567.4 29404.6 30401.8 31024.9 31144.1 48547.3 49007.0 49026.5 49125.0 49134.8 540594.0 541497.0 542939.0 544397.0 544899.0 24632.4 25288.2 25693.0 25863.5 25882.0 39174.0 39576.8 39923.8 40136.4 40639.0 33312.0 33580.1 33638.7 33681.7 34438.5 28594.0 32987.0 33498.0 34053.0 34196.7 32594.9 33290.2 33537.3 33576.5 33579.5 27779.7 30201.0 30276.5 30291.1 30304.8 21009.7 21406.4 22366.8 22806.9 23141.5 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:32699.10 Median:393.44 stddev:89957.10 (22864.1%) stddev-sans-first:90176.67 18:29:29 INFO - PROCESS | 1652 | Values: 357.3 374.6 375.2 385.4 401.5 14504.6 14898.2 16195.9 19432.0 20397.9 17418.9 19340.4 19760.3 20343.4 20389.6 5702.7 5966.5 5973.0 5977.3 5989.9 5078.6 6394.5 6467.0 6504.3 6514.7 6227.3 6432.4 6454.8 6462.9 6468.4 6422.3 6452.6 6459.6 6468.2 6480.4 5164.7 5173.5 5489.6 5490.5 5631.3 12894.2 13042.0 13076.7 21987.6 23092.9 2104.9 2177.6 2190.9 2247.8 2279.4 9704.3 9749.6 9752.5 10181.5 10346.6 1803.7 1834.2 1848.5 1901.2 1902.2 114902.3 114969.4 115014.0 115049.0 129284.4 10914.9 11109.1 11234.9 11552.0 11751.6 14147.6 14591.4 14656.0 14698.2 14700.6 8219.3 8341.7 8360.6 8393.1 8456.2 8097.4 8132.0 8134.2 8315.6 8354.9 4461.2 4504.3 4542.3 4581.0 4611.0 1781.2 1883.2 1928.9 1929.4 1934.8 709.5 767.7 778.5 794.7 899.1 18709.1 19630.5 20289.1 20395.9 21188.0 829.9 847.5 886.9 895.7 900.5 8293.0 10452.9 10503.7 11206.7 11358.7 501927.0 518744.0 538193.0 554928.0 556036.0 121066.0 130800.0 131902.3 133665.3 136401.3 934.3 934.7 955.4 956.6 979.7 13800.8 17500.8 18905.7 19550.7 19689.2 44312.0 50176.0 51809.7 52773.7 56775.0 60227.4 73907.5 75288.0 80905.8 81658.0 7283.8 7565.9 8014.2 8287.4 8291.3 9296.9 10804.0 12314.9 13127.3 13290.9 6649.0 10794.5 11182.7 11213.9 11405.0 11064.3 11113.8 11287.0 11328.9 11546.7 11021.9 11425.8 11679.2 11723.4 11749.1 7852.6 7937.9 8022.2 8159.8 8489.8 8243.6 9996.2 10823.6 11306.5 11424.2 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5290.65 Median:5179.64 stddev:2884.96 (55.7%) stddev-sans-first:2878.88 18:29:29 INFO - PROCESS | 1652 | Values: 1485.5 1514.3 1665.3 1701.9 1806.1 7913.7 8313.1 8323.9 8323.9 8331.4 7421.6 7650.8 7667.9 7800.7 8095.2 2253.4 2328.2 2330.7 2331.8 2337.8 2316.1 2332.2 2341.1 2355.3 2355.9 2053.1 2225.1 2286.2 2289.1 2292.8 2280.6 2307.2 2307.5 2308.0 2308.7 1943.6 2314.3 2344.8 2345.0 2350.5 8130.6 8175.6 8247.3 8254.3 8258.3 5033.0 5199.4 5200.6 5200.8 5211.7 3082.8 3247.7 3508.4 3508.5 3511.3 905.0 1016.0 1048.2 1053.6 1062.3 10450.5 10693.0 10695.8 10705.0 10707.6 4487.8 4678.3 4727.5 4751.3 4755.8 8362.6 8581.7 8638.0 8657.7 8680.5 5084.6 5094.6 5096.7 5101.0 5114.7 4592.0 4717.5 4777.9 4791.1 4806.4 3491.5 3570.1 3599.4 3618.9 3637.9 1111.6 1130.6 1130.9 1139.4 1147.9 864.8 867.7 879.0 906.7 925.0 5159.9 5210.7 5573.1 5589.0 5721.7 404.9 425.6 427.9 439.4 447.3 3492.6 3682.1 3707.2 3836.6 3838.9 9377.6 9827.8 9831.8 9844.1 9858.2 9762.7 9767.4 9772.4 9775.0 9806.3 7434.3 7651.6 7659.7 7756.0 7758.4 5387.7 5397.4 5653.7 5654.1 5690.0 8763.9 9011.7 9152.1 9191.8 9252.8 7085.7 7690.4 9190.7 9286.4 9321.2 6999.9 7191.6 7192.5 7197.4 7201.6 7497.2 7694.0 7779.8 7784.2 7798.6 5580.9 6937.5 6991.8 7063.3 7132.1 6926.9 6931.3 6987.1 7047.6 7066.7 5572.6 6480.8 6530.8 6577.3 6585.0 4745.0 4768.7 4784.3 4790.8 4942.6 3983.5 4664.7 4764.4 4811.3 4863.6 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4223.51 Median:4657.21 stddev:1236.89 (26.6%) stddev-sans-first:1205.66 18:29:29 INFO - PROCESS | 1652 | Values: 347.5 352.9 357.8 366.8 369.7 4352.5 4398.3 5205.0 5216.9 5235.5 3757.8 4818.6 4827.3 5009.4 5124.6 3534.3 3808.3 3877.9 3905.8 3912.0 3620.9 4017.3 4058.7 4091.6 4110.4 3100.1 3375.5 3465.8 3512.4 4031.0 3250.5 3540.3 4044.0 4058.4 4097.0 2888.9 3135.7 3607.4 3613.9 3630.9 4079.6 4597.7 4898.3 4963.8 4979.8 4372.3 4627.5 4658.9 4683.4 4702.4 4614.5 5015.9 5391.0 5420.7 5450.8 3980.0 3988.2 3992.0 3992.3 4014.1 5367.0 5653.2 5672.2 5703.3 5780.3 4046.1 4061.9 4077.6 4083.2 4109.3 3520.9 4069.9 4103.4 4126.7 4157.8 4296.5 4385.8 4722.4 4722.7 4796.3 4821.4 4854.3 4975.7 5180.4 5213.8 1198.7 1332.7 1337.9 1339.6 1349.3 799.4 831.9 889.9 927.6 945.9 4216.6 4283.8 4632.2 4736.5 4784.6 4424.8 4744.7 4801.5 5275.2 5277.3 3905.6 4451.5 4608.5 4723.4 4838.1 2435.4 2695.8 2709.6 2747.5 2765.8 5073.8 5371.3 5393.8 5406.2 5412.9 5003.3 5087.0 5288.7 5312.0 5436.9 4791.7 5097.5 5254.8 5385.5 5393.4 4396.5 4460.6 4970.8 4995.5 5167.3 4514.1 4911.7 5118.0 5177.3 5188.4 4267.6 4520.9 4929.9 5373.4 5456.6 3227.7 3316.4 3581.9 3728.7 3781.4 4408.4 4732.1 4838.2 4931.8 5424.3 4480.8 4655.6 4745.5 4994.1 5194.5 4117.9 4272.2 4327.7 5040.1 5107.6 3651.2 4147.4 4674.8 4779.8 4832.9 4235.5 4997.8 5254.8 5388.5 5389.5 5335.9 5368.2 5372.2 5383.4 5390.6 18:29:29 INFO - PROCESS | 1652 | 18:29:29 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:20254.09 Median:28605.01 stddev:29737.16 (104.0%) stddev-sans-first:29784.39 18:29:29 INFO - PROCESS | 1652 | Values: 716.3 723.5 735.8 746.9 748.3 15175.8 15362.3 15712.2 15726.7 15763.7 14009.3 14053.9 14307.4 14507.3 14539.6 689.1 715.5 721.0 853.7 878.4 709.8 712.5 714.3 843.4 874.0 928.4 935.9 938.2 940.3 940.9 933.8 934.7 935.0 935.7 939.0 696.9 697.7 697.8 698.0 698.9 11814.3 12305.3 14603.4 15078.5 15166.8 14100.8 14309.6 14406.2 14415.3 14425.5 11599.7 11866.4 12063.9 12073.6 12225.6 3560.2 3772.6 3777.3 3813.1 3820.6 98200.0 104045.5 106444.5 106542.0 106867.0 8989.0 10156.8 10672.7 11174.6 11284.4 22644.5 22923.9 22968.0 22976.8 23187.9 7414.6 7469.9 7540.1 7578.0 7659.3 4176.7 4314.7 4370.6 4460.9 4503.4 3087.2 3440.4 3469.8 3539.2 3562.7 563.7 570.9 571.9 574.3 580.5 590.2 623.9 639.3 669.5 700.4 7058.9 7784.4 9119.4 9235.6 9551.1 564.2 629.6 634.7 649.3 683.5 4332.8 4461.4 4505.3 4530.2 4533.5 83873.0 101122.0 108926.0 109998.5 111954.0 72094.6 76556.0 84373.0 91278.0 94668.0 79944.6 80425.0 80826.8 82291.0 83310.6 8527.7 8589.9 8749.7 8761.8 8839.5 36490.8 52676.5 53608.7 53907.7 54636.7 71530.6 74690.0 75501.0 76561.0 77020.6 11799.9 11897.2 11910.4 11919.9 12330.2 12737.8 12951.7 12970.7 13175.3 13511.6 11792.4 11959.9 12053.5 12407.7 12545.7 11663.7 12000.7 12043.4 12168.1 12171.2 11845.3 11920.2 11972.8 12009.9 12356.4 8079.8 8776.6 9468.7 9825.3 10283.4 8698.9 9562.3 9858.4 10357.8 10361.3 18:29:29 INFO - PROCESS | 1652 | -------- Summary: end -------- 18:29:29 INFO - PROCESS | 1652 | 18:29:30 INFO - TEST-INFO | 1652: exit 0 18:29:30 INFO - TEST-OK | dromaeo_css | took 1119218ms 18:29:30 INFO - TEST-START | kraken 18:29:30 INFO - operating with platform_type : mac_ 18:29:30 INFO - Initialising browser for kraken test... 18:29:30 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmplRaA3j/profile http://localhost:49241/getInfo.html) 18:29:32 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 18:29:32 INFO - PROCESS | 1657 | colorDepth:24 18:29:32 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 18:29:32 INFO - PROCESS | 1657 | __metrics 18:29:32 INFO - PROCESS | 1657 | 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" 18:29:32 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:29:33 INFO - TEST-INFO | 1657: exit 0 18:29:33 INFO - Browser initialized. 18:29:33 INFO - Running cycle 1/1 for kraken test... 18:29:33 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmplRaA3j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:45 INFO - PROCESS | 1658 | RSS: Main: 237174784 18:29:45 INFO - PROCESS | 1658 | 18:29:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:49 INFO - PROCESS | 1658 | RSS: Main: 289443840 18:29:49 INFO - PROCESS | 1658 | 18:29:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 18:29:52 INFO - PROCESS | 1658 | RSS: Main: 290668544 18:29:52 INFO - PROCESS | 1658 | 18:29:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 18:29:56 INFO - PROCESS | 1658 | RSS: Main: 381034496 18:29:56 INFO - PROCESS | 1658 | 18:29:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 18:29:58 INFO - PROCESS | 1658 | RSS: Main: 285028352 18:29:58 INFO - PROCESS | 1658 | 18:30:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:01 INFO - PROCESS | 1658 | RSS: Main: 289730560 18:30:01 INFO - PROCESS | 1658 | 18:30:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:05 INFO - PROCESS | 1658 | RSS: Main: 333078528 18:30:05 INFO - PROCESS | 1658 | 18:30:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:08 INFO - PROCESS | 1658 | RSS: Main: 332156928 18:30:08 INFO - PROCESS | 1658 | 18:30:11 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 18:30:11 INFO - PROCESS | 1658 | RSS: Main: 330113024 18:30:11 INFO - PROCESS | 1658 | 18:30:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:14 INFO - PROCESS | 1658 | RSS: Main: 305999872 18:30:14 INFO - PROCESS | 1658 | 18:30:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:16 INFO - PROCESS | 1658 | RSS: Main: 310059008 18:30:16 INFO - PROCESS | 1658 | 18:30:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:19 INFO - PROCESS | 1658 | RSS: Main: 313159680 18:30:19 INFO - PROCESS | 1658 | 18:30:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:23 INFO - PROCESS | 1658 | RSS: Main: 328380416 18:30:23 INFO - PROCESS | 1658 | 18:30:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:26 INFO - PROCESS | 1658 | RSS: Main: 322801664 18:30:26 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 18:30:28 INFO - PROCESS | 1658 | RSS: Main: 366444544 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | __start_tp_report 18:30:28 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 18:30:28 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 18:30:28 INFO - PROCESS | 1658 | |i|pagename|runs| 18:30:28 INFO - PROCESS | 1658 | |0;ai-astar;111;113;113;113;111;114;113;113;113;112 18:30:28 INFO - PROCESS | 1658 | |1;audio-beat-detection;140;111;109;146;109;111;117;133;148;109 18:30:28 INFO - PROCESS | 1658 | |2;audio-dft;182;182;182;185;183;182;179;180;183;182 18:30:28 INFO - PROCESS | 1658 | |3;audio-fft;80;59;58;87;60;59;59;58;74;59 18:30:28 INFO - PROCESS | 1658 | |4;audio-oscillator;89;69;85;68;66;67;83;68;68;83 18:30:28 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;109;110;109;111;108;117;109;111;109;110 18:30:28 INFO - PROCESS | 1658 | |6;imaging-darkroom;94;94;94;95;94;94;94;95;94;94 18:30:28 INFO - PROCESS | 1658 | |7;imaging-desaturate;88;84;88;85;85;81;91;84;85;85 18:30:28 INFO - PROCESS | 1658 | |8;json-parse-financial;56;57;58;55;56;56;57;55;55;55 18:30:28 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;67;72;75;71;73;70;69;71;69;70 18:30:28 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;88;90;87;85;87;87;87;88;86;85 18:30:28 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;139;141;139;140;143;137;140;137;184;149 18:30:28 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;163;179;172;171;174;173;173;173;172;173 18:30:28 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;68;66;68;67;67;67;67;66;67 18:30:28 INFO - PROCESS | 1658 | __end_tp_report 18:30:28 INFO - PROCESS | 1658 | __start_cc_report 18:30:28 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2005 18:30:28 INFO - PROCESS | 1658 | __end_cc_report 18:30:28 INFO - PROCESS | 1658 | __startTimestamp1482201028564__endTimestamp 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | ------- Summary: start ------- 18:30:28 INFO - PROCESS | 1658 | Number of tests: 14 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:0.83 18:30:28 INFO - PROCESS | 1658 | Values: 111.0 113.0 113.0 113.0 111.0 114.0 113.0 113.0 113.0 112.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:125.00 stddev:16.51 (13.2%) stddev-sans-first:16.37 18:30:28 INFO - PROCESS | 1658 | Values: 140.0 111.0 109.0 146.0 109.0 111.0 117.0 133.0 148.0 109.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:182.00 Median:182.00 stddev:1.63 (0.9%) stddev-sans-first:1.73 18:30:28 INFO - PROCESS | 1658 | Values: 182.0 182.0 182.0 185.0 183.0 182.0 179.0 180.0 183.0 182.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:65.30 Median:59.50 stddev:10.83 (18.2%) stddev-sans-first:10.10 18:30:28 INFO - PROCESS | 1658 | Values: 80.0 59.0 58.0 87.0 60.0 59.0 59.0 58.0 74.0 59.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:76.00 stddev:9.13 (12.0%) stddev-sans-first:8.06 18:30:28 INFO - PROCESS | 1658 | Values: 89.0 69.0 85.0 68.0 66.0 67.0 83.0 68.0 68.0 83.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:2.54 (2.3%) stddev-sans-first:2.65 18:30:28 INFO - PROCESS | 1658 | Values: 109.0 110.0 109.0 111.0 108.0 117.0 109.0 111.0 109.0 110.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:30:28 INFO - PROCESS | 1658 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.00 stddev:2.76 (3.2%) stddev-sans-first:2.78 18:30:28 INFO - PROCESS | 1658 | Values: 88.0 84.0 88.0 85.0 85.0 81.0 91.0 84.0 85.0 85.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:1.12 18:30:28 INFO - PROCESS | 1658 | Values: 56.0 57.0 58.0 55.0 56.0 56.0 57.0 55.0 55.0 55.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:2.26 (3.2%) stddev-sans-first:1.96 18:30:28 INFO - PROCESS | 1658 | Values: 67.0 72.0 75.0 71.0 73.0 70.0 69.0 71.0 69.0 70.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:1.49 (1.7%) stddev-sans-first:1.54 18:30:28 INFO - PROCESS | 1658 | Values: 88.0 90.0 87.0 85.0 87.0 87.0 87.0 88.0 86.0 85.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:140.50 stddev:14.17 (10.1%) stddev-sans-first:14.87 18:30:28 INFO - PROCESS | 1658 | Values: 139.0 141.0 139.0 140.0 143.0 137.0 140.0 137.0 184.0 149.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:3.92 (2.3%) stddev-sans-first:2.29 18:30:28 INFO - PROCESS | 1658 | Values: 163.0 179.0 172.0 171.0 174.0 173.0 173.0 173.0 172.0 173.0 18:30:28 INFO - PROCESS | 1658 | 18:30:28 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 18:30:28 INFO - PROCESS | 1658 | Values: 67.0 68.0 66.0 68.0 67.0 67.0 67.0 67.0 66.0 67.0 18:30:28 INFO - PROCESS | 1658 | -------- Summary: end -------- 18:30:28 INFO - PROCESS | 1658 | 18:30:29 INFO - TEST-INFO | 1658: exit 0 18:30:29 INFO - TEST-OK | kraken | took 59405ms 18:30:29 INFO - SUITE-END | took 1178s 18:30:29 INFO - Completed test suite (00:19:38) 18:30:29 INFO - javascript benchmark 18:30:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2694.8517831519266, 3354.3962086824363, 3355.8154301513423, 3369.612494563126, 3372.6458721834206, 5593.776248950047, 5600.607957442976, 5643.379228284885, 5687.772489100436, 5714.628549144302, 5654.37801841797, 5676.943230567693, 5699.74351154198, 5706.600537962344, 5708.800191993281, 4298.731874097149, 5133.3326667533265, 5141.588672906178, 5163.509466600667, 5246.606504512158, 5170.09523333417, 5261.526462618363, 5267.367915850104, 5269.578433725293, 5280.1815718563685, 5183.714895680736, 5220.973895130538, 5224.45143259958, 5236.136037553799, 5262.789488420459, 5267.078261304257, 5269.604779641523, 5280.3663560373, 5286.682799032032, 5295.152775555893, 5072.213806859906, 5086.109930762102, 5146.897062058738, 5188.169892817131, 5200.193969934666, 5581.888362232773, 5643.5767317451355, 5644.520215781622, 5665.036943719537, 5699.715014249271, 6215.192025036717, 6228.657423841687, 6248.281447633535, 6253.749850005995, 6254.405831446051, 6121.493465094016, 6159.568830181889, 6215.782447614357, 6270.435660790551, 6289.119523266746, 5732.22614946981, 5760.423957604248, 5771.163181338767, 5771.567132465082, 5824.213731146241, 6266.843328916813, 6300.905486417708, 6313.242410910629, 6319.368063193644, 6330.145430366933, 5985.700714964234, 6069.696515174223, 6079.331273559993, 6093.086037094471, 6100.9057437040565, 5441.891162176735, 5806.490312518691, 6183.659898705614, 6192.040233763774, 6250.656213908188, 6212.502999760009, 6224.346443623445, 6228.377162283826, 6241.469475094577, 6247.875042499216, 6236.438720515084, 6237.376262373817, 6244.500439964792, 6257.217847769029, 6259.812205633838, 4851.975740121347, 4883.0, 4888.926666100011, 4905.828296009622, 4920.75396230187, 4365.039691267916, 4392.758398288125, 4405.977970110193, 4425.822967081281, 4467.5755803198645, 5733.455321744427, 5742.397048309867, 5746.885062298814, 5753.0, 5756.913646295309, 6232.283287422005, 6247.250329960434, 6253.468455181361, 6256.405641464054, 6273.592216505913, 4601.217792975135, 5542.86142846424, 5644.548436125182, 5647.124695672177, 5714.314282286069, 5256.579473642099, 5273.050850846885, 5285.867853303698, 5310.0, 5316.388615309212, 6294.370562943761, 6297.2128483939505, 6297.275813281532, 6305.873882522415, 6315.179026726588, 6083.391660833881, 6089.512838972783, 6133.417325354084, 6141.240538582456, 6143.201383820075, 5270.920936185884, 6271.780487683091, 6274.309825919054, 6317.210348706411, 6354.777582784581, 6192.473639740672, 6200.255969283535, 6202.131701561695, 6217.378262173746, 6226.3151053385, 6124.510039196764, 6212.254529456494, 6266.2480502338185, 6275.592086514362, 6279.497640188865, 5942.940570594239, 6016.157737916783, 6017.3681763414215, 6021.066734656135, 6105.358937311518, 6087.969560152171, 6090.817275481742, 6090.817275481742, 6091.7563297467605, 6099.268087829489, 4878.146324393146, 5088.974555127201, 5866.560007999332, 5867.442592953663, 5902.822915312548, 5840.94159058404, 5951.940480595139, 6044.0933859919605, 6054.485368743706, 6102.0541816018585, 4873.756312184448, 4878.487758785418, 5902.793402230901, 5915.58590898633, 5920.970395147997], "value": 5630.575204967106, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.44646852029405, 440.0868198488138, 482.94446138694036, 489.8317512732135, 495.8958618690075, 29967.0, 38150.236995260115, 39750.60249397505, 39775.80112099436, 40079.39880901789, 41682.58317416825, 41964.0, 42075.94810129748, 42156.789216053876, 42218.0, 9297.349185556997, 9500.714978550655, 9511.239100871948, 9519.524023798816, 9532.18976387008, 8484.490930544187, 8683.696070637528, 11191.328520288767, 11420.771584568303, 11448.771024579504, 11321.377324247203, 11371.374574398405, 11373.601923932663, 11376.374299413528, 11381.2033157679, 11332.376719280437, 11380.317180969168, 11403.828942565786, 11405.030572401356, 11451.656450306504, 7551.24487551246, 8396.370272229608, 8614.353923455767, 8677.566121693953, 11166.609168679057, 31430.528542071886, 38404.0, 39138.412923806165, 39186.21627567461, 40856.978575535555, 2797.244743919151, 3426.9828650856834, 3504.877329293488, 3512.7541072124964, 3746.400575907842, 27481.86259068692, 27910.860445697843, 28094.859525702446, 28502.572461413096, 28838.567421488693, 3142.5286207068893, 3151.6060492438446, 3166.208447888028, 3268.1502809269523, 3271.689189526991, 458108.0, 460509.6974515106, 461600.0, 462014.0, 464185.0, 53295.467045329824, 53570.0, 53598.176164145414, 53641.09947905727, 53721.73139134357, 55321.34035978927, 55525.0, 55619.72190139104, 55709.1643625346, 55746.0, 14577.416903323749, 15006.624834379229, 15012.624684382978, 15017.624559386102, 15036.62408439776, 11529.827052594217, 11641.825372619418, 11658.950694437372, 11680.883191167979, 11691.356975366436, 14434.639134021734, 14953.775693364609, 14960.177190254422, 16288.348466061461, 16700.49898503047, 6093.542984276197, 7218.448033672786, 7330.450216233804, 7358.96320518394, 7364.963175184197, 837.2339309531832, 906.7007887397143, 1010.368519675203, 1021.9897801022043, 1025.9689012542347, 29065.564016539767, 29298.560521591768, 29377.706222937497, 30179.849100754356, 30249.395012099634, 1067.8451624514403, 1085.7122862441458, 1109.606089838112, 1117.3240189685287, 1161.1523587780966, 11959.820602690967, 14894.404223831141, 15269.869676716247, 15349.539513814603, 15749.685006300038, 648815.0, 652546.0, 653878.0, 655835.0, 826650.0, 47807.04385912332, 56366.15450768242, 57932.71033644805, 58352.416475834696, 60715.69642151849, 1304.478208716521, 1331.6803967048033, 1342.9597112086653, 1350.1696456678876, 1350.230368689857, 25567.360815979748, 29404.55893161647, 30401.847990759903, 31024.91412800541, 31144.065678029696, 48547.27179092387, 49007.0, 49026.509734902196, 49125.0, 49134.75432622814, 540594.0, 541497.0, 542939.0, 544397.0, 544899.0, 24632.384190395383, 25288.218295987794, 25693.0, 25863.482730345662, 25882.0, 39174.02064948285, 39576.80211598924, 39923.80038099791, 40136.39795403013, 40638.9840253996, 33312.0, 33580.14568761682, 33638.663613363555, 33681.663183367855, 34438.48342274918, 28594.0, 32987.010389688345, 33498.0, 34053.0, 34196.65803341935, 32594.85917992859, 33290.167745806546, 33537.329253415286, 33576.489057992934, 33579.49630755589, 27779.722202777713, 30201.0, 30276.5458518118, 30291.091267262018, 30304.84847575748, 21009.73941563511, 21406.357809265748, 22366.77633223712, 22806.885965570065, 23141.53716925686], "value": 19032.48855450673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3317895535349, 374.60104988187595, 375.183974854691, 385.36030189884787, 401.5241938303111, 14504.564863054113, 14898.180600066991, 16195.919020404881, 19432.02839858005, 20397.898010509925, 17418.912905435485, 19340.4197874064, 19760.30838920638, 20343.389698309038, 20389.592208155864, 5702.714864256781, 5966.46301832835, 5972.970135149319, 5977.252843394575, 5989.9101513477335, 5078.619103567229, 6394.520410969173, 6467.029945508164, 6504.284528701839, 6514.674266286666, 6227.346128656493, 6432.42108210261, 6454.806355809334, 6462.870742585145, 6468.3855033771715, 6422.2614399343975, 6452.580582262138, 6459.612423254573, 6468.191476065492, 6480.384363485461, 5164.741762911877, 5173.482651734834, 5489.64317319373, 5490.478404551601, 5631.267935168402, 12894.161879477897, 13042.021848361412, 13076.673083172902, 21987.570807897435, 23092.88453557738, 2104.9052792624216, 2177.6080305544997, 2190.9014094365634, 2247.8426510144295, 2279.3959600705825, 9704.272179586489, 9749.610015599368, 9752.4636145012, 10181.490925453698, 10346.586136554528, 1803.6573051120376, 1834.238790901774, 1848.4639454558162, 1901.1634880652468, 1902.1630482587755, 114902.27646585308, 114969.4251528737, 115014.0, 115049.0, 129284.35357823245, 10914.890851091388, 11109.111271098292, 11234.943825280821, 11552.018078463425, 11751.588694395656, 14147.646308842155, 14591.416343346147, 14656.0, 14698.191599461918, 14700.55898323052, 8219.301359384399, 8341.708040218564, 8360.581970901552, 8393.118722534045, 8456.196661317288, 8097.433179677366, 8132.0, 8134.227248411392, 8315.625796839156, 8354.874676879852, 4461.219286624828, 4504.324351347259, 4542.318652202196, 4581.015081757439, 4610.976945115253, 1781.189558750791, 1883.1808163448943, 1928.8939108349175, 1929.411529483521, 1934.796846331115, 709.5317090720204, 767.7005967672612, 778.5445514374042, 794.6503538443067, 899.0739538275456, 18709.064546772606, 19630.509237268896, 20289.086991085438, 20395.8980205101, 21188.04653790583, 829.8921140251729, 847.5296210603175, 886.9423487473423, 895.6596493332491, 900.4732231644431, 8293.004839419187, 10452.947735261276, 10503.684889453329, 11206.719832004102, 11358.716032099264, 501927.0, 518744.0, 538193.0, 554928.0, 556036.0, 121066.0, 130799.9999999981, 131902.34048829693, 133665.33167334102, 136401.3179934094, 934.3412893909777, 934.7008957133788, 955.3742298794301, 956.5982287439292, 979.7452662307851, 13800.792988105388, 17500.82499174992, 18905.71641425407, 19550.65392152951, 19689.21243150258, 44312.0, 50176.0, 51809.740951295, 52773.7361313191, 56775.0, 60227.39772602218, 73907.54433062884, 75288.0, 80905.78641320503, 81658.0, 7283.817904552428, 7565.924340756522, 8014.156743949041, 8287.378446616407, 8291.295239904675, 9296.907030929604, 10804.0, 12314.938425308175, 13127.277999710108, 13290.86709132935, 6649.0, 10794.460276985963, 11182.720431989266, 11213.87861213872, 11405.0, 11064.28082174656, 11113.833292500458, 11287.0, 11328.886711132784, 11546.653600392001, 11021.944890275498, 11425.828612570653, 11679.182457228253, 11723.41382930867, 11749.118816088656, 7852.568108754073, 7937.877480586584, 8022.197780221931, 8159.83680326402, 8489.811426400433, 8243.587820609066, 9996.150327221976, 10823.621173258898, 11306.4912078955, 11424.200305978502], "value": 9222.637597632247, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.5246321177224, 1514.2958524286207, 1665.3005737590217, 1701.9404320848773, 1806.0608483588542, 7913.683452661894, 8313.127121652231, 8323.875141872877, 8323.876276702644, 8331.375146863988, 7421.554706717588, 7650.770476885702, 7667.8849817252785, 7800.7269745558915, 8095.190480951902, 2253.3803204118917, 2328.2200462844967, 2330.685357476736, 2331.813454923602, 2337.777911098443, 2316.1198744477074, 2332.183735692511, 2341.075275266269, 2355.3051849704293, 2355.882205889707, 2053.0863765624304, 2225.121077174515, 2286.2455389721354, 2289.061484791236, 2292.8165746740306, 2280.600894843396, 2307.157887371114, 2307.457747429361, 2307.988460057689, 2308.734495533002, 1943.620993906189, 2314.2825724025606, 2344.847584906993, 2345.026813872241, 2350.4828937633692, 8130.634121464489, 8175.591220438954, 8247.298979586682, 8254.298384637314, 8258.298044666211, 5033.0, 5199.350081239845, 5200.583953283728, 5200.843974680765, 5211.7133557654315, 3082.7842051056437, 3247.707706306444, 3508.438649816017, 3508.456189290664, 3511.3328467591077, 904.9819003619957, 1015.9644412445602, 1048.224314007629, 1053.578568572577, 1062.2511129653576, 10450.47747612624, 10693.0, 10695.83956240657, 10705.0, 10707.625233116803, 4487.753173575485, 4678.345031695498, 4727.479977202505, 4751.263554149113, 4755.762211889391, 8362.58187090643, 8581.742547723577, 8638.0, 8657.653693852302, 8680.522571258514, 5084.618653600995, 5094.643374963791, 5096.668716533413, 5100.974495127501, 5114.693118412907, 4591.95408045922, 4717.481077081518, 4777.928331075037, 4791.137595232822, 4806.375171227718, 3491.528643633077, 3570.107473131717, 3599.4240921452965, 3618.87333943316, 3637.944561322844, 1111.6442738323658, 1130.5647325779635, 1130.909527237819, 1139.3733446604335, 1147.8737338892715, 864.7578677970179, 867.7483529776295, 878.9912100879037, 906.7143849687327, 924.9953750231206, 5159.922601160985, 5210.711128204875, 5573.080441727151, 5588.9720551397795, 5721.685307308055, 404.88056023473143, 425.6339547988727, 427.8930267433142, 439.35634295756233, 447.29997553828804, 3492.5808902931813, 3682.0794801299676, 3707.2029513654693, 3836.616338366141, 3838.9424158637644, 9377.578008989612, 9827.754306142404, 9831.75420614476, 9844.114029737359, 9858.162056225157, 9762.707118786306, 9767.365121267096, 9772.413655180711, 9775.022497750168, 9806.264530160266, 7434.3309102181065, 7651.579163146081, 7659.693612255447, 7756.0, 7758.4181186410115, 5387.676739395492, 5397.3523177218985, 5653.717314134195, 5654.123610840326, 5690.032694442038, 8763.868541971748, 9011.684591039282, 9152.130547597968, 9191.770205744642, 9252.768680783034, 7085.6811443486195, 7690.423218258541, 9190.724278271662, 9286.442813431217, 9321.207697345802, 6999.930000700131, 7191.568505889454, 7192.460565457716, 7197.424206063607, 7201.639918003974, 7497.175310715707, 7693.961530192313, 7779.805504862424, 7784.2215778421705, 7798.649060792164, 5580.944190558205, 6937.479689023445, 6991.755288565079, 7063.258357872555, 7132.072830531998, 6926.896096558455, 6931.341522555349, 6987.091678081817, 7047.577145371294, 7066.717331306896, 5572.60991730575, 6480.805575832733, 6530.771423000172, 6577.3422657733845, 6584.979328204136, 4745.0, 4768.66619336657, 4784.330193772944, 4790.8323208687525, 4942.6293028023765, 3983.462232598562, 4664.6501512387385, 4764.356811830358, 4811.254255590389, 4863.610911127172], "value": 4230.491606538808, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.5308333749439, 352.8817846021583, 357.7799653213274, 366.8495916674164, 369.66175949006674, 4352.4994625618065, 4398.318260669594, 5205.0, 5216.869878073154, 5235.450277720832, 3757.849686012556, 4818.614510839133, 4827.30004149399, 5009.445182956691, 5124.564412024983, 3534.2754735279204, 3808.276427478777, 3877.856032470428, 3905.8047097645144, 3912.041549820298, 3620.8732694355704, 4017.292650623488, 4058.715889887694, 4091.6112969267874, 4110.424540564323, 3100.1474594486585, 3375.5274261603395, 3465.792052476847, 3512.350215210194, 4031.044943202559, 3250.463673493871, 3540.327337805809, 4043.9595604044025, 4058.370952502367, 4096.97951510242, 2888.9310954946595, 3135.6550779414247, 3607.3687104756823, 3613.927721445583, 3630.8547658093644, 4079.5920407959266, 4597.678172522888, 4898.265260210961, 4963.8086859153545, 4979.759108401234, 4372.256716358195, 4627.537246275379, 4658.860234192945, 4683.3842324398365, 4702.365180700596, 4614.469336026366, 5015.899682006376, 5390.973045134789, 5420.674759514442, 5450.781968721247, 3979.98010009951, 3988.1824226033596, 3992.0, 3992.321305378093, 4014.116894283253, 5367.0339338918975, 5653.247493277097, 5672.234248376458, 5703.344115426696, 5780.277465316835, 4046.069404037088, 4061.878143655636, 4077.6126268005087, 4083.244599749056, 4109.260333140004, 3520.8591656333974, 4069.89825254371, 4103.4460347853255, 4126.731762435432, 4157.771322577288, 4296.462942132233, 4385.780710964439, 4722.409698787652, 4722.716637001791, 4796.328514008042, 4821.397325334333, 4854.344663470457, 4975.676581022222, 5180.352455943007, 5213.843584692465, 1198.676357383519, 1332.7467781121557, 1337.8628166058772, 1339.5713371720956, 1349.3455673998103, 799.428408687791, 831.8710599857031, 889.9199072083544, 927.6150397585062, 945.9263735660076, 4216.620504154641, 4283.807228674717, 4632.2125238709505, 4736.455307639597, 4784.626838079146, 4424.778761061934, 4744.7390393528685, 4801.4958429365115, 5275.20871869215, 5277.313949186581, 3905.5508616508896, 4451.488078870972, 4608.493065762764, 4723.385959825269, 4838.080764654705, 2435.356134609132, 2695.757381835644, 2709.6206531085663, 2747.5272254970687, 2765.778737700979, 5073.771680274396, 5371.301730775052, 5393.784248630011, 5406.243125962368, 5412.864678382994, 5003.3495645565845, 5087.0, 5288.682679039193, 5311.981447050173, 5436.891262174734, 4791.736454494967, 5097.515736005073, 5254.816081437131, 5385.515303622693, 5393.379761327419, 4396.472423309224, 4460.620847228022, 4970.7879993402585, 4995.500449954975, 5167.276581278699, 4514.119746649372, 4911.656184067081, 5118.0, 5177.301064356264, 5188.351456067991, 4267.594578515036, 4520.90958180828, 4929.852104436873, 5373.408925018323, 5456.645318054472, 3227.7095061444584, 3316.369889720945, 3581.871710411212, 3728.738988270795, 3781.357169281174, 4408.404865343137, 4732.148213321635, 4838.2016967201425, 4931.753412329297, 5424.294841670558, 4480.843170489017, 4655.557722016403, 4745.549172828576, 4994.076095922266, 5194.4805519447755, 4117.876463706094, 4272.188284225987, 4327.697061205686, 5040.093927206444, 5107.624954396224, 3651.160233146338, 4147.398627198979, 4674.839392940354, 4779.761011949458, 4832.912594666172, 4235.4917409911, 4997.827682811652, 5254.842354729364, 5388.541973932103, 5389.541888939327, 5335.866603334947, 5368.2484452177505, 5372.247885295984, 5383.37030154075, 5390.568754499553], "value": 3855.6060110688077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.2872941423283, 723.5007844587232, 735.8270806360508, 746.8842329438935, 748.345197951792, 15175.848241517582, 15362.308696108674, 15712.214389280547, 15726.68546629068, 15763.68472630548, 14009.29953502326, 14053.859461405384, 14307.427702891899, 14507.274636268197, 14539.636509087279, 689.0697558296285, 715.4920006795181, 721.0, 853.71827296992, 878.3895192840978, 709.8331892005375, 712.4976891291627, 714.3463730686416, 843.3843294395095, 874.0, 928.4058202750211, 935.948522831244, 938.1556599060832, 940.3135710931025, 940.9482478463682, 933.7945651956559, 934.686879895236, 934.9762010598384, 935.7473482159813, 939.0421769794839, 696.8919817428307, 697.7034760226883, 697.7592730507967, 698.0227681246245, 698.8602279544111, 11814.291142531476, 12305.261684298881, 14603.415863365453, 15078.54764357071, 15166.772498412533, 14100.788488172686, 14309.642258943506, 14406.207658578878, 14415.279236038261, 14425.49510767118, 11599.6520104397, 11866.406679666068, 12063.93968030163, 12073.637790866289, 12225.594056683507, 3560.181158333572, 3772.5661548921953, 3777.338965680995, 3813.103920578662, 3820.5797362290127, 98200.0, 104045.47977260141, 106444.4677776614, 106542.0, 106867.0, 8989.0, 10156.796864062677, 10672.675313255673, 11174.553017879194, 11284.379359135326, 22644.547109057727, 22923.885380573323, 22968.0, 22976.770232297797, 23187.88406057959, 7414.591227666726, 7469.9253007470315, 7540.132884718218, 7577.962110189414, 7659.310662040331, 4176.665866730655, 4314.676399270067, 4370.628496577763, 4460.910781784346, 4503.414556107685, 3087.1818967973504, 3440.415129428003, 3469.8438570263893, 3539.150603855108, 3562.7327950403824, 563.7068724263443, 570.9486146246858, 571.9227904232876, 574.2592056247394, 580.494969376645, 590.2120668906971, 623.8752249550108, 639.3228134168646, 669.5012215899089, 700.4256509662029, 7058.929410705828, 7784.3772498200005, 9119.407238529475, 9235.584398702074, 9551.082203651493, 564.221374503183, 629.6064959400375, 634.6826586706646, 649.3409189672486, 683.4771399879096, 4332.783360831946, 4461.442319710036, 4505.324201369821, 4530.184566778012, 4533.54664533544, 83873.0, 101121.98878011126, 108926.0, 109998.45000775105, 111954.0, 72094.63952680203, 76556.0, 84373.0, 91278.0, 94668.0, 79944.60027699824, 80424.98937526492, 80826.78759818607, 82291.0, 83310.58344708238, 8527.720841873768, 8589.871151932852, 8749.650013999624, 8761.826819433727, 8839.46963182211, 36490.8175459121, 52676.473235267156, 53608.731956339965, 53907.73046134901, 54636.72681636566, 71530.64234678794, 74690.0, 75501.0, 76561.0, 77020.61489692515, 11799.882001180222, 11897.167198296036, 11910.422118784765, 11919.940400297943, 12330.19853709506, 12737.808932866199, 12951.676208094874, 12970.675733106747, 13175.341232938506, 13511.594652160451, 11792.351420671603, 11959.940200298943, 12053.517859285881, 12407.689807754878, 12545.686357840761, 11663.650090497298, 12000.699982500508, 12043.397830108284, 12168.148229623841, 12171.208871423329, 11845.289282643069, 11920.165588408729, 11972.76054478923, 12009.879901201226, 12356.38218089074, 8079.8384032317845, 8776.605052772513, 9468.715938521855, 9825.250616310137, 10283.434411107162, 8698.91301086981, 9562.330636855353, 9858.408495490294, 10357.792844143225, 10361.326513776581], "value": 7209.467874290646, "unit": "score"}], "name": "dromaeo_css", "value": 6985.914890427097, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 111.0, 114.0, 113.0, 113.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 109.0, 146.0, 109.0, 111.0, 117.0, 133.0, 148.0, 109.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 182.0, 185.0, 183.0, 182.0, 179.0, 180.0, 183.0, 182.0], "value": 182.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 87.0, 60.0, 59.0, 59.0, 58.0, 74.0, 59.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 85.0, 68.0, 66.0, 67.0, 83.0, 68.0, 68.0, 83.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 109.0, 111.0, 108.0, 117.0, 109.0, 111.0, 109.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 85.0, 81.0, 91.0, 84.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 55.0, 56.0, 56.0, 57.0, 55.0, 55.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 75.0, 71.0, 73.0, 70.0, 69.0, 71.0, 69.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 87.0, 85.0, 87.0, 87.0, 87.0, 88.0, 86.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 139.0, 140.0, 143.0, 137.0, 140.0, 137.0, 184.0, 149.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 179.0, 172.0, 171.0, 174.0, 173.0, 173.0, 173.0, 172.0, 173.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1445.8, "alertThreshold": 2.0}]} 18:30:29 INFO - Return code: 0 18:30:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:30:29 INFO - # TBPL SUCCESS # 18:30:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:30:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:30:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:30:29 INFO - 2016-12-19 18:30:29.919 screenresolution[1663:10087] starting screenresolution argv=screenresolution get 18:30:29 INFO - 2016-12-19 18:30:29.922 screenresolution[1663:10087] Display 0: 1600x1200x32@60 18:30:29 INFO - 2016-12-19 18:30:29.928 screenresolution[1664:10090] starting screenresolution argv=screenresolution list 18:30:29 INFO - Available Modes on Display 0 18:30:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:30:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:30:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:30:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:30:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:30:30 INFO - Intel Iris: 18:30:30 INFO - Chipset Model: Intel Iris 18:30:30 INFO - Type: GPU 18:30:30 INFO - Bus: Built-In 18:30:30 INFO - VRAM (Dynamic, Max): 1536 MB 18:30:30 INFO - Vendor: Intel (0x8086) 18:30:30 INFO - Device ID: 0x0a2e 18:30:30 INFO - Revision ID: 0x0009 18:30:30 INFO - Displays: 18:30:30 INFO - Display: 18:30:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:30:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:30:30 INFO - Display Serial Number: 1600x1200 60 18:30:30 INFO - Main Display: Yes 18:30:30 INFO - Mirror: Off 18:30:30 INFO - Online: Yes 18:30:30 INFO - Rotation: Supported 18:30:30 INFO - Return code: 0 18:30:30 INFO - Running post-action listener: _resource_record_post_action 18:30:30 INFO - [mozharness: 2016-12-20 02:30:30.164079Z] Finished run-tests step (success) 18:30:30 INFO - Running post-run listener: _resource_record_post_run 18:30:30 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32308224; Write bytes: 552069120; Read time: 196; Write time: 1690 18:30:30 INFO - TinderboxPrint: CPU usage
53.7% 18:30:30 INFO - TinderboxPrint: I/O read bytes / time
32,308,224 / 196 18:30:30 INFO - TinderboxPrint: I/O write bytes / time
552,069,120 / 1,690 18:30:30 INFO - TinderboxPrint: CPU idle
2,224.7 (46.3%) 18:30:30 INFO - TinderboxPrint: CPU system
958.9 (20.0%) 18:30:30 INFO - TinderboxPrint: CPU user
1,622.1 (33.8%) 18:30:30 INFO - TinderboxPrint: Swap in / out
291,672,064 / 0 18:30:30 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249790976; Write bytes: 243689472; Read time: 18033; Write time: 536 18:30:30 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 28994560; Write bytes: 298840064; Read time: 172; Write time: 1128 18:30:30 INFO - Running post-run listener: _upload_blobber_files 18:30:30 INFO - Blob upload gear active. 18:30:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:30 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 18:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:30:31 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:31 INFO - (blobuploader) - INFO - Done attempting. 18:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:30:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:33 INFO - (blobuploader) - INFO - Done attempting. 18:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:30:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:34 INFO - (blobuploader) - INFO - Done attempting. 18:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:36 INFO - (blobuploader) - INFO - Done attempting. 18:30:36 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:36 INFO - Return code: 0 18:30:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/138fb9c8cd8437af8c112dccd9188c7cbd6901ce4b0c0cc0d4cb44258032fd8f367a50f32270faeff162454f73e69c264d1724b5de2e73002853f2961fa14028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76df1dea8d70ccf37211c9fd689f7f5f42ac950c66121540c33ae0bae509daa16a1bad4011fa6ac5a4acef40eb0faca1da49945df28857ec2f0780a16b60e4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860af588280b286daadd5150cba1d7492e15b9f84b76059fbdbbf762ecb136d27db3dc65728d2355efb4ed3684df1309e7251bb1414d036a6ce4ce1603935d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e511f6da8dbe6ea375310c11acf0e88c79940e1a159f63ac7e052f9fde2e213e95b17119d2ba6ff39d9e3e1aebe0a19864f2af1d02e6ea4385db4f4cfe492c9"} 18:30:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:36 INFO - Contents: 18:30:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/138fb9c8cd8437af8c112dccd9188c7cbd6901ce4b0c0cc0d4cb44258032fd8f367a50f32270faeff162454f73e69c264d1724b5de2e73002853f2961fa14028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76df1dea8d70ccf37211c9fd689f7f5f42ac950c66121540c33ae0bae509daa16a1bad4011fa6ac5a4acef40eb0faca1da49945df28857ec2f0780a16b60e4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860af588280b286daadd5150cba1d7492e15b9f84b76059fbdbbf762ecb136d27db3dc65728d2355efb4ed3684df1309e7251bb1414d036a6ce4ce1603935d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e511f6da8dbe6ea375310c11acf0e88c79940e1a159f63ac7e052f9fde2e213e95b17119d2ba6ff39d9e3e1aebe0a19864f2af1d02e6ea4385db4f4cfe492c9"} 18:30:36 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:36 INFO - Copying logs to upload dir... 18:30:36 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.548956 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-19 18:30:36.940863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 18:30:36.944239) ========= 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.w62HZoRucx/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.g14vFiVrqd/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/Firefox/sha512/138fb9c8cd8437af8c112dccd9188c7cbd6901ce4b0c0cc0d4cb44258032fd8f367a50f32270faeff162454f73e69c264d1724b5de2e73002853f2961fa14028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76df1dea8d70ccf37211c9fd689f7f5f42ac950c66121540c33ae0bae509daa16a1bad4011fa6ac5a4acef40eb0faca1da49945df28857ec2f0780a16b60e4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860af588280b286daadd5150cba1d7492e15b9f84b76059fbdbbf762ecb136d27db3dc65728d2355efb4ed3684df1309e7251bb1414d036a6ce4ce1603935d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e511f6da8dbe6ea375310c11acf0e88c79940e1a159f63ac7e052f9fde2e213e95b17119d2ba6ff39d9e3e1aebe0a19864f2af1d02e6ea4385db4f4cfe492c9"} build_url:https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/bjs8eIxeSaa68hjoHN1hjg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/138fb9c8cd8437af8c112dccd9188c7cbd6901ce4b0c0cc0d4cb44258032fd8f367a50f32270faeff162454f73e69c264d1724b5de2e73002853f2961fa14028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76df1dea8d70ccf37211c9fd689f7f5f42ac950c66121540c33ae0bae509daa16a1bad4011fa6ac5a4acef40eb0faca1da49945df28857ec2f0780a16b60e4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860af588280b286daadd5150cba1d7492e15b9f84b76059fbdbbf762ecb136d27db3dc65728d2355efb4ed3684df1309e7251bb1414d036a6ce4ce1603935d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e511f6da8dbe6ea375310c11acf0e88c79940e1a159f63ac7e052f9fde2e213e95b17119d2ba6ff39d9e3e1aebe0a19864f2af1d02e6ea4385db4f4cfe492c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 18:30:36.979028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 18:30:36.979353) ========= 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.w62HZoRucx/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.g14vFiVrqd/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.005151 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 18:30:37.029376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 18:30:37.029778) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 18:30:37.030110) ========= ========= Total master_lag: 0.25 =========