builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0117 starttime: 1494226957.93 results: success (0) buildid: 20170507230642 builduid: d9fccc64660d43e98ffe70dec1dd26e4 revision: 4844f1db8655240f9b7d9fc400539b1dfb80b915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:37.930958) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:37.931397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:37.931672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:37.959453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:37.959851) ========= 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.kShDrg0fP9/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.s7A84LWG9C/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-08 00:02:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-05-08 00:02:38 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137773 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:38.123961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:38.124461) ========= 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.kShDrg0fP9/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.s7A84LWG9C/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.037713 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:38.186140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 00:02:38.186493) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4844f1db8655240f9b7d9fc400539b1dfb80b915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4844f1db8655240f9b7d9fc400539b1dfb80b915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kShDrg0fP9/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.s7A84LWG9C/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-08 00:02:38,295 truncating revision to first 12 chars 2017-05-08 00:02:38,295 Setting DEBUG logging. 2017-05-08 00:02:38,296 attempt 1/10 2017-05-08 00:02:38,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4844f1db8655?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 00:02:39,461 unpacking tar archive at: mozilla-beta-4844f1db8655/testing/mozharness/ program finished with exit code 0 elapsedTime=1.446827 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 00:02:39.658630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:39.659003) ========= script_repo_revision: 4844f1db8655240f9b7d9fc400539b1dfb80b915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:39.659497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:39.659769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 00:02:39.681150) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-05-08 00:02:39.681592) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kShDrg0fP9/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.s7A84LWG9C/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:02:39 INFO - MultiFileLogger online at 20170508 00:02:39 in /builds/slave/test 00:02:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 00:02:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:02:39 INFO - {'append_to_log': False, 00:02:39 INFO - 'base_work_dir': '/builds/slave/test', 00:02:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:02:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:02:39 INFO - 'branch': 'Mozilla-Beta', 00:02:39 INFO - 'buildbot_json_path': 'buildprops.json', 00:02:39 INFO - 'config_files': ('talos/mac_config.py',), 00:02:39 INFO - 'default_actions': ('clobber', 00:02:39 INFO - 'read-buildbot-config', 00:02:39 INFO - 'download-and-extract', 00:02:39 INFO - 'populate-webroot', 00:02:39 INFO - 'create-virtualenv', 00:02:39 INFO - 'install', 00:02:39 INFO - 'run-tests'), 00:02:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:02:39 INFO - 'download_minidump_stackwalk': True, 00:02:39 INFO - 'download_symbols': 'ondemand', 00:02:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:02:39 INFO - 'tooltool.py': '/tools/tooltool.py', 00:02:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:02:39 INFO - '/tools/misc-python/virtualenv.py')}, 00:02:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:02:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:02:39 INFO - 'gecko_profile': False, 00:02:39 INFO - 'gecko_profile_interval': 0, 00:02:39 INFO - 'installer_path': 'installer.exe', 00:02:39 INFO - 'log_level': 'info', 00:02:39 INFO - 'log_name': 'talos', 00:02:39 INFO - 'log_to_console': True, 00:02:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:02:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:02:39 INFO - 'opt_config_files': (), 00:02:39 INFO - 'pip_index': False, 00:02:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:02:39 INFO - 'cmd': ('bash', 00:02:39 INFO - '-c', 00:02:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:02:39 INFO - 'enabled': True, 00:02:39 INFO - 'halt_on_failure': False, 00:02:39 INFO - 'name': 'check_screen_resolution'},), 00:02:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:02:39 INFO - 'cmd': ('bash', 00:02:39 INFO - '-c', 00:02:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:02:39 INFO - 'enabled': True, 00:02:39 INFO - 'halt_on_failure': False, 00:02:39 INFO - 'name': 'check_screen_resolution'},), 00:02:39 INFO - 'run_cmd_checks_enabled': True, 00:02:39 INFO - 'suite': 'dromaeojs', 00:02:39 INFO - 'system_bits': '32', 00:02:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:02:39 INFO - 'title': 't-yosemite-r7-0117', 00:02:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:02:39 INFO - 'use_talos_json': True, 00:02:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:02:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:02:39 INFO - 'work_dir': 'build'} 00:02:39 INFO - [mozharness: 2017-05-08 07:02:39.895816Z] Running clobber step. 00:02:39 INFO - Running pre-action listener: _resource_record_pre_action 00:02:39 INFO - Running main action method: clobber 00:02:39 INFO - rmtree: /builds/slave/test/build 00:02:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:02:42 INFO - Running post-action listener: _resource_record_post_action 00:02:42 INFO - [mozharness: 2017-05-08 07:02:42.468702Z] Finished clobber step (success) 00:02:42 INFO - [mozharness: 2017-05-08 07:02:42.468944Z] Running read-buildbot-config step. 00:02:42 INFO - Running pre-action listener: _resource_record_pre_action 00:02:42 INFO - Running main action method: read_buildbot_config 00:02:42 INFO - Using buildbot properties: 00:02:42 INFO - { 00:02:42 INFO - "project": "", 00:02:42 INFO - "product": "firefox", 00:02:42 INFO - "script_repo_revision": "production", 00:02:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 00:02:42 INFO - "repository": "", 00:02:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 00:02:42 INFO - "buildid": "20170507230642", 00:02:42 INFO - "pgo_build": "False", 00:02:42 INFO - "basedir": "/builds/slave/test", 00:02:42 INFO - "buildnumber": 22, 00:02:42 INFO - "slavename": "t-yosemite-r7-0117", 00:02:42 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 00:02:42 INFO - "platform": "yosemite_r7", 00:02:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 00:02:42 INFO - "branch": "mozilla-beta", 00:02:42 INFO - "repo_path": "releases/mozilla-beta", 00:02:42 INFO - "revision": "4844f1db8655240f9b7d9fc400539b1dfb80b915", 00:02:42 INFO - "stage_platform": "macosx64", 00:02:42 INFO - "builduid": "d9fccc64660d43e98ffe70dec1dd26e4", 00:02:42 INFO - "slavebuilddir": "test" 00:02:42 INFO - } 00:02:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 00:02:42 INFO - Running post-action listener: _resource_record_post_action 00:02:42 INFO - [mozharness: 2017-05-08 07:02:42.474258Z] Finished read-buildbot-config step (success) 00:02:42 INFO - [mozharness: 2017-05-08 07:02:42.474483Z] Running download-and-extract step. 00:02:42 INFO - Running pre-action listener: _resource_record_pre_action 00:02:42 INFO - Running main action method: download_and_extract 00:02:42 INFO - mkdir: /builds/slave/test/build/tests 00:02:42 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')]} 00:02:42 INFO - trying https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 00:02:42 INFO - Downloading https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 00:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 00:02:43 INFO - Downloaded 1287 bytes. 00:02:43 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 00:02:43 INFO - Using the following test package requirements: 00:02:43 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 00:02:43 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 00:02:43 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 00:02:43 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 00:02:43 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 00:02:43 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 00:02:43 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 00:02:43 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 00:02:43 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 00:02:43 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 00:02:43 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 00:02:43 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 00:02:43 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 00:02:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 00:02:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 00:02:43 INFO - Fetch https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 00:02:45 INFO - Expected file size: 51226948 00:02:45 INFO - Obtained file size: 51226948 00:03:01 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 00:03:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 00:03:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 00:03:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 00:03:03 INFO - Expected file size: 51226948 00:03:03 INFO - Obtained file size: 51226948 00:03:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 00:03:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 00:03:18 INFO - Fetch https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 00:03:19 INFO - Expected file size: 14404449 00:03:19 INFO - Obtained file size: 14404449 00:03:19 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')]} 00:03:19 INFO - trying https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 00:03:19 INFO - Downloading https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 00:03:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 00:03:21 INFO - Downloaded 59566077 bytes. 00:03:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 00:03:21 INFO - mkdir: /builds/slave/test/properties 00:03:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:03:21 INFO - Writing to file /builds/slave/test/properties/build_url 00:03:21 INFO - Contents: 00:03:21 INFO - build_url:https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 00:03:22 INFO - Running post-action listener: _resource_record_post_action 00:03:22 INFO - Running post-action listener: set_extra_try_arguments 00:03:22 INFO - [mozharness: 2017-05-08 07:03:22.252779Z] Finished download-and-extract step (success) 00:03:22 INFO - [mozharness: 2017-05-08 07:03:22.252903Z] Running populate-webroot step. 00:03:22 INFO - Running pre-action listener: _resource_record_pre_action 00:03:22 INFO - Running main action method: populate_webroot 00:03:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:03:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:03:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:03:22 INFO - '--tppagecycles', 00:03:22 INFO - '7'], 00:03:22 INFO - 'tests': ['tsvgm']}}, 00:03:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:03:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:03:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:03:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:03:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:03:22 INFO - 'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:03:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:03:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:03:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:03:22 INFO - 'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['damp', 'tps']}, 00:03:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:03:22 INFO - 'tests': ['damp', 'tps']}, 00:03:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['dromaeo_dom']}, 00:03:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:03:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['basic_compositor_video']}, 00:03:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:03:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['a11yr', 00:03:22 INFO - 'ts_paint', 00:03:22 INFO - 'tpaint', 00:03:22 INFO - 'sessionrestore', 00:03:22 INFO - 'sessionrestore_no_auto_restore', 00:03:22 INFO - 'tabpaint']}, 00:03:22 INFO - 'other-e10s': {'tests': ['a11yr', 00:03:22 INFO - 'ts_paint', 00:03:22 INFO - 'tpaint', 00:03:22 INFO - 'sessionrestore', 00:03:22 INFO - 'sessionrestore_no_auto_restore', 00:03:22 INFO - 'tabpaint']}, 00:03:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:03:22 INFO - 'ts_paint', 00:03:22 INFO - 'tpaint', 00:03:22 INFO - 'sessionrestore', 00:03:22 INFO - 'sessionrestore_no_auto_restore', 00:03:22 INFO - 'tabpaint']}, 00:03:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:03:22 INFO - 'ts_paint', 00:03:22 INFO - 'tpaint', 00:03:22 INFO - 'sessionrestore', 00:03:22 INFO - 'sessionrestore_no_auto_restore', 00:03:22 INFO - 'tabpaint']}, 00:03:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['a11yr', 00:03:22 INFO - 'ts_paint', 00:03:22 INFO - 'tpaint', 00:03:22 INFO - 'sessionrestore', 00:03:22 INFO - 'sessionrestore_no_auto_restore', 00:03:22 INFO - 'tabpaint']}, 00:03:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['a11yr', 00:03:22 INFO - 'ts_paint', 00:03:22 INFO - 'tpaint', 00:03:22 INFO - 'sessionrestore', 00:03:22 INFO - 'sessionrestore_no_auto_restore', 00:03:22 INFO - 'tabpaint']}, 00:03:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['tsvgx', 00:03:22 INFO - 'tsvgr_opacity', 00:03:22 INFO - 'tart', 00:03:22 INFO - 'tscrollx', 00:03:22 INFO - 'cart', 00:03:22 INFO - 'tsvg_static']}, 00:03:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:03:22 INFO - 'tsvgr_opacity', 00:03:22 INFO - 'tart', 00:03:22 INFO - 'tscrollx', 00:03:22 INFO - 'cart', 00:03:22 INFO - 'tsvg_static']}, 00:03:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:03:22 INFO - 'talos_options': ['--disable-e10s'], 00:03:22 INFO - 'tests': ['tp5o']}, 00:03:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:03:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:03:22 INFO - 'talos_options': ['--disable-e10s', 00:03:22 INFO - '--xperf_path', 00:03:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:03:22 INFO - 'tests': ['tp5n']}, 00:03:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:03:22 INFO - 'talos_options': ['--xperf_path', 00:03:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:03:22 INFO - 'tests': ['tp5n']}}, 00:03:22 INFO - 'talos.zip': {'path': '', 00:03:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:03:22 INFO - Running post-action listener: _resource_record_post_action 00:03:22 INFO - [mozharness: 2017-05-08 07:03:22.271611Z] Finished populate-webroot step (success) 00:03:22 INFO - [mozharness: 2017-05-08 07:03:22.271753Z] Running create-virtualenv step. 00:03:22 INFO - Running pre-action listener: _resource_record_pre_action 00:03:22 INFO - Running main action method: create_virtualenv 00:03:22 INFO - Creating virtualenv /builds/slave/test/build/venv 00:03:22 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 00:03:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:03:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:03:22 INFO - Using real prefix '/tools/python27' 00:03:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:03:23 INFO - Installing distribute.............................................................................................................................................................................................done. 00:03:25 INFO - Installing pip.................done. 00:03:25 INFO - Return code: 0 00:03:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:03:26 INFO - Reading from file tmpfile_stdout 00:03:26 INFO - Output received: 00:03:26 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) 00:03:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:03:26 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')]} 00:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:26 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')]} 00:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:26 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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:26 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 00:03:26 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 00:03:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:26 INFO - 'HOME': '/Users/cltbld', 00:03:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:26 INFO - 'LOGNAME': 'cltbld', 00:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:26 INFO - 'MOZ_NO_REMOTE': '1', 00:03:26 INFO - 'NO_EM_RESTART': '1', 00:03:26 INFO - 'PAGER': '/bin/cat', 00:03:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:26 INFO - 'PWD': '/builds/slave/test', 00:03:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:26 INFO - 'SHELL': '/bin/bash', 00:03:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:26 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:26 INFO - 'USER': 'cltbld', 00:03:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:26 INFO - 'XPC_FLAGS': '0x0', 00:03:26 INFO - 'XPC_SERVICE_NAME': '0', 00:03:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:26 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 00:03:26 INFO - Cleaning up... 00:03:26 INFO - Return code: 0 00:03:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:03:26 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')]} 00:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:26 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')]} 00:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:26 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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:26 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 00:03:26 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 00:03:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:26 INFO - 'HOME': '/Users/cltbld', 00:03:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:26 INFO - 'LOGNAME': 'cltbld', 00:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:26 INFO - 'MOZ_NO_REMOTE': '1', 00:03:26 INFO - 'NO_EM_RESTART': '1', 00:03:26 INFO - 'PAGER': '/bin/cat', 00:03:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:26 INFO - 'PWD': '/builds/slave/test', 00:03:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:26 INFO - 'SHELL': '/bin/bash', 00:03:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:26 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:26 INFO - 'USER': 'cltbld', 00:03:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:26 INFO - 'XPC_FLAGS': '0x0', 00:03:26 INFO - 'XPC_SERVICE_NAME': '0', 00:03:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:26 INFO - Downloading/unpacking psutil>=3.1.1 00:03:26 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 00:03:26 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 00:03:26 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 00:03:26 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 00:03:26 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 00:03:26 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 00:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:03:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:03:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:03:28 INFO - Installing collected packages: psutil 00:03:28 INFO - Running setup.py install for psutil 00:03:29 INFO - building 'psutil._psutil_osx' extension 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 INFO - building 'psutil._psutil_posix' extension 00:03:29 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 00:03:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:03:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:03:29 INFO - ^ 00:03:29 INFO - 1 warning generated. 00:03:29 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 00:03:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:03:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:03:30 INFO - Successfully installed psutil 00:03:30 INFO - Cleaning up... 00:03:30 INFO - Return code: 0 00:03:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:03:30 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')]} 00:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:30 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')]} 00:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:30 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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:30 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 00:03:30 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 00:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:30 INFO - 'HOME': '/Users/cltbld', 00:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:30 INFO - 'LOGNAME': 'cltbld', 00:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:30 INFO - 'MOZ_NO_REMOTE': '1', 00:03:30 INFO - 'NO_EM_RESTART': '1', 00:03:30 INFO - 'PAGER': '/bin/cat', 00:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:30 INFO - 'PWD': '/builds/slave/test', 00:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:30 INFO - 'SHELL': '/bin/bash', 00:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:30 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:30 INFO - 'USER': 'cltbld', 00:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:30 INFO - 'XPC_FLAGS': '0x0', 00:03:30 INFO - 'XPC_SERVICE_NAME': '0', 00:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:03:31 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 00:03:31 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 00:03:31 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 00:03:31 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 00:03:31 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 00:03:31 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 00:03:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:03:33 INFO - Installing collected packages: mozsystemmonitor 00:03:33 INFO - Running setup.py install for mozsystemmonitor 00:03:33 INFO - Successfully installed mozsystemmonitor 00:03:33 INFO - Cleaning up... 00:03:33 INFO - Return code: 0 00:03:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:33 INFO - 'HOME': '/Users/cltbld', 00:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:33 INFO - 'LOGNAME': 'cltbld', 00:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:33 INFO - 'MOZ_NO_REMOTE': '1', 00:03:33 INFO - 'NO_EM_RESTART': '1', 00:03:33 INFO - 'PAGER': '/bin/cat', 00:03:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:33 INFO - 'PWD': '/builds/slave/test', 00:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:33 INFO - 'SHELL': '/bin/bash', 00:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:33 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:33 INFO - 'USER': 'cltbld', 00:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:33 INFO - 'XPC_FLAGS': '0x0', 00:03:33 INFO - 'XPC_SERVICE_NAME': '0', 00:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:33 INFO - Downloading/unpacking jsonschema==2.5.1 00:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:03:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:03:34 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 00:03:34 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 00:03:34 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 00:03:34 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 00:03:34 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 00:03:34 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 00:03:35 INFO - Downloading functools32-3.2.3-2.tar.gz 00:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:03:35 INFO - warning: no files found matching '*.txt' 00:03:35 INFO - no previously-included directories found matching 'build' 00:03:35 INFO - no previously-included directories found matching 'dist' 00:03:35 INFO - no previously-included directories found matching '.git*' 00:03:35 INFO - Installing collected packages: jsonschema, functools32 00:03:35 INFO - Running setup.py install for functools32 00:03:35 INFO - warning: no files found matching '*.txt' 00:03:35 INFO - no previously-included directories found matching 'build' 00:03:35 INFO - no previously-included directories found matching 'dist' 00:03:35 INFO - no previously-included directories found matching '.git*' 00:03:35 INFO - Successfully installed jsonschema functools32 00:03:35 INFO - Cleaning up... 00:03:35 INFO - Return code: 0 00:03:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:35 INFO - 'HOME': '/Users/cltbld', 00:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:35 INFO - 'LOGNAME': 'cltbld', 00:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:35 INFO - 'MOZ_NO_REMOTE': '1', 00:03:35 INFO - 'NO_EM_RESTART': '1', 00:03:35 INFO - 'PAGER': '/bin/cat', 00:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:35 INFO - 'PWD': '/builds/slave/test', 00:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:35 INFO - 'SHELL': '/bin/bash', 00:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:35 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:35 INFO - 'USER': 'cltbld', 00:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:35 INFO - 'XPC_FLAGS': '0x0', 00:03:35 INFO - 'XPC_SERVICE_NAME': '0', 00:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:03:35 INFO - Cleaning up... 00:03:35 INFO - Return code: 0 00:03:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:35 INFO - 'HOME': '/Users/cltbld', 00:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:35 INFO - 'LOGNAME': 'cltbld', 00:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:35 INFO - 'MOZ_NO_REMOTE': '1', 00:03:35 INFO - 'NO_EM_RESTART': '1', 00:03:35 INFO - 'PAGER': '/bin/cat', 00:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:35 INFO - 'PWD': '/builds/slave/test', 00:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:35 INFO - 'SHELL': '/bin/bash', 00:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:35 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:35 INFO - 'USER': 'cltbld', 00:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:35 INFO - 'XPC_FLAGS': '0x0', 00:03:35 INFO - 'XPC_SERVICE_NAME': '0', 00:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:36 INFO - Downloading/unpacking blobuploader==1.2.4 00:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:37 INFO - Downloading blobuploader-1.2.4.tar.gz 00:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:03:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:03:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:38 INFO - Downloading docopt-0.6.1.tar.gz 00:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:03:38 INFO - Installing collected packages: blobuploader, requests, docopt 00:03:38 INFO - Running setup.py install for blobuploader 00:03:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:03:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:03:38 INFO - Running setup.py install for requests 00:03:38 INFO - Running setup.py install for docopt 00:03:39 INFO - Successfully installed blobuploader requests docopt 00:03:39 INFO - Cleaning up... 00:03:39 INFO - Return code: 0 00:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03:39 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')]} 00:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:39 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')]} 00:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:39 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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:39 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 00:03:39 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 00:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:39 INFO - 'HOME': '/Users/cltbld', 00:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:39 INFO - 'LOGNAME': 'cltbld', 00:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:39 INFO - 'MOZ_NO_REMOTE': '1', 00:03:39 INFO - 'NO_EM_RESTART': '1', 00:03:39 INFO - 'PAGER': '/bin/cat', 00:03:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:39 INFO - 'PWD': '/builds/slave/test', 00:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:39 INFO - 'SHELL': '/bin/bash', 00:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:39 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:39 INFO - 'USER': 'cltbld', 00:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:39 INFO - 'XPC_FLAGS': '0x0', 00:03:39 INFO - 'XPC_SERVICE_NAME': '0', 00:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:03:39 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Fl3H2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:03:39 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-me8wwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:03:39 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-wIWtUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:03:39 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-vGfs28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:03:39 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-GYatoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:03:39 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-_95d7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-OGuLaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-DTvFl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-exxOkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-lffscD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-z4LWc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-MCS9tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-JsZ5fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-9wLGmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-gzQeXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:03:40 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-YQbJRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:03:41 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-kSKisu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:03:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:03:41 INFO - Running setup.py install for manifestparser 00:03:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:03:41 INFO - Running setup.py install for mozcrash 00:03:41 INFO - Running setup.py install for mozdebug 00:03:41 INFO - Running setup.py install for mozdevice 00:03:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:03:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:03:41 INFO - Running setup.py install for mozfile 00:03:41 INFO - Running setup.py install for mozhttpd 00:03:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Running setup.py install for mozinfo 00:03:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Running setup.py install for mozInstall 00:03:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Running setup.py install for mozleak 00:03:42 INFO - Running setup.py install for mozlog 00:03:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Running setup.py install for moznetwork 00:03:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:03:42 INFO - Running setup.py install for mozprocess 00:03:42 INFO - Running setup.py install for mozprofile 00:03:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:03:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:03:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:03:43 INFO - Running setup.py install for mozrunner 00:03:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:03:43 INFO - Running setup.py install for mozscreenshot 00:03:43 INFO - Running setup.py install for moztest 00:03:43 INFO - Running setup.py install for mozversion 00:03:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:03:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:03:43 INFO - Cleaning up... 00:03:43 INFO - Return code: 0 00:03:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:43 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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:43 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 00:03:43 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 00:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:43 INFO - 'HOME': '/Users/cltbld', 00:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:43 INFO - 'LOGNAME': 'cltbld', 00:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:43 INFO - 'MOZ_NO_REMOTE': '1', 00:03:43 INFO - 'NO_EM_RESTART': '1', 00:03:43 INFO - 'PAGER': '/bin/cat', 00:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:43 INFO - 'PWD': '/builds/slave/test', 00:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:43 INFO - 'SHELL': '/bin/bash', 00:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:43 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:43 INFO - 'USER': 'cltbld', 00:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:43 INFO - 'XPC_FLAGS': '0x0', 00:03:43 INFO - 'XPC_SERVICE_NAME': '0', 00:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-sE02N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-LnOeK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-BI_NwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-VaZq4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-z475eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-t8Z7KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-unGsWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-oHAVNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-c8gT7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:03:44 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)) 00:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:03:44 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-3kDCIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:03:45 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)) 00:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:03:45 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-GPpAHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:03:45 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)) 00:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:03:45 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-hsyotR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:03:45 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-fMC5SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:03:45 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)) 00:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:03:45 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Ag9Vk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:03:45 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)) 00:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:45 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-WBAbI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:45 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)) 00:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:03:45 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-q6FA4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:03:45 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-v2M3Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:03:45 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)) 00:03:45 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)) 00:03:45 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)) 00:03:45 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)) 00:03:45 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)) 00:03:45 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)) 00:03:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:47 INFO - Downloading blessings-1.6.tar.gz 00:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:03:47 INFO - Installing collected packages: blessings 00:03:47 INFO - Running setup.py install for blessings 00:03:47 INFO - Successfully installed blessings 00:03:47 INFO - Cleaning up... 00:03:47 INFO - Return code: 0 00:03:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:03:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:03:47 INFO - Reading from file tmpfile_stdout 00:03:47 INFO - Current package versions: 00:03:47 INFO - blessings == 1.6 00:03:47 INFO - blobuploader == 1.2.4 00:03:47 INFO - docopt == 0.6.1 00:03:47 INFO - functools32 == 3.2.3-2 00:03:47 INFO - jsonschema == 2.5.1 00:03:47 INFO - manifestparser == 1.1 00:03:47 INFO - mozInstall == 1.12 00:03:47 INFO - mozcrash == 1.0 00:03:47 INFO - mozdebug == 0.1 00:03:47 INFO - mozdevice == 0.49 00:03:47 INFO - mozfile == 1.2 00:03:47 INFO - mozhttpd == 0.7 00:03:47 INFO - mozinfo == 0.9 00:03:47 INFO - mozleak == 0.1 00:03:47 INFO - mozlog == 3.4 00:03:47 INFO - moznetwork == 0.27 00:03:47 INFO - mozprocess == 0.25 00:03:47 INFO - mozprofile == 0.28 00:03:47 INFO - mozrunner == 6.13 00:03:47 INFO - mozscreenshot == 0.1 00:03:47 INFO - mozsystemmonitor == 0.3 00:03:47 INFO - moztest == 0.8 00:03:47 INFO - mozversion == 1.4 00:03:47 INFO - psutil == 3.1.1 00:03:47 INFO - requests == 1.2.3 00:03:47 INFO - wsgiref == 0.1.2 00:03:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03:47 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')]} 00:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:47 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')]} 00:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:47 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 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:47 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 00:03:47 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 00:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:47 INFO - 'HOME': '/Users/cltbld', 00:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:47 INFO - 'LOGNAME': 'cltbld', 00:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:47 INFO - 'MOZ_NO_REMOTE': '1', 00:03:47 INFO - 'NO_EM_RESTART': '1', 00:03:47 INFO - 'PAGER': '/bin/cat', 00:03:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:47 INFO - 'PWD': '/builds/slave/test', 00:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:47 INFO - 'SHELL': '/bin/bash', 00:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:47 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:47 INFO - 'USER': 'cltbld', 00:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:47 INFO - 'XPC_FLAGS': '0x0', 00:03:47 INFO - 'XPC_SERVICE_NAME': '0', 00:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 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)) 00:03:48 INFO - Cleaning up... 00:03:48 INFO - Return code: 0 00:03:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085e8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085eb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9b1d86a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, '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.kShDrg0fP9/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.s7A84LWG9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 00:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:03:48 INFO - 'HOME': '/Users/cltbld', 00:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:03:48 INFO - 'LOGNAME': 'cltbld', 00:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:48 INFO - 'MOZ_NO_REMOTE': '1', 00:03:48 INFO - 'NO_EM_RESTART': '1', 00:03:48 INFO - 'PAGER': '/bin/cat', 00:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:48 INFO - 'PWD': '/builds/slave/test', 00:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:03:48 INFO - 'SHELL': '/bin/bash', 00:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:03:48 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:03:48 INFO - 'USER': 'cltbld', 00:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:48 INFO - 'XPC_FLAGS': '0x0', 00:03:48 INFO - 'XPC_SERVICE_NAME': '0', 00:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:03:48 INFO - Cleaning up... 00:03:48 INFO - Return code: 0 00:03:48 INFO - Running post-action listener: _resource_record_post_action 00:03:48 INFO - Running post-action listener: _start_resource_monitoring 00:03:48 INFO - Starting resource monitoring. 00:03:48 INFO - [mozharness: 2017-05-08 07:03:48.333231Z] Finished create-virtualenv step (success) 00:03:48 INFO - [mozharness: 2017-05-08 07:03:48.334175Z] Running install step. 00:03:48 INFO - Running pre-action listener: _resource_record_pre_action 00:03:48 INFO - Running main action method: install 00:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:03:48 INFO - Reading from file tmpfile_stdout 00:03:48 INFO - Detecting whether we're running mozinstall >=1.0... 00:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:03:48 INFO - Reading from file tmpfile_stdout 00:03:48 INFO - Output received: 00:03:48 INFO - Usage: mozinstall [options] installer 00:03:48 INFO - Options: 00:03:48 INFO - -h, --help show this help message and exit 00:03:48 INFO - -d DEST, --destination=DEST 00:03:48 INFO - Directory to install application into. [default: 00:03:48 INFO - "/builds/slave/test"] 00:03:48 INFO - --app=APP Application being installed. [default: firefox] 00:03:48 INFO - mkdir: /builds/slave/test/build/application 00:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 00:04:03 INFO - Reading from file tmpfile_stdout 00:04:03 INFO - Output received: 00:04:03 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 00:04:03 INFO - Running post-action listener: _resource_record_post_action 00:04:03 INFO - [mozharness: 2017-05-08 07:04:03.707874Z] Finished install step (success) 00:04:03 INFO - [mozharness: 2017-05-08 07:04:03.708039Z] Running run-tests step. 00:04:03 INFO - Running pre-action listener: _resource_record_pre_action 00:04:03 INFO - Running main action method: run_tests 00:04:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:04:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:04:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:04:03 INFO - 2017-05-08 00:04:03.722 screenresolution[1630:7419] starting screenresolution argv=screenresolution get 00:04:03 INFO - 2017-05-08 00:04:03.725 screenresolution[1630:7419] Display 0: 1600x1200x32@60 00:04:03 INFO - 2017-05-08 00:04:03.731 screenresolution[1631:7421] starting screenresolution argv=screenresolution list 00:04:03 INFO - Available Modes on Display 0 00:04:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:04:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:04:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:04:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:04:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:04:03 INFO - Intel Iris: 00:04:03 INFO - Chipset Model: Intel Iris 00:04:03 INFO - Type: GPU 00:04:03 INFO - Bus: Built-In 00:04:03 INFO - VRAM (Dynamic, Max): 1536 MB 00:04:03 INFO - Vendor: Intel (0x8086) 00:04:03 INFO - Device ID: 0x0a2e 00:04:03 INFO - Revision ID: 0x0009 00:04:03 INFO - Displays: 00:04:03 INFO - Display: 00:04:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:04:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:04:03 INFO - Display Serial Number: 1600x1200 60 00:04:03 INFO - Main Display: Yes 00:04:03 INFO - Mirror: Off 00:04:03 INFO - Online: Yes 00:04:03 INFO - Rotation: Supported 00:04:03 INFO - Return code: 0 00:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:04:03 INFO - Python 2.7.3 00:04:03 INFO - Return code: 0 00:04:03 INFO - grabbing minidump binary from tooltool 00:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:03 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 0x1083c6d30>, '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 0x1082eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083bbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:04:03 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 00:04:03 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 00:04:03 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 00:04:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:04:04 INFO - Return code: 0 00:04:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:04:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:04:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:04:04 INFO - ENV: RUST_BACKTRACE is now 1 00:04:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:04:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 00:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0117 --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 00:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kShDrg0fP9/Render', 00:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:04:04 INFO - 'HOME': '/Users/cltbld', 00:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:04:04 INFO - 'LOGNAME': 'cltbld', 00:04:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:04:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:04 INFO - 'MOZ_NO_REMOTE': '1', 00:04:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:04:04 INFO - 'NO_EM_RESTART': '1', 00:04:04 INFO - 'PAGER': '/bin/cat', 00:04:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:04 INFO - 'PWD': '/builds/slave/test', 00:04:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:04:04 INFO - 'RUST_BACKTRACE': '1', 00:04:04 INFO - 'SHELL': '/bin/bash', 00:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s7A84LWG9C/Listeners', 00:04:04 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 00:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:04:04 INFO - 'USER': 'cltbld', 00:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:04 INFO - 'XPC_FLAGS': '0x0', 00:04:04 INFO - 'XPC_SERVICE_NAME': '0', 00:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:04:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 00:04:04 INFO - mozversion application_buildid: 20170507230642 00:04:04 INFO - mozversion application_changeset: 4844f1db8655240f9b7d9fc400539b1dfb80b915 00:04:04 INFO - mozversion application_display_name: Firefox 00:04:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:04:04 INFO - mozversion application_name: Firefox 00:04:04 INFO - mozversion application_remotingname: firefox 00:04:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:04:04 INFO - mozversion application_vendor: Mozilla 00:04:04 INFO - mozversion application_version: 54.0 00:04:04 INFO - mozversion platform_buildid: 20170507230642 00:04:04 INFO - mozversion platform_changeset: 4844f1db8655240f9b7d9fc400539b1dfb80b915 00:04:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:04:04 INFO - mozversion platform_version: 54.0 00:04:04 INFO - using testdate: 1494227044 00:04:04 INFO - actual date: 1494227044 00:04:04 INFO - starting webserver on 'localhost:49242' 00:04:04 INFO - SUITE-START | Running 2 tests 00:04:04 INFO - TEST-START | dromaeo_css 00:04:04 INFO - operating with platform_type : mac_ 00:04:04 INFO - Initialising browser for dromaeo_css test... 00:04:04 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpufQdfG/profile http://localhost:49242/getInfo.html) 00:04:06 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 00:04:06 INFO - PROCESS | 1641 | colorDepth:24 00:04:06 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 00:04:06 INFO - PROCESS | 1641 | __metrics 00:04:06 INFO - PROCESS | 1641 | 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" 00:04:06 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:04:07 INFO - TEST-INFO | 1641: exit 0 00:04:07 INFO - Browser initialized. 00:04:07 INFO - Running cycle 1/1 for dromaeo_css test... 00:04:07 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpufQdfG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:04:19 INFO - PROCESS | 1644 | RSS: Main: 164757504 00:04:19 INFO - PROCESS | 1644 | 00:07:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 00:07:24 INFO - PROCESS | 1644 | RSS: Main: 347705344 00:07:24 INFO - PROCESS | 1644 | 00:10:27 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 00:10:28 INFO - PROCESS | 1644 | RSS: Main: 302383104 00:10:28 INFO - PROCESS | 1644 | 00:13:30 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 00:13:31 INFO - PROCESS | 1644 | RSS: Main: 289742848 00:13:31 INFO - PROCESS | 1644 | 00:16:33 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 00:16:34 INFO - PROCESS | 1644 | RSS: Main: 275222528 00:16:34 INFO - PROCESS | 1644 | 00:19:37 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 00:19:37 INFO - PROCESS | 1644 | RSS: Main: 276058112 00:19:37 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 00:22:41 INFO - PROCESS | 1644 | RSS: Main: 418537472 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | __start_tp_report 00:22:41 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 00:22:41 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 00:22:41 INFO - PROCESS | 1644 | |i|pagename|runs| 00:22:41 INFO - PROCESS | 1644 | |0;dojo.html;3478.6869181773636;3547.2905418916216;3563.6970857477113;3572.892813215603;3586.53375061242;6152.323244443108;6174.84562885927;6180.9690951545235;6191.659458729768;6236.3763623637615;6010.338862725097;6021.608595441293;6050.304215015274;6050.334463209055;6056.606320589159;5326.121190003654;5331.2269720890645;5357.892842143155;5359.5444387227135;5471.042567550682;5377.381601115882;5400.29796126503;5435.211894275328;5435.809746658868;5486.149646804732;5430.321209848769;5434.157705555625;5470.288862447876;5481.506664400204;5484.204790305404;5534.806281780118;5561.721913904329;5566.777328906839;5573.972130139324;5590.217369568284;5416.133418652997;5514.062609356419;5520.558355331564;5526.696031718254;5564.944350556523;6017.067354560007;6033.9698301508215;6079.665618390986;6208.161898143738;6216;6387.93612063878;6440.323766004596;6444.935550644527;6446.484281257535;6453.999630057302;6532;6589.835254118685;6603.636799976;6626.072349871022;6633.900491492632;6114.021756518936;6223.5954662947215;6224.470919971808;6287.9056814147825;6290.591111577733;6561.442277406379;6562.475001999828;6636.634985075867;6641.535092543572;6700.83247918806;6410.45511131559;6417.197850268716;6419.133416988647;6423.518236132309;6460.063290822804;6491.805245842632;6539.346364784158;6568.96715516429;6589.308122647149;6598.7030583623855;6238.095476155932;6278.968605156945;6353.618782873043;6415.005674120425;6485.578437401554;6253.1245625612455;6261.812145635638;6492.642904640195;6510.7721229756735;6514;5053.292539044537;5216.26972223889;5256.237845512379;5283.577313814885;5328.280682107943;4700.482946875841;4757.524247575284;4769.523047695272;4788.1381351356395;4799.472058073609;6139.57023008394;6150.323464418911;6268.529860260499;6269.7492100316385;6279.058141278845;6436.35636436362;6440.645764482999;6442.838929026718;6447.903281450782;6505.60966342021;6218.1916350875;6252.093446450239;6275.497960163176;6278.434940855345;6289.056641503811;5820.185174075633;5826.446487583673;5840.795572154954;5863.413658634187;5892.616979896293;6552.410283074546;6614.570052946543;6810.489213309121;6913.516053876381;6916;6420.3258657842125;6433.8713225736155;6538.248101468392;6547.738090476328;6575.013747937847;6841.008053832266;6909.170899492093;6914.274001229798;6915.343042410963;6915.6887940043825;6508;6523.054157147092;6536.084948107174;6539.967300163468;6563.573367731082;6332.715027823667;6378.968105159444;6464.806055818333;6493.448056915215;6573.820608627874;6304.779332723333;6358.841028974312;6382.6170429774365;6406.327335629691;6416.967915160394;6337.7781777637565;6371.39471750183;6374.330695276929;6399.296077431572;6402.327755585783;6198.81403557894;6232.5325600581045;6249;6294.307626161027;6309.716062777278;6395.840103997251;6443.130177425987;6465.062565928009;6474.352564743488;6476.481881449567;6165.414285642857;6198.380161983766;6309.179806625109;6310.6213627182515;6311.147995020797 00:22:41 INFO - PROCESS | 1644 | |1;ext.html;823.4112609484218;844.5439462690146;909.2725819344523;921.2629896083132;996.4569309726198;38165.85502434928;38644;38776.418353724715;38780.030499237495;38931.61068389315;31035.689643103564;38669.80665096678;38730.80634596823;38737.80631096847;38764.03089922753;7892.921070789304;8041.959790201041;8138.674453021887;8145.185481451837;8244.134365891585;11636.941815290911;11858.407079645984;12084.456199471;12097.576584819533;12119.39403029845;11861.7627647447;11874.22817516863;11878.22791518553;11881.22772019816;11890.643280701594;11797.469113889896;11813.881861181408;11829.231099978473;11833.171677982544;11837.230580012358;11410.828837567444;11430.25703329281;11440.313581185072;11442.599509017144;11448.96959273661;40242.993925151815;40388.79805600953;40400.98997525056;40424.98937526556;40506.1898762026;4012.3981402789523;4056.7971601420104;4074.0222346636892;4075.8369665213354;4106.342985122366;25296.114635987837;28365.71634283672;28559.71440285612;29940.70059299401;30757.846210768803;3190.202449387653;3271.5910511186103;3280.7539434542505;3289.917752056194;3357.5803024621923;331000;331058;332056;332865;333970.99999999756;44454.88862778457;45091.323630145576;46352.07295854064;52319;52691.73654131705;53786.731066344415;54253.72873135609;54307.72846135744;54410.72794636001;54488.72755636196;14802.777958330633;14851.2574371281;14877.33052012662;14881.553553393416;14881.958262921708;12772.297523636104;12792.424340904681;12817.679558011125;12818;12990.415431305613;11724.355160466257;11760.705982350339;11812.93683568483;11822.172447928562;11923.761524769456;5112.028714544224;5127.307813445137;5505.834824955257;5535.394735526652;5558.749856256478;1100.7963526747578;1116.8883111688929;1134.3137401871913;1182.2492717124687;1203.8555373355077;26417.339566510607;26779.196624101307;26899.596506052425;26950.86524567404;27027.864860675963;1245.682351000489;1246.4391024039219;1262.7032647327871;1313.1727011982389;1321.5242512695422;13495.527656531975;13889;13950.372233249529;14267.928660356632;14339.426422943174;405073;406157;406250;406944;408838;53890.46109538933;53923;53971;54036.72981635145;54074.188887166725;1496.7605183170858;1540.2375823967209;1552.51871919703;1554.2306558253738;1556.7275726747773;21292.893535532225;25548.48903021892;25632.359191020372;26133.82397792142;26153;35618.821905890305;39125.6087439122;39191.216175675756;39220.80389598034;39240.215195696495;317995.0501237488;376405;376593;378962;379817;28059.859700701367;28437.573436398055;30527;33180;33387.83142590095;36941;44630.55369446264;45929.13997855133;46892;47003.52996469991;30183.396332072796;31267.53098703567;31324.530132048494;31395.90114345987;32154.83922580372;25672.743272567783;30990.0702978911;31693.049208523782;32002.359952800347;32435.02694919156;36151;36934;37626.81186594049;37726;37794.43308350432;30963.380732385678;31055.534166987964;31792.04623861288;32127.67872321247;32808.67191328152;24618.630720538848;24785;24877.502449951262;25173.24480265595;25472.617910730984 00:22:41 INFO - PROCESS | 1644 | |2;jquery.html;363.30161418156206;447.8007286757392;450.1334930259252;454.5885973194259;458.12955384768935;19578.412647620575;21172.682409763845;21708.131674733013;22487;22517.32448026558;22135.114595416206;22980.965856536455;23467.647985280233;23501.29496115115;23600.173993910175;6794.7961561153;6829.487788415864;6902.240753517109;7006.1592608887;7104.36060754532;6827.965860170692;6953.026576279325;6953.756618518353;6957.930420695779;6961.965190174042;6673.265940746514;6898.724051037952;6963.16442026955;6970.30296970304;6991.706534291147;6644.269130395653;6870.106886104824;6872.587644741307;6958.165020197558;6963.3732964033225;6793.728250869959;6796.35434633709;6796.4562834973085;6809.761658341934;6818.079559259536;25751.742482575122;26041.479170416485;26218.606720899203;26570.46859062808;26758.732412676014;2943.543750718642;3011.8192908425563;3042.3154790172257;3044.8173109613494;3075.584796052549;15983;16390.508284751475;16559.98883372221;16603.169841507875;17327.393541226123;2077.626027315083;2113.006886763219;2170.750363708178;2189.1462329691435;2237.6419772836266;157117;159891;160410;160938;165795;15312;17273;20228.494287642632;20292.89853550723;20578.588428231353;33092.503612445835;33176.3364732704;33432.8298509551;33644;33649.83175084109;10814.243002989715;10995.505202265917;11017.11863050954;11038.613648522263;11142.387168705798;9036.277097832157;9076.364654474255;9104.04407537199;9232.261419086457;9249.491277979776;7823.530588164728;9243.491607961627;9509.432453237587;9633.08485693858;9635.807283854283;3432.9828350858584;3737.0657335666083;3784.5836957934607;4019.83920643171;4067.6745860331102;1068.524506594558;1081.5511562701547;1089.2048804372853;1089.2647462962627;1133.586241022021;22739.317820465414;22900.885495572416;23052.88473557655;23078;23115.53768924612;900.4057322167338;1072.1690689715376;1100.4662738571785;1101.752105776194;1105.4748994227677;9001.829762131012;9317.39436936597;11892.643220703392;12432.875671243353;12499.187552809039;770949;781796;785868;789686;801487;153958;155895;159781;160672.58991115142;162010.37989619953;1271.2436100520176;1290.6515240884908;1323.2259128409796;1326.522451917309;1329.2157627000117;19128.521786955436;21272.958992427848;21732.782672173074;21851;21855.016524256764;66387.66806165938;67009.66495167493;67247.66376168087;67529;67901.64196716137;93786.53106734423;93870;94083;94549.52725236605;96145.5578166342;10349.360912967146;11211.198237314666;11547.8267825981;11763;11940.940295298467;13329.600111996655;13351.532696355582;13539.729205416033;13599.320033998458;13898.58304250874;11376.317420954769;11472.426378681199;11807.645770626896;11846.526138954345;11902.761944760883;10488.765945590847;10594.417307048187;10851.40317282557;11006.504707288032;11086.833697494705;10588.629397971034;10759.977802108788;11611.535538578362;11805.881941180478;11938.28370297785;11357.48891299877;11392.202545821712;11715.707107322385;11784.351860647746;11833.82249266279;10797.676069717922;11325.71685707864;11372.147088968195;11405.771884562428;11717.648470545897 00:22:41 INFO - PROCESS | 1644 | |3;mootools.html;1607.2927911718837;1637.7134001549725;1658.0466231916648;1667.658130083333;1676.1619190404795;10719.624813131542;11322.320660760339;11326.490307936143;11327;11332.036776873965;10979.451027448615;11402.7149321267;11562.248453850494;11570.942145289262;11578.247413918089;2119.703241546185;2459.0655550890683;2489.55188066148;2493.9127130550432;2496.8002559795264;2277.9316620501413;2306.9423264418356;2468.4816188600416;2472.678551788265;2478.8512689238705;2380.5000949800565;2433.111914151331;2434.3427274635837;2448.6327050942323;2468.2101727447225;2369.9052037918464;2418.069043418288;2421.685180926477;2422.1280339077916;2443.425794938188;2379.202967006055;2413.2398294537165;2420.770026847447;2421.6004359280696;2429.9514009719705;11108.44457777116;11351;11352.318860868374;11358.03456706181;11374.829377559343;5738.713064346808;5897.673023569705;5916.852078698024;5920.111983202511;5941.0197317443;3446.8965931022108;3522.18989632386;3582.7492075554724;3635.94546081809;3722.2083437421934;1237.257645412754;1244.7137158453606;1280.910336276461;1289.8194252804615;1294.0488740775615;14081.788773168411;14349.928250358786;14713.970022098565;15231.923840380838;15390.307436165287;4618.699784513996;4791.856244312677;4814.061258054716;4831.0820944020525;4850.466448690641;10337.431441270652;12098;12121.818172727417;12124.030077593949;12132.575359862363;4956.826511072095;4978.10394129053;5001.874953126201;5002.124628190052;5015.548600625962;4381.2332841753205;5279.128943724242;5303.416624171338;5351.51836334724;5381.730913454312;3943.3493473577114;3958.386450100239;4018.011084513185;4076.3681629347498;4091.5908409158847;1029.4955471818905;1049.239301506417;1064.164630764846;1064.4784055812595;1065.4566171252561;870.7039606533809;990.6582229130938;1013.7516308504464;1022.7852151048363;1040.079529616295;6834.2482326944;6897.827554311082;7004.964975175091;7014.333638304353;7064.399526040344;923.5751554284969;1021.4841505040056;1021.6424251511911;1052.1687866585464;1077.1167642533048;3793.829277682511;3840.6543411092575;4100.979495102565;4362.825486980549;4506.278995360726;12991.41538630745;13461.730765384833;14088.15471071739;14092.577222683336;14128.434862605587;13686.52097176594;13702.177869327872;13712.314384280746;13712.45150194001;13722.45110195601;10184.388936663823;10449.9477502612;10459.267851250339;10461.163106951426;10476.266661333786;6853.725850965906;7240.891386629311;7279.4540409468445;7357.411407087528;7392.519486233377;12648.494060237488;12682.970724684006;12776.872231277568;12781.233126012468;12793.040521961077;11231.326120432801;11474.139439541901;13097.476100955855;13111.27887966171;13132.40904159296;8928.062553431797;9123.498207598646;9360.95319523398;9410.670626528039;9493.240540756584;10381;10460.26778125524;10569.63006294776;10579.36523808574;10580.994805493467;8972.28221742272;9005.864912026194;9028.142326478974;9111.362204645611;9196.034416386183;8765.517896515752;8844;8885.06706795803;8948.5078320693;9026.954865225633;8109.635066422144;8153.877691834508;8158.143394943446;8230.300424463987;8242.052164000977;5095.515925987025;6046.7278972445465;6097.146399503984;6120.65345623962;6184.752609895734;5945.91081133792;6018.398160183947;6112.908306375497;6183.886900357978;6190.50475961931 00:22:41 INFO - PROCESS | 1644 | |4;prototype.html;391.64556076750534;392.672118780818;397.515774238797;399.29524389452604;403.8687426586358;4619.861404157877;4683.157031734287;5094.649917771793;5097.311862898508;5227.764750586223;5070.74646267687;5082.576878474024;5100.923486147711;5110.565601923841;5152.562032227256;4009.6190861868076;4083.9795801020955;4098.549159592442;4108.609682080212;4154.670505438254;3968.424578436125;3969.483967084275;4013.1772986537835;4117.723505713224;4190.832366705328;3375.898283585443;3893.357595996657;4116.279651061067;4139.855105071323;4184.4978602567735;3810.5427348718194;4039.6162364575316;4056.2901492239034;4070.999999999985;4078.8164532596106;3127.5152351385573;3647.8723244686307;3661.4324779659196;3685.4840322354894;3686.7972261525606;5155.690658560498;5182.404023537304;5185.740712964374;5223;5240.737963101829;4132.132252227036;4568.314752787075;4696.929546056812;4721.371126961193;4814.422269327703;4639.698419602715;4679.906401871977;4699.616276281072;5139.383274007106;5603.551715862721;3682.085315635881;4012.8996775080564;4103.199876024177;4116.279651061082;4136.345461815268;5312.415634280226;5591.329040515124;5893.44012318829;5934.703264836784;5983.461488466059;4490.326451032306;4878.243872199815;4989.575886049726;5081.974590127025;5087.618428617869;4077.0022688882827;5178.404483484373;5186.132992122833;5228.6339956203465;5256.421793602701;4482.529334419839;4753.977894752576;5045.646804723634;5307.495787900143;5486.862828429242;5181.212481693809;5194.68831870089;5601.719914004365;5618.494335509824;5693.572982026281;1556.8053993250844;1635.9754603680954;1744.8778585499147;1767.9823201768074;1782.8128046555184;1208.8428504294386;1307.0981023094034;1370.6710389506645;1416.5891891351598;1468.7209430208227;5324.334458192726;5337.733113344318;5344.194297993507;5377.010506112763;5384.838454846361;5205.27126202332;5224.947750522522;5425.484578964992;5782.537397008229;5813.7383817728305;4349.325854492558;4689.812407503661;4985.850424487271;5266.472722910313;5356.92861427716;2497.7627125423055;2619.934501637474;2623.5671114266315;2955.896543621006;2967.554866770002;5320.707361095099;5894.941050589439;5911.674857882772;6081.391860813972;6100.956179679857;5330.280412144389;5336.893262134736;5530.917036244459;5773.220615216976;5971.193888824953;5426.186072089218;5917.378675239124;5987.700614969322;5992.31088424828;5998.3401825798255;4590.770461476846;4966.627502937222;5501.304360863228;5832.9708351457975;5947.264258440992;5606.719664016864;5614.410486898817;5627.837517917874;5708.316046766297;5788;4977.950220497749;5131.818272670818;5653.773849045992;5942.851428714143;5976.611520251344;4666.440027196758;4779.183910114134;4894.853154405374;5013.348264725708;5100.464451232567;5062.367204099488;5472.699001554953;5542.7782888684005;5744.913826292525;5843.503302219359;5628.85927851807;5632.718364081861;5644.689542075225;5658.349289831557;5701.486866182064;5166.346769033873;5525.8948210357285;5528.391876893619;5657.943420565742;5678.602497825113;4753.928691069567;4754.643401744814;4892.633052521004;5097.954919241621;5588.888222235614;4631.861044168681;5108.642395032312;5256;5429.728513574227;5646.830595082154;5251.894962100813;5394.56843452515;5445.618806683494;5490.3411590609385;5561.888762224814 00:22:41 INFO - PROCESS | 1644 | |5;yui.html;751.6993202718909;770.5376773935636;805.8750893611489;826.9627866745996;886.9379143459959;16588.585285367855;17470.47588572345;17504.949703017828;17524.386646467392;17568.73646895296;15835.762463563056;16023.91988040061;16025.118618475979;16037.839621603809;16038.83961160388;984.566790612132;993.6720882108887;994.6220436234239;1014.8021135878506;1021.6679579136774;1018.9286749927508;1025.2157099818644;1027.2655051638078;1030.1089557532755;1031.020530496028;1049.9055085042344;1050.217587897018;1051.6529545250087;1051.85799917011;1052.3054783842665;1044.7335929338008;1047.3925123428394;1047.6752206815872;1048.3133547526381;1049.9370037797719;787.0122995640492;787.3425689549233;787.5983248543284;787.7991112266393;788.0976282156955;16320.836791632051;16729.749053764204;17117.400890968882;17124.886882352606;17341.82658173415;13233.808957193802;14136.929315353358;14527;14698.485553005594;14770.483033093898;11659.825102623467;11887.465064072137;11965.446629157686;12013;12449.377531123408;3725.2363265530503;3852.306584814732;3892.3577609694366;3930.0174956260935;4019.879403617867;105727.94272057258;112639;114395;115769;117258.41370793177;11280.435978201058;11305.434728263719;11315.603953861575;11517.539298428137;11673.941630291794;22764.772352276595;23418.648720269208;23428.64857027146;23492.177773777836;23499.17752878641;7746.0704715433385;7902.130765615778;8003.679852805939;8222.465539739898;8231.176882311722;4485.060600168472;4509.278515437514;4655.557722016403;4668.262060833079;4753.47711751707;3513.631068737797;3593.82030898454;3602.243528858969;3803.4865293185067;3993.6006399360413;711.0081436396198;712.6472396163932;719.3274288540232;736.6132780290391;736.7458226911707;700.8458139209366;712.6935417770305;746.9663865126082;752.7816933089453;763.8128658478709;8342;10148.644797432054;10418.739531511774;11033.83449248262;11046.834297485544;729.959852208123;739.9223081576465;748.3190296829968;753.1188509443964;767.535640937236;5054.54509094176;5296.92054619181;5302.708351040653;5311.521963023347;5323.387810401776;76947.230527694;99909;101098.98901011042;102203;104332.95667043384;87372;88698.11301887028;91246.63130053054;91725.62411563832;92538;61890.69054654698;74822.6258868713;77581.83627245596;78340.20747406574;78543.60728196322;9092.545372731205;9885.802283954137;9903.55434005486;9917.157041651251;10243.641472548425;42664.57335426606;50810.23784643159;51375.48624513707;51802.740986294826;53470.46529534655;61596.38403615906;65205.67397162984;65499.69000620056;66670.99993500004;67865;11808.291502509534;11910.702232444259;11934.940325298317;12051.397430128283;12283.140180187302;13146.40841162169;13369.598912032654;13408.463661453823;13926.651833704238;14255.429782808571;12256.203346782431;12449.439775209956;12932;12934.86453250841;12977.870221297666;12085.818712719492;12648.557300494438;12896.935515322739;12935;13104.803427948778;11556.653300401002;11761.705957350792;11841;11849;12236;8770.956145219234;8888.644454222018;9473.715788526355;9491.335606507755;9562.28282878773;10272.3881890817;10357.067863892285;10551.208659350426;10570.894291057299;10706.464676765974 00:22:41 INFO - PROCESS | 1644 | __end_tp_report 00:22:41 INFO - PROCESS | 1644 | __start_cc_report 00:22:41 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2070 00:22:41 INFO - PROCESS | 1644 | __end_cc_report 00:22:41 INFO - PROCESS | 1644 | __startTimestamp1494228161430__endTimestamp 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | ------- Summary: start ------- 00:22:41 INFO - PROCESS | 1644 | Number of tests: 6 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:6075.25 Median:6289.06 stddev:662.84 (10.5%) stddev-sans-first:632.80 00:22:41 INFO - PROCESS | 1644 | Values: 3478.7 3547.3 3563.7 3572.9 3586.5 6152.3 6174.8 6181.0 6191.7 6236.4 6010.3 6021.6 6050.3 6050.3 6056.6 5326.1 5331.2 5357.9 5359.5 5471.0 5377.4 5400.3 5435.2 5435.8 5486.1 5430.3 5434.2 5470.3 5481.5 5484.2 5534.8 5561.7 5566.8 5574.0 5590.2 5416.1 5514.1 5520.6 5526.7 5564.9 6017.1 6034.0 6079.7 6208.2 6216.0 6387.9 6440.3 6444.9 6446.5 6454.0 6532.0 6589.8 6603.6 6626.1 6633.9 6114.0 6223.6 6224.5 6287.9 6290.6 6561.4 6562.5 6636.6 6641.5 6700.8 6410.5 6417.2 6419.1 6423.5 6460.1 6491.8 6539.3 6569.0 6589.3 6598.7 6238.1 6279.0 6353.6 6415.0 6485.6 6253.1 6261.8 6492.6 6510.8 6514.0 5053.3 5216.3 5256.2 5283.6 5328.3 4700.5 4757.5 4769.5 4788.1 4799.5 6139.6 6150.3 6268.5 6269.7 6279.1 6436.4 6440.6 6442.8 6447.9 6505.6 6218.2 6252.1 6275.5 6278.4 6289.1 5820.2 5826.4 5840.8 5863.4 5892.6 6552.4 6614.6 6810.5 6913.5 6916.0 6420.3 6433.9 6538.2 6547.7 6575.0 6841.0 6909.2 6914.3 6915.3 6915.7 6508.0 6523.1 6536.1 6540.0 6563.6 6332.7 6379.0 6464.8 6493.4 6573.8 6304.8 6358.8 6382.6 6406.3 6417.0 6337.8 6371.4 6374.3 6399.3 6402.3 6198.8 6232.5 6249.0 6294.3 6309.7 6395.8 6443.1 6465.1 6474.4 6476.5 6165.4 6198.4 6309.2 6310.6 6311.1 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:51481.57 Median:17596.28 stddev:97515.12 (554.2%) stddev-sans-first:97714.50 00:22:41 INFO - PROCESS | 1644 | Values: 823.4 844.5 909.3 921.3 996.5 38165.9 38644.0 38776.4 38780.0 38931.6 31035.7 38669.8 38730.8 38737.8 38764.0 7892.9 8042.0 8138.7 8145.2 8244.1 11636.9 11858.4 12084.5 12097.6 12119.4 11861.8 11874.2 11878.2 11881.2 11890.6 11797.5 11813.9 11829.2 11833.2 11837.2 11410.8 11430.3 11440.3 11442.6 11449.0 40243.0 40388.8 40401.0 40425.0 40506.2 4012.4 4056.8 4074.0 4075.8 4106.3 25296.1 28365.7 28559.7 29940.7 30757.8 3190.2 3271.6 3280.8 3289.9 3357.6 331000.0 331058.0 332056.0 332865.0 333971.0 44454.9 45091.3 46352.1 52319.0 52691.7 53786.7 54253.7 54307.7 54410.7 54488.7 14802.8 14851.3 14877.3 14881.6 14882.0 12772.3 12792.4 12817.7 12818.0 12990.4 11724.4 11760.7 11812.9 11822.2 11923.8 5112.0 5127.3 5505.8 5535.4 5558.7 1100.8 1116.9 1134.3 1182.2 1203.9 26417.3 26779.2 26899.6 26950.9 27027.9 1245.7 1246.4 1262.7 1313.2 1321.5 13495.5 13889.0 13950.4 14267.9 14339.4 405073.0 406157.0 406250.0 406944.0 408838.0 53890.5 53923.0 53971.0 54036.7 54074.2 1496.8 1540.2 1552.5 1554.2 1556.7 21292.9 25548.5 25632.4 26133.8 26153.0 35618.8 39125.6 39191.2 39220.8 39240.2 317995.1 376405.0 376593.0 378962.0 379817.0 28059.9 28437.6 30527.0 33180.0 33387.8 36941.0 44630.6 45929.1 46892.0 47003.5 30183.4 31267.5 31324.5 31395.9 32154.8 25672.7 30990.1 31693.0 32002.4 32435.0 36151.0 36934.0 37626.8 37726.0 37794.4 30963.4 31055.5 31792.0 32127.7 32808.7 24618.6 24785.0 24877.5 25173.2 25472.6 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:45000.61 Median:12362.32 stddev:131112.57 (1060.6%) stddev-sans-first:131437.54 00:22:41 INFO - PROCESS | 1644 | Values: 363.3 447.8 450.1 454.6 458.1 19578.4 21172.7 21708.1 22487.0 22517.3 22135.1 22981.0 23467.6 23501.3 23600.2 6794.8 6829.5 6902.2 7006.2 7104.4 6828.0 6953.0 6953.8 6957.9 6962.0 6673.3 6898.7 6963.2 6970.3 6991.7 6644.3 6870.1 6872.6 6958.2 6963.4 6793.7 6796.4 6796.5 6809.8 6818.1 25751.7 26041.5 26218.6 26570.5 26758.7 2943.5 3011.8 3042.3 3044.8 3075.6 15983.0 16390.5 16560.0 16603.2 17327.4 2077.6 2113.0 2170.8 2189.1 2237.6 157117.0 159891.0 160410.0 160938.0 165795.0 15312.0 17273.0 20228.5 20292.9 20578.6 33092.5 33176.3 33432.8 33644.0 33649.8 10814.2 10995.5 11017.1 11038.6 11142.4 9036.3 9076.4 9104.0 9232.3 9249.5 7823.5 9243.5 9509.4 9633.1 9635.8 3433.0 3737.1 3784.6 4019.8 4067.7 1068.5 1081.6 1089.2 1089.3 1133.6 22739.3 22900.9 23052.9 23078.0 23115.5 900.4 1072.2 1100.5 1101.8 1105.5 9001.8 9317.4 11892.6 12432.9 12499.2 770949.0 781796.0 785868.0 789686.0 801487.0 153958.0 155895.0 159781.0 160672.6 162010.4 1271.2 1290.7 1323.2 1326.5 1329.2 19128.5 21273.0 21732.8 21851.0 21855.0 66387.7 67009.7 67247.7 67529.0 67901.6 93786.5 93870.0 94083.0 94549.5 96145.6 10349.4 11211.2 11547.8 11763.0 11940.9 13329.6 13351.5 13539.7 13599.3 13898.6 11376.3 11472.4 11807.6 11846.5 11902.8 10488.8 10594.4 10851.4 11006.5 11086.8 10588.6 10760.0 11611.5 11805.9 11938.3 11357.5 11392.2 11715.7 11784.4 11833.8 10797.7 11325.7 11372.1 11405.8 11717.6 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:6836.95 Median:2433.73 stddev:4259.64 (175.0%) stddev-sans-first:4253.46 00:22:41 INFO - PROCESS | 1644 | Values: 1607.3 1637.7 1658.0 1667.7 1676.2 10719.6 11322.3 11326.5 11327.0 11332.0 10979.5 11402.7 11562.2 11570.9 11578.2 2119.7 2459.1 2489.6 2493.9 2496.8 2277.9 2306.9 2468.5 2472.7 2478.9 2380.5 2433.1 2434.3 2448.6 2468.2 2369.9 2418.1 2421.7 2422.1 2443.4 2379.2 2413.2 2420.8 2421.6 2430.0 11108.4 11351.0 11352.3 11358.0 11374.8 5738.7 5897.7 5916.9 5920.1 5941.0 3446.9 3522.2 3582.7 3635.9 3722.2 1237.3 1244.7 1280.9 1289.8 1294.0 14081.8 14349.9 14714.0 15231.9 15390.3 4618.7 4791.9 4814.1 4831.1 4850.5 10337.4 12098.0 12121.8 12124.0 12132.6 4956.8 4978.1 5001.9 5002.1 5015.5 4381.2 5279.1 5303.4 5351.5 5381.7 3943.3 3958.4 4018.0 4076.4 4091.6 1029.5 1049.2 1064.2 1064.5 1065.5 870.7 990.7 1013.8 1022.8 1040.1 6834.2 6897.8 7005.0 7014.3 7064.4 923.6 1021.5 1021.6 1052.2 1077.1 3793.8 3840.7 4101.0 4362.8 4506.3 12991.4 13461.7 14088.2 14092.6 14128.4 13686.5 13702.2 13712.3 13712.5 13722.5 10184.4 10449.9 10459.3 10461.2 10476.3 6853.7 7240.9 7279.5 7357.4 7392.5 12648.5 12683.0 12776.9 12781.2 12793.0 11231.3 11474.1 13097.5 13111.3 13132.4 8928.1 9123.5 9361.0 9410.7 9493.2 10381.0 10460.3 10569.6 10579.4 10581.0 8972.3 9005.9 9028.1 9111.4 9196.0 8765.5 8844.0 8885.1 8948.5 9027.0 8109.6 8153.9 8158.1 8230.3 8242.1 5095.5 6046.7 6097.1 6120.7 6184.8 5945.9 6018.4 6112.9 6183.9 6190.5 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4657.05 Median:5104.78 stddev:1301.57 (25.5%) stddev-sans-first:1265.24 00:22:41 INFO - PROCESS | 1644 | Values: 391.6 392.7 397.5 399.3 403.9 4619.9 4683.2 5094.6 5097.3 5227.8 5070.7 5082.6 5100.9 5110.6 5152.6 4009.6 4084.0 4098.5 4108.6 4154.7 3968.4 3969.5 4013.2 4117.7 4190.8 3375.9 3893.4 4116.3 4139.9 4184.5 3810.5 4039.6 4056.3 4071.0 4078.8 3127.5 3647.9 3661.4 3685.5 3686.8 5155.7 5182.4 5185.7 5223.0 5240.7 4132.1 4568.3 4696.9 4721.4 4814.4 4639.7 4679.9 4699.6 5139.4 5603.6 3682.1 4012.9 4103.2 4116.3 4136.3 5312.4 5591.3 5893.4 5934.7 5983.5 4490.3 4878.2 4989.6 5082.0 5087.6 4077.0 5178.4 5186.1 5228.6 5256.4 4482.5 4754.0 5045.6 5307.5 5486.9 5181.2 5194.7 5601.7 5618.5 5693.6 1556.8 1636.0 1744.9 1768.0 1782.8 1208.8 1307.1 1370.7 1416.6 1468.7 5324.3 5337.7 5344.2 5377.0 5384.8 5205.3 5224.9 5425.5 5782.5 5813.7 4349.3 4689.8 4985.9 5266.5 5356.9 2497.8 2619.9 2623.6 2955.9 2967.6 5320.7 5894.9 5911.7 6081.4 6101.0 5330.3 5336.9 5530.9 5773.2 5971.2 5426.2 5917.4 5987.7 5992.3 5998.3 4590.8 4966.6 5501.3 5833.0 5947.3 5606.7 5614.4 5627.8 5708.3 5788.0 4978.0 5131.8 5653.8 5942.9 5976.6 4666.4 4779.2 4894.9 5013.3 5100.5 5062.4 5472.7 5542.8 5744.9 5843.5 5628.9 5632.7 5644.7 5658.3 5701.5 5166.3 5525.9 5528.4 5657.9 5678.6 4753.9 4754.6 4892.6 5098.0 5588.9 4631.9 5108.6 5256.0 5429.7 5646.8 5251.9 5394.6 5445.6 5490.3 5561.9 00:22:41 INFO - PROCESS | 1644 | 00:22:41 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20480.96 Median:23091.71 stddev:29389.56 (127.3%) stddev-sans-first:29434.67 00:22:41 INFO - PROCESS | 1644 | Values: 751.7 770.5 805.9 827.0 886.9 16588.6 17470.5 17504.9 17524.4 17568.7 15835.8 16023.9 16025.1 16037.8 16038.8 984.6 993.7 994.6 1014.8 1021.7 1018.9 1025.2 1027.3 1030.1 1031.0 1049.9 1050.2 1051.7 1051.9 1052.3 1044.7 1047.4 1047.7 1048.3 1049.9 787.0 787.3 787.6 787.8 788.1 16320.8 16729.7 17117.4 17124.9 17341.8 13233.8 14136.9 14527.0 14698.5 14770.5 11659.8 11887.5 11965.4 12013.0 12449.4 3725.2 3852.3 3892.4 3930.0 4019.9 105727.9 112639.0 114395.0 115769.0 117258.4 11280.4 11305.4 11315.6 11517.5 11673.9 22764.8 23418.6 23428.6 23492.2 23499.2 7746.1 7902.1 8003.7 8222.5 8231.2 4485.1 4509.3 4655.6 4668.3 4753.5 3513.6 3593.8 3602.2 3803.5 3993.6 711.0 712.6 719.3 736.6 736.7 700.8 712.7 747.0 752.8 763.8 8342.0 10148.6 10418.7 11033.8 11046.8 730.0 739.9 748.3 753.1 767.5 5054.5 5296.9 5302.7 5311.5 5323.4 76947.2 99909.0 101099.0 102203.0 104333.0 87372.0 88698.1 91246.6 91725.6 92538.0 61890.7 74822.6 77581.8 78340.2 78543.6 9092.5 9885.8 9903.6 9917.2 10243.6 42664.6 50810.2 51375.5 51802.7 53470.5 61596.4 65205.7 65499.7 66671.0 67865.0 11808.3 11910.7 11934.9 12051.4 12283.1 13146.4 13369.6 13408.5 13926.7 14255.4 12256.2 12449.4 12932.0 12934.9 12977.9 12085.8 12648.6 12896.9 12935.0 13104.8 11556.7 11761.7 11841.0 11849.0 12236.0 8771.0 8888.6 9473.7 9491.3 9562.3 10272.4 10357.1 10551.2 10570.9 10706.5 00:22:41 INFO - PROCESS | 1644 | -------- Summary: end -------- 00:22:41 INFO - PROCESS | 1644 | 00:22:42 INFO - TEST-INFO | 1644: exit 0 00:22:42 INFO - TEST-OK | dromaeo_css | took 1117738ms 00:22:42 INFO - TEST-START | kraken 00:22:42 INFO - operating with platform_type : mac_ 00:22:42 INFO - Initialising browser for kraken test... 00:22:42 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmp5lTF5u/profile http://localhost:49242/getInfo.html) 00:22:44 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 00:22:44 INFO - PROCESS | 1654 | colorDepth:24 00:22:44 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 00:22:44 INFO - PROCESS | 1654 | __metrics 00:22:44 INFO - PROCESS | 1654 | 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" 00:22:44 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:22:45 INFO - TEST-INFO | 1654: exit 0 00:22:45 INFO - Browser initialized. 00:22:45 INFO - Running cycle 1/1 for kraken test... 00:22:45 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmp5lTF5u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:22:57 INFO - PROCESS | 1656 | RSS: Main: 164945920 00:22:57 INFO - PROCESS | 1656 | 00:22:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 00:23:00 INFO - PROCESS | 1656 | RSS: Main: 215904256 00:23:00 INFO - PROCESS | 1656 | 00:23:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 00:23:03 INFO - PROCESS | 1656 | RSS: Main: 232157184 00:23:03 INFO - PROCESS | 1656 | 00:23:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 00:23:07 INFO - PROCESS | 1656 | RSS: Main: 327979008 00:23:07 INFO - PROCESS | 1656 | 00:23:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 00:23:10 INFO - PROCESS | 1656 | RSS: Main: 230772736 00:23:10 INFO - PROCESS | 1656 | 00:23:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:23:12 INFO - PROCESS | 1656 | RSS: Main: 231784448 00:23:12 INFO - PROCESS | 1656 | 00:23:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 00:23:16 INFO - PROCESS | 1656 | RSS: Main: 271425536 00:23:16 INFO - PROCESS | 1656 | 00:23:19 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 00:23:20 INFO - PROCESS | 1656 | RSS: Main: 272531456 00:23:20 INFO - PROCESS | 1656 | 00:23:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 00:23:23 INFO - PROCESS | 1656 | RSS: Main: 271032320 00:23:23 INFO - PROCESS | 1656 | 00:23:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:23:25 INFO - PROCESS | 1656 | RSS: Main: 246734848 00:23:25 INFO - PROCESS | 1656 | 00:23:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:23:28 INFO - PROCESS | 1656 | RSS: Main: 251133952 00:23:28 INFO - PROCESS | 1656 | 00:23:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:23:30 INFO - PROCESS | 1656 | RSS: Main: 259989504 00:23:30 INFO - PROCESS | 1656 | 00:23:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:23:34 INFO - PROCESS | 1656 | RSS: Main: 273747968 00:23:34 INFO - PROCESS | 1656 | 00:23:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:23:37 INFO - PROCESS | 1656 | RSS: Main: 267509760 00:23:37 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 00:23:39 INFO - PROCESS | 1656 | RSS: Main: 311939072 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | __start_tp_report 00:23:39 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 00:23:39 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 00:23:39 INFO - PROCESS | 1656 | |i|pagename|runs| 00:23:39 INFO - PROCESS | 1656 | |0;ai-astar;104;114;115;117;115;116;116;116;115;114 00:23:39 INFO - PROCESS | 1656 | |1;audio-beat-detection;141;108;107;143;109;106;108;120;126;107 00:23:39 INFO - PROCESS | 1656 | |2;audio-dft;184;183;160;195;231;255;228;183;185;186 00:23:39 INFO - PROCESS | 1656 | |3;audio-fft;82;58;59;93;62;59;58;59;74;58 00:23:39 INFO - PROCESS | 1656 | |4;audio-oscillator;89;68;84;68;68;67;83;69;69;83 00:23:39 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;87;87;87;86;88;91;135;87;87;87 00:23:39 INFO - PROCESS | 1656 | |6;imaging-darkroom;97;95;95;94;93;94;94;93;99;94 00:23:39 INFO - PROCESS | 1656 | |7;imaging-desaturate;85;85;83;85;85;85;85;85;86;84 00:23:39 INFO - PROCESS | 1656 | |8;json-parse-financial;62;62;63;61;63;67;63;63;62;65 00:23:39 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;54;61;65;62;61;59;58;57;59;58 00:23:39 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;84;84;83;83;81;73;80;87;82;82 00:23:39 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;134;135;132;132;131;133;131;147;188;161 00:23:39 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;161;162;162;163;160;161;160;159;160;158 00:23:39 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;64;64;64;64;65;62;62;63;63;63 00:23:39 INFO - PROCESS | 1656 | __end_tp_report 00:23:39 INFO - PROCESS | 1656 | __start_cc_report 00:23:39 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2030 00:23:39 INFO - PROCESS | 1656 | __end_cc_report 00:23:39 INFO - PROCESS | 1656 | __startTimestamp1494228219790__endTimestamp 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | ------- Summary: start ------- 00:23:39 INFO - PROCESS | 1656 | Number of tests: 14 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:3.71 (3.2%) stddev-sans-first:1.00 00:23:39 INFO - PROCESS | 1656 | Values: 104.0 114.0 115.0 117.0 115.0 116.0 116.0 116.0 115.0 114.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:114.50 stddev:14.48 (12.6%) stddev-sans-first:12.61 00:23:39 INFO - PROCESS | 1656 | Values: 141.0 108.0 107.0 143.0 109.0 106.0 108.0 120.0 126.0 107.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:199.00 Median:190.50 stddev:29.14 (15.3%) stddev-sans-first:30.39 00:23:39 INFO - PROCESS | 1656 | Values: 184.0 183.0 160.0 195.0 231.0 255.0 228.0 183.0 185.0 186.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:12.49 (20.6%) stddev-sans-first:11.86 00:23:39 INFO - PROCESS | 1656 | Values: 82.0 58.0 59.0 93.0 62.0 59.0 58.0 59.0 74.0 58.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:76.00 stddev:8.74 (11.5%) stddev-sans-first:7.61 00:23:39 INFO - PROCESS | 1656 | Values: 89.0 68.0 84.0 68.0 68.0 67.0 83.0 69.0 69.0 83.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:87.00 stddev:15.10 (17.4%) stddev-sans-first:15.90 00:23:39 INFO - PROCESS | 1656 | Values: 87.0 87.0 87.0 86.0 88.0 91.0 135.0 87.0 87.0 87.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:94.50 stddev:1.87 (2.0%) stddev-sans-first:1.81 00:23:39 INFO - PROCESS | 1656 | Values: 97.0 95.0 95.0 94.0 93.0 94.0 94.0 93.0 99.0 94.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 00:23:39 INFO - PROCESS | 1656 | Values: 85.0 85.0 83.0 85.0 85.0 85.0 85.0 85.0 86.0 84.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:1.73 (2.7%) stddev-sans-first:1.79 00:23:39 INFO - PROCESS | 1656 | Values: 62.0 62.0 63.0 61.0 63.0 67.0 63.0 63.0 62.0 65.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:3.03 (5.0%) stddev-sans-first:2.50 00:23:39 INFO - PROCESS | 1656 | Values: 54.0 61.0 65.0 62.0 61.0 59.0 58.0 57.0 59.0 58.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:83.00 stddev:3.67 (4.4%) stddev-sans-first:3.81 00:23:39 INFO - PROCESS | 1656 | Values: 84.0 84.0 83.0 83.0 81.0 73.0 80.0 87.0 82.0 82.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:134.50 stddev:18.67 (13.9%) stddev-sans-first:19.55 00:23:39 INFO - PROCESS | 1656 | Values: 134.0 135.0 132.0 132.0 131.0 133.0 131.0 147.0 188.0 161.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 00:23:39 INFO - PROCESS | 1656 | Values: 161.0 162.0 162.0 163.0 160.0 161.0 160.0 159.0 160.0 158.0 00:23:39 INFO - PROCESS | 1656 | 00:23:39 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 00:23:39 INFO - PROCESS | 1656 | Values: 64.0 64.0 64.0 64.0 65.0 62.0 62.0 63.0 63.0 63.0 00:23:39 INFO - PROCESS | 1656 | -------- Summary: end -------- 00:23:39 INFO - PROCESS | 1656 | 00:23:40 INFO - TEST-INFO | 1656: exit 0 00:23:40 INFO - TEST-OK | kraken | took 58589ms 00:23:40 INFO - SUITE-END | took 1176s 00:23:40 INFO - Completed test suite (00:19:36) 00:23:40 INFO - javascript benchmark 00:23:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.7765714693, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3478.6869181773636, 3547.2905418916216, 3563.6970857477113, 3572.892813215603, 3586.53375061242, 6152.323244443108, 6174.84562885927, 6180.9690951545235, 6191.659458729768, 6236.3763623637615, 6010.338862725097, 6021.608595441293, 6050.304215015274, 6050.334463209055, 6056.606320589159, 5326.121190003654, 5331.2269720890645, 5357.892842143155, 5359.5444387227135, 5471.042567550682, 5377.381601115882, 5400.29796126503, 5435.211894275328, 5435.809746658868, 5486.149646804732, 5430.321209848769, 5434.157705555625, 5470.288862447876, 5481.506664400204, 5484.204790305404, 5534.806281780118, 5561.721913904329, 5566.777328906839, 5573.972130139324, 5590.217369568284, 5416.133418652997, 5514.062609356419, 5520.558355331564, 5526.696031718254, 5564.944350556523, 6017.067354560007, 6033.9698301508215, 6079.665618390986, 6208.161898143738, 6216.0, 6387.93612063878, 6440.323766004596, 6444.935550644527, 6446.484281257535, 6453.999630057302, 6532.0, 6589.835254118685, 6603.636799976, 6626.072349871022, 6633.900491492632, 6114.021756518936, 6223.5954662947215, 6224.470919971808, 6287.9056814147825, 6290.591111577733, 6561.442277406379, 6562.475001999828, 6636.634985075867, 6641.535092543572, 6700.83247918806, 6410.45511131559, 6417.197850268716, 6419.133416988647, 6423.518236132309, 6460.063290822804, 6491.805245842632, 6539.346364784158, 6568.96715516429, 6589.308122647149, 6598.7030583623855, 6238.095476155932, 6278.968605156945, 6353.618782873043, 6415.005674120425, 6485.578437401554, 6253.1245625612455, 6261.812145635638, 6492.642904640195, 6510.7721229756735, 6514.0, 5053.292539044537, 5216.26972223889, 5256.237845512379, 5283.577313814885, 5328.280682107943, 4700.482946875841, 4757.524247575284, 4769.523047695272, 4788.1381351356395, 4799.472058073609, 6139.57023008394, 6150.323464418911, 6268.529860260499, 6269.7492100316385, 6279.058141278845, 6436.35636436362, 6440.645764482999, 6442.838929026718, 6447.903281450782, 6505.60966342021, 6218.1916350875, 6252.093446450239, 6275.497960163176, 6278.434940855345, 6289.056641503811, 5820.185174075633, 5826.446487583673, 5840.795572154954, 5863.413658634187, 5892.616979896293, 6552.410283074546, 6614.570052946543, 6810.489213309121, 6913.516053876381, 6916.0, 6420.3258657842125, 6433.8713225736155, 6538.248101468392, 6547.738090476328, 6575.013747937847, 6841.008053832266, 6909.170899492093, 6914.274001229798, 6915.343042410963, 6915.6887940043825, 6508.0, 6523.054157147092, 6536.084948107174, 6539.967300163468, 6563.573367731082, 6332.715027823667, 6378.968105159444, 6464.806055818333, 6493.448056915215, 6573.820608627874, 6304.779332723333, 6358.841028974312, 6382.6170429774365, 6406.327335629691, 6416.967915160394, 6337.7781777637565, 6371.39471750183, 6374.330695276929, 6399.296077431572, 6402.327755585783, 6198.81403557894, 6232.5325600581045, 6249.0, 6294.307626161027, 6309.716062777278, 6395.840103997251, 6443.130177425987, 6465.062565928009, 6474.352564743488, 6476.481881449567, 6165.414285642857, 6198.380161983766, 6309.179806625109, 6310.6213627182515, 6311.147995020797], "value": 6032.455819709929, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.4112609484218, 844.5439462690146, 909.2725819344523, 921.2629896083132, 996.4569309726198, 38165.85502434928, 38644.0, 38776.418353724715, 38780.030499237495, 38931.61068389315, 31035.689643103564, 38669.80665096678, 38730.80634596823, 38737.80631096847, 38764.03089922753, 7892.921070789304, 8041.959790201041, 8138.674453021887, 8145.185481451837, 8244.134365891585, 11636.941815290911, 11858.407079645984, 12084.456199471, 12097.576584819533, 12119.39403029845, 11861.7627647447, 11874.22817516863, 11878.22791518553, 11881.22772019816, 11890.643280701594, 11797.469113889896, 11813.881861181408, 11829.231099978473, 11833.171677982544, 11837.230580012358, 11410.828837567444, 11430.25703329281, 11440.313581185072, 11442.599509017144, 11448.96959273661, 40242.993925151815, 40388.79805600953, 40400.98997525056, 40424.98937526556, 40506.1898762026, 4012.3981402789523, 4056.7971601420104, 4074.0222346636892, 4075.8369665213354, 4106.342985122366, 25296.114635987837, 28365.71634283672, 28559.71440285612, 29940.70059299401, 30757.846210768803, 3190.202449387653, 3271.5910511186103, 3280.7539434542505, 3289.917752056194, 3357.5803024621923, 331000.0, 331058.0, 332056.0, 332865.0, 333970.99999999756, 44454.88862778457, 45091.323630145576, 46352.07295854064, 52319.0, 52691.73654131705, 53786.731066344415, 54253.72873135609, 54307.72846135744, 54410.72794636001, 54488.72755636196, 14802.777958330633, 14851.2574371281, 14877.33052012662, 14881.553553393416, 14881.958262921708, 12772.297523636104, 12792.424340904681, 12817.679558011125, 12818.0, 12990.415431305613, 11724.355160466257, 11760.705982350339, 11812.93683568483, 11822.172447928562, 11923.761524769456, 5112.028714544224, 5127.307813445137, 5505.834824955257, 5535.394735526652, 5558.749856256478, 1100.7963526747578, 1116.8883111688929, 1134.3137401871913, 1182.2492717124687, 1203.8555373355077, 26417.339566510607, 26779.196624101307, 26899.596506052425, 26950.86524567404, 27027.864860675963, 1245.682351000489, 1246.4391024039219, 1262.7032647327871, 1313.1727011982389, 1321.5242512695422, 13495.527656531975, 13889.0, 13950.372233249529, 14267.928660356632, 14339.426422943174, 405073.0, 406157.0, 406250.0, 406944.0, 408838.0, 53890.46109538933, 53923.0, 53971.0, 54036.72981635145, 54074.188887166725, 1496.7605183170858, 1540.2375823967209, 1552.51871919703, 1554.2306558253738, 1556.7275726747773, 21292.893535532225, 25548.48903021892, 25632.359191020372, 26133.82397792142, 26153.0, 35618.821905890305, 39125.6087439122, 39191.216175675756, 39220.80389598034, 39240.215195696495, 317995.0501237488, 376405.0, 376593.0, 378962.0, 379817.0, 28059.859700701367, 28437.573436398055, 30527.0, 33180.0, 33387.83142590095, 36941.0, 44630.55369446264, 45929.13997855133, 46892.0, 47003.52996469991, 30183.396332072796, 31267.53098703567, 31324.530132048494, 31395.90114345987, 32154.83922580372, 25672.743272567783, 30990.0702978911, 31693.049208523782, 32002.359952800347, 32435.02694919156, 36151.0, 36934.0, 37626.81186594049, 37726.0, 37794.43308350432, 30963.380732385678, 31055.534166987964, 31792.04623861288, 32127.67872321247, 32808.67191328152, 24618.630720538848, 24785.0, 24877.502449951262, 25173.24480265595, 25472.617910730984], "value": 18851.118556659225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.30161418156206, 447.8007286757392, 450.1334930259252, 454.5885973194259, 458.12955384768935, 19578.412647620575, 21172.682409763845, 21708.131674733013, 22487.0, 22517.32448026558, 22135.114595416206, 22980.965856536455, 23467.647985280233, 23501.29496115115, 23600.173993910175, 6794.7961561153, 6829.487788415864, 6902.240753517109, 7006.1592608887, 7104.36060754532, 6827.965860170692, 6953.026576279325, 6953.756618518353, 6957.930420695779, 6961.965190174042, 6673.265940746514, 6898.724051037952, 6963.16442026955, 6970.30296970304, 6991.706534291147, 6644.269130395653, 6870.106886104824, 6872.587644741307, 6958.165020197558, 6963.3732964033225, 6793.728250869959, 6796.35434633709, 6796.4562834973085, 6809.761658341934, 6818.079559259536, 25751.742482575122, 26041.479170416485, 26218.606720899203, 26570.46859062808, 26758.732412676014, 2943.543750718642, 3011.8192908425563, 3042.3154790172257, 3044.8173109613494, 3075.584796052549, 15983.0, 16390.508284751475, 16559.98883372221, 16603.169841507875, 17327.393541226123, 2077.626027315083, 2113.006886763219, 2170.750363708178, 2189.1462329691435, 2237.6419772836266, 157117.0, 159891.0, 160410.0, 160938.0, 165795.0, 15312.0, 17273.0, 20228.494287642632, 20292.89853550723, 20578.588428231353, 33092.503612445835, 33176.3364732704, 33432.8298509551, 33644.0, 33649.83175084109, 10814.243002989715, 10995.505202265917, 11017.11863050954, 11038.613648522263, 11142.387168705798, 9036.277097832157, 9076.364654474255, 9104.04407537199, 9232.261419086457, 9249.491277979776, 7823.530588164728, 9243.491607961627, 9509.432453237587, 9633.08485693858, 9635.807283854283, 3432.9828350858584, 3737.0657335666083, 3784.5836957934607, 4019.83920643171, 4067.6745860331102, 1068.524506594558, 1081.5511562701547, 1089.2048804372853, 1089.2647462962627, 1133.586241022021, 22739.317820465414, 22900.885495572416, 23052.88473557655, 23078.0, 23115.53768924612, 900.4057322167338, 1072.1690689715376, 1100.4662738571785, 1101.752105776194, 1105.4748994227677, 9001.829762131012, 9317.39436936597, 11892.643220703392, 12432.875671243353, 12499.187552809039, 770949.0, 781796.0, 785868.0, 789686.0, 801487.0, 153958.0, 155895.0, 159781.0, 160672.58991115142, 162010.37989619953, 1271.2436100520176, 1290.6515240884908, 1323.2259128409796, 1326.522451917309, 1329.2157627000117, 19128.521786955436, 21272.958992427848, 21732.782672173074, 21851.0, 21855.016524256764, 66387.66806165938, 67009.66495167493, 67247.66376168087, 67529.0, 67901.64196716137, 93786.53106734423, 93870.0, 94083.0, 94549.52725236605, 96145.5578166342, 10349.360912967146, 11211.198237314666, 11547.8267825981, 11763.0, 11940.940295298467, 13329.600111996655, 13351.532696355582, 13539.729205416033, 13599.320033998458, 13898.58304250874, 11376.317420954769, 11472.426378681199, 11807.645770626896, 11846.526138954345, 11902.761944760883, 10488.765945590847, 10594.417307048187, 10851.40317282557, 11006.504707288032, 11086.833697494705, 10588.629397971034, 10759.977802108788, 11611.535538578362, 11805.881941180478, 11938.28370297785, 11357.48891299877, 11392.202545821712, 11715.707107322385, 11784.351860647746, 11833.82249266279, 10797.676069717922, 11325.71685707864, 11372.147088968195, 11405.771884562428, 11717.648470545897], "value": 11958.581921921244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1607.2927911718837, 1637.7134001549725, 1658.0466231916648, 1667.658130083333, 1676.1619190404795, 10719.624813131542, 11322.320660760339, 11326.490307936143, 11327.0, 11332.036776873965, 10979.451027448615, 11402.7149321267, 11562.248453850494, 11570.942145289262, 11578.247413918089, 2119.703241546185, 2459.0655550890683, 2489.55188066148, 2493.9127130550432, 2496.8002559795264, 2277.9316620501413, 2306.9423264418356, 2468.4816188600416, 2472.678551788265, 2478.8512689238705, 2380.5000949800565, 2433.111914151331, 2434.3427274635837, 2448.6327050942323, 2468.2101727447225, 2369.9052037918464, 2418.069043418288, 2421.685180926477, 2422.1280339077916, 2443.425794938188, 2379.202967006055, 2413.2398294537165, 2420.770026847447, 2421.6004359280696, 2429.9514009719705, 11108.44457777116, 11351.0, 11352.318860868374, 11358.03456706181, 11374.829377559343, 5738.713064346808, 5897.673023569705, 5916.852078698024, 5920.111983202511, 5941.0197317443, 3446.8965931022108, 3522.18989632386, 3582.7492075554724, 3635.94546081809, 3722.2083437421934, 1237.257645412754, 1244.7137158453606, 1280.910336276461, 1289.8194252804615, 1294.0488740775615, 14081.788773168411, 14349.928250358786, 14713.970022098565, 15231.923840380838, 15390.307436165287, 4618.699784513996, 4791.856244312677, 4814.061258054716, 4831.0820944020525, 4850.466448690641, 10337.431441270652, 12098.0, 12121.818172727417, 12124.030077593949, 12132.575359862363, 4956.826511072095, 4978.10394129053, 5001.874953126201, 5002.124628190052, 5015.548600625962, 4381.2332841753205, 5279.128943724242, 5303.416624171338, 5351.51836334724, 5381.730913454312, 3943.3493473577114, 3958.386450100239, 4018.011084513185, 4076.3681629347498, 4091.5908409158847, 1029.4955471818905, 1049.239301506417, 1064.164630764846, 1064.4784055812595, 1065.4566171252561, 870.7039606533809, 990.6582229130938, 1013.7516308504464, 1022.7852151048363, 1040.079529616295, 6834.2482326944, 6897.827554311082, 7004.964975175091, 7014.333638304353, 7064.399526040344, 923.5751554284969, 1021.4841505040056, 1021.6424251511911, 1052.1687866585464, 1077.1167642533048, 3793.829277682511, 3840.6543411092575, 4100.979495102565, 4362.825486980549, 4506.278995360726, 12991.41538630745, 13461.730765384833, 14088.15471071739, 14092.577222683336, 14128.434862605587, 13686.52097176594, 13702.177869327872, 13712.314384280746, 13712.45150194001, 13722.45110195601, 10184.388936663823, 10449.9477502612, 10459.267851250339, 10461.163106951426, 10476.266661333786, 6853.725850965906, 7240.891386629311, 7279.4540409468445, 7357.411407087528, 7392.519486233377, 12648.494060237488, 12682.970724684006, 12776.872231277568, 12781.233126012468, 12793.040521961077, 11231.326120432801, 11474.139439541901, 13097.476100955855, 13111.27887966171, 13132.40904159296, 8928.062553431797, 9123.498207598646, 9360.95319523398, 9410.670626528039, 9493.240540756584, 10381.0, 10460.26778125524, 10569.63006294776, 10579.36523808574, 10580.994805493467, 8972.28221742272, 9005.864912026194, 9028.142326478974, 9111.362204645611, 9196.034416386183, 8765.517896515752, 8844.0, 8885.06706795803, 8948.5078320693, 9026.954865225633, 8109.635066422144, 8153.877691834508, 8158.143394943446, 8230.300424463987, 8242.052164000977, 5095.515925987025, 6046.7278972445465, 6097.146399503984, 6120.65345623962, 6184.752609895734, 5945.91081133792, 6018.398160183947, 6112.908306375497, 6183.886900357978, 6190.50475961931], "value": 5224.778168937245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.64556076750534, 392.672118780818, 397.515774238797, 399.29524389452604, 403.8687426586358, 4619.861404157877, 4683.157031734287, 5094.649917771793, 5097.311862898508, 5227.764750586223, 5070.74646267687, 5082.576878474024, 5100.923486147711, 5110.565601923841, 5152.562032227256, 4009.6190861868076, 4083.9795801020955, 4098.549159592442, 4108.609682080212, 4154.670505438254, 3968.424578436125, 3969.483967084275, 4013.1772986537835, 4117.723505713224, 4190.832366705328, 3375.898283585443, 3893.357595996657, 4116.279651061067, 4139.855105071323, 4184.4978602567735, 3810.5427348718194, 4039.6162364575316, 4056.2901492239034, 4070.999999999985, 4078.8164532596106, 3127.5152351385573, 3647.8723244686307, 3661.4324779659196, 3685.4840322354894, 3686.7972261525606, 5155.690658560498, 5182.404023537304, 5185.740712964374, 5223.0, 5240.737963101829, 4132.132252227036, 4568.314752787075, 4696.929546056812, 4721.371126961193, 4814.422269327703, 4639.698419602715, 4679.906401871977, 4699.616276281072, 5139.383274007106, 5603.551715862721, 3682.085315635881, 4012.8996775080564, 4103.199876024177, 4116.279651061082, 4136.345461815268, 5312.415634280226, 5591.329040515124, 5893.44012318829, 5934.703264836784, 5983.461488466059, 4490.326451032306, 4878.243872199815, 4989.575886049726, 5081.974590127025, 5087.618428617869, 4077.0022688882827, 5178.404483484373, 5186.132992122833, 5228.6339956203465, 5256.421793602701, 4482.529334419839, 4753.977894752576, 5045.646804723634, 5307.495787900143, 5486.862828429242, 5181.212481693809, 5194.68831870089, 5601.719914004365, 5618.494335509824, 5693.572982026281, 1556.8053993250844, 1635.9754603680954, 1744.8778585499147, 1767.9823201768074, 1782.8128046555184, 1208.8428504294386, 1307.0981023094034, 1370.6710389506645, 1416.5891891351598, 1468.7209430208227, 5324.334458192726, 5337.733113344318, 5344.194297993507, 5377.010506112763, 5384.838454846361, 5205.27126202332, 5224.947750522522, 5425.484578964992, 5782.537397008229, 5813.7383817728305, 4349.325854492558, 4689.812407503661, 4985.850424487271, 5266.472722910313, 5356.92861427716, 2497.7627125423055, 2619.934501637474, 2623.5671114266315, 2955.896543621006, 2967.554866770002, 5320.707361095099, 5894.941050589439, 5911.674857882772, 6081.391860813972, 6100.956179679857, 5330.280412144389, 5336.893262134736, 5530.917036244459, 5773.220615216976, 5971.193888824953, 5426.186072089218, 5917.378675239124, 5987.700614969322, 5992.31088424828, 5998.3401825798255, 4590.770461476846, 4966.627502937222, 5501.304360863228, 5832.9708351457975, 5947.264258440992, 5606.719664016864, 5614.410486898817, 5627.837517917874, 5708.316046766297, 5788.0, 4977.950220497749, 5131.818272670818, 5653.773849045992, 5942.851428714143, 5976.611520251344, 4666.440027196758, 4779.183910114134, 4894.853154405374, 5013.348264725708, 5100.464451232567, 5062.367204099488, 5472.699001554953, 5542.7782888684005, 5744.913826292525, 5843.503302219359, 5628.85927851807, 5632.718364081861, 5644.689542075225, 5658.349289831557, 5701.486866182064, 5166.346769033873, 5525.8948210357285, 5528.391876893619, 5657.943420565742, 5678.602497825113, 4753.928691069567, 4754.643401744814, 4892.633052521004, 5097.954919241621, 5588.888222235614, 4631.861044168681, 5108.642395032312, 5256.0, 5429.728513574227, 5646.830595082154, 5251.894962100813, 5394.56843452515, 5445.618806683494, 5490.3411590609385, 5561.888762224814], "value": 4293.117502125522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.6993202718909, 770.5376773935636, 805.8750893611489, 826.9627866745996, 886.9379143459959, 16588.585285367855, 17470.47588572345, 17504.949703017828, 17524.386646467392, 17568.73646895296, 15835.762463563056, 16023.91988040061, 16025.118618475979, 16037.839621603809, 16038.83961160388, 984.566790612132, 993.6720882108887, 994.6220436234239, 1014.8021135878506, 1021.6679579136774, 1018.9286749927508, 1025.2157099818644, 1027.2655051638078, 1030.1089557532755, 1031.020530496028, 1049.9055085042344, 1050.217587897018, 1051.6529545250087, 1051.85799917011, 1052.3054783842665, 1044.7335929338008, 1047.3925123428394, 1047.6752206815872, 1048.3133547526381, 1049.9370037797719, 787.0122995640492, 787.3425689549233, 787.5983248543284, 787.7991112266393, 788.0976282156955, 16320.836791632051, 16729.749053764204, 17117.400890968882, 17124.886882352606, 17341.82658173415, 13233.808957193802, 14136.929315353358, 14527.0, 14698.485553005594, 14770.483033093898, 11659.825102623467, 11887.465064072137, 11965.446629157686, 12013.0, 12449.377531123408, 3725.2363265530503, 3852.306584814732, 3892.3577609694366, 3930.0174956260935, 4019.879403617867, 105727.94272057258, 112639.0, 114395.0, 115769.0, 117258.41370793177, 11280.435978201058, 11305.434728263719, 11315.603953861575, 11517.539298428137, 11673.941630291794, 22764.772352276595, 23418.648720269208, 23428.64857027146, 23492.177773777836, 23499.17752878641, 7746.0704715433385, 7902.130765615778, 8003.679852805939, 8222.465539739898, 8231.176882311722, 4485.060600168472, 4509.278515437514, 4655.557722016403, 4668.262060833079, 4753.47711751707, 3513.631068737797, 3593.82030898454, 3602.243528858969, 3803.4865293185067, 3993.6006399360413, 711.0081436396198, 712.6472396163932, 719.3274288540232, 736.6132780290391, 736.7458226911707, 700.8458139209366, 712.6935417770305, 746.9663865126082, 752.7816933089453, 763.8128658478709, 8342.0, 10148.644797432054, 10418.739531511774, 11033.83449248262, 11046.834297485544, 729.959852208123, 739.9223081576465, 748.3190296829968, 753.1188509443964, 767.535640937236, 5054.54509094176, 5296.92054619181, 5302.708351040653, 5311.521963023347, 5323.387810401776, 76947.230527694, 99909.0, 101098.98901011042, 102203.0, 104332.95667043384, 87372.0, 88698.11301887028, 91246.63130053054, 91725.62411563832, 92538.0, 61890.69054654698, 74822.6258868713, 77581.83627245596, 78340.20747406574, 78543.60728196322, 9092.545372731205, 9885.802283954137, 9903.55434005486, 9917.157041651251, 10243.641472548425, 42664.57335426606, 50810.23784643159, 51375.48624513707, 51802.740986294826, 53470.46529534655, 61596.38403615906, 65205.67397162984, 65499.69000620056, 66670.99993500004, 67865.0, 11808.291502509534, 11910.702232444259, 11934.940325298317, 12051.397430128283, 12283.140180187302, 13146.40841162169, 13369.598912032654, 13408.463661453823, 13926.651833704238, 14255.429782808571, 12256.203346782431, 12449.439775209956, 12932.0, 12934.86453250841, 12977.870221297666, 12085.818712719492, 12648.557300494438, 12896.935515322739, 12935.0, 13104.803427948778, 11556.653300401002, 11761.705957350792, 11841.0, 11849.0, 12236.0, 8770.956145219234, 8888.644454222018, 9473.715788526355, 9491.335606507755, 9562.28282878773, 10272.3881890817, 10357.067863892285, 10551.208659350426, 10570.894291057299, 10706.464676765974], "value": 7793.160797055553, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1414.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 117.0, 115.0, 116.0, 116.0, 116.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 107.0, 143.0, 109.0, 106.0, 108.0, 120.0, 126.0, 107.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 160.0, 195.0, 231.0, 255.0, 228.0, 183.0, 185.0, 186.0], "value": 199.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 93.0, 62.0, 59.0, 58.0, 59.0, 74.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 84.0, 68.0, 68.0, 67.0, 83.0, 69.0, 69.0, 83.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 88.0, 91.0, 135.0, 87.0, 87.0, 87.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 94.0, 93.0, 94.0, 94.0, 93.0, 99.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 63.0, 67.0, 63.0, 63.0, 62.0, 65.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 65.0, 62.0, 61.0, 59.0, 58.0, 57.0, 59.0, 58.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 81.0, 73.0, 80.0, 87.0, 82.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 132.0, 132.0, 131.0, 133.0, 131.0, 147.0, 188.0, 161.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 160.0, 161.0, 160.0, 159.0, 160.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 63.4, "unit": "score"}]}]} 00:23:41 INFO - Return code: 0 00:23:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:23:41 INFO - # TBPL SUCCESS # 00:23:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:23:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:23:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:23:41 INFO - 2017-05-08 00:23:41.097 screenresolution[1660:9767] starting screenresolution argv=screenresolution get 00:23:41 INFO - 2017-05-08 00:23:41.099 screenresolution[1660:9767] Display 0: 1600x1200x32@60 00:23:41 INFO - 2017-05-08 00:23:41.105 screenresolution[1661:9770] starting screenresolution argv=screenresolution list 00:23:41 INFO - Available Modes on Display 0 00:23:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:23:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:23:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:23:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:23:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:23:41 INFO - Intel Iris: 00:23:41 INFO - Chipset Model: Intel Iris 00:23:41 INFO - Type: GPU 00:23:41 INFO - Bus: Built-In 00:23:41 INFO - VRAM (Dynamic, Max): 1536 MB 00:23:41 INFO - Vendor: Intel (0x8086) 00:23:41 INFO - Device ID: 0x0a2e 00:23:41 INFO - Revision ID: 0x0009 00:23:41 INFO - Displays: 00:23:41 INFO - Display: 00:23:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:23:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:23:41 INFO - Display Serial Number: 1600x1200 60 00:23:41 INFO - Main Display: Yes 00:23:41 INFO - Mirror: Off 00:23:41 INFO - Online: Yes 00:23:41 INFO - Rotation: Supported 00:23:41 INFO - Return code: 0 00:23:41 INFO - Running post-action listener: _resource_record_post_action 00:23:41 INFO - [mozharness: 2017-05-08 07:23:41.339993Z] Finished run-tests step (success) 00:23:41 INFO - Running post-run listener: _resource_record_post_run 00:23:41 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 42054656; Write bytes: 423926272; Read time: 429; Write time: 1505 00:23:41 INFO - TinderboxPrint: CPU usage
53.9% 00:23:41 INFO - TinderboxPrint: I/O read bytes / time
42,054,656 / 429 00:23:41 INFO - TinderboxPrint: I/O write bytes / time
423,926,272 / 1,505 00:23:41 INFO - TinderboxPrint: CPU idle
2,199.8 (46.1%) 00:23:41 INFO - TinderboxPrint: CPU system
946.8 (19.9%) 00:23:41 INFO - TinderboxPrint: CPU user
1,623.1 (34.0%) 00:23:41 INFO - TinderboxPrint: Swap in / out
161,333,248 / 0 00:23:41 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119632384; Write bytes: 115828224; Read time: 10930; Write time: 309 00:23:41 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 39883776; Write bytes: 297001984; Read time: 398; Write time: 1159 00:23:41 INFO - Running post-run listener: _upload_blobber_files 00:23:41 INFO - Blob upload gear active. 00:23:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:23:41 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 00:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:23:42 INFO - (blobuploader) - INFO - Open directory for files ... 00:23:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:23:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:44 INFO - (blobuploader) - INFO - Done attempting. 00:23:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:23:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:23:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:45 INFO - (blobuploader) - INFO - Done attempting. 00:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:23:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:46 INFO - (blobuploader) - INFO - Done attempting. 00:23:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:23:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:48 INFO - (blobuploader) - INFO - Done attempting. 00:23:48 INFO - (blobuploader) - INFO - Iteration through files over. 00:23:48 INFO - Return code: 0 00:23:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:23:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:23:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80ff80e8b14967764202d614c1ccfd1c7538dc61f48c452908ab08dfaf526cb23a730a8d7c53a05f55e20b8be6f66c4371aaec6a6906baeb00c866ca1b8b4933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c6b6bd128a99305dbfbb9f6bd58d6d2cc6cc1fb1a3a87d89c41d9edeeefc6530d339db744e630a2dc5841dcf1189f11cf181fb0437c737f5700d0d7bd39d523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21549c2017b86833807ade98da0b1d84aa5555933911ee9d4b15ef458d87da157b3fce8445030106d054dd47b3d796f34bc2488664343d7e68e3fb6dc08ab0c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05b96fdfa5c4b9be5219cc320a7ef3c512d8418f4346dd6541a15c0db3b55bd683a4aacc05e7eb42257cc9a96ff0938862af517b58ac6e36d035748815f8f2d7"} 00:23:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:23:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:23:48 INFO - Contents: 00:23:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80ff80e8b14967764202d614c1ccfd1c7538dc61f48c452908ab08dfaf526cb23a730a8d7c53a05f55e20b8be6f66c4371aaec6a6906baeb00c866ca1b8b4933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c6b6bd128a99305dbfbb9f6bd58d6d2cc6cc1fb1a3a87d89c41d9edeeefc6530d339db744e630a2dc5841dcf1189f11cf181fb0437c737f5700d0d7bd39d523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21549c2017b86833807ade98da0b1d84aa5555933911ee9d4b15ef458d87da157b3fce8445030106d054dd47b3d796f34bc2488664343d7e68e3fb6dc08ab0c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05b96fdfa5c4b9be5219cc320a7ef3c512d8418f4346dd6541a15c0db3b55bd683a4aacc05e7eb42257cc9a96ff0938862af517b58ac6e36d035748815f8f2d7"} 00:23:48 INFO - Running post-run listener: copy_logs_to_upload_dir 00:23:48 INFO - Copying logs to upload dir... 00:23:48 INFO - mkdir: /builds/slave/test/build/upload/logs 00:23:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.628911 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-05-08 00:23:48.349664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 00:23:48.353349) ========= 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.kShDrg0fP9/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.s7A84LWG9C/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80ff80e8b14967764202d614c1ccfd1c7538dc61f48c452908ab08dfaf526cb23a730a8d7c53a05f55e20b8be6f66c4371aaec6a6906baeb00c866ca1b8b4933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c6b6bd128a99305dbfbb9f6bd58d6d2cc6cc1fb1a3a87d89c41d9edeeefc6530d339db744e630a2dc5841dcf1189f11cf181fb0437c737f5700d0d7bd39d523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21549c2017b86833807ade98da0b1d84aa5555933911ee9d4b15ef458d87da157b3fce8445030106d054dd47b3d796f34bc2488664343d7e68e3fb6dc08ab0c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05b96fdfa5c4b9be5219cc320a7ef3c512d8418f4346dd6541a15c0db3b55bd683a4aacc05e7eb42257cc9a96ff0938862af517b58ac6e36d035748815f8f2d7"} build_url:https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010897 build_url: 'https://queue.taskcluster.net/v1/task/LPZQ-Rp-SLu_P5vICrVBdw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80ff80e8b14967764202d614c1ccfd1c7538dc61f48c452908ab08dfaf526cb23a730a8d7c53a05f55e20b8be6f66c4371aaec6a6906baeb00c866ca1b8b4933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c6b6bd128a99305dbfbb9f6bd58d6d2cc6cc1fb1a3a87d89c41d9edeeefc6530d339db744e630a2dc5841dcf1189f11cf181fb0437c737f5700d0d7bd39d523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21549c2017b86833807ade98da0b1d84aa5555933911ee9d4b15ef458d87da157b3fce8445030106d054dd47b3d796f34bc2488664343d7e68e3fb6dc08ab0c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05b96fdfa5c4b9be5219cc320a7ef3c512d8418f4346dd6541a15c0db3b55bd683a4aacc05e7eb42257cc9a96ff0938862af517b58ac6e36d035748815f8f2d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 00:23:48.388605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 00:23:48.388986) ========= 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.kShDrg0fP9/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.s7A84LWG9C/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.005024 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 00:23:48.437773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 00:23:48.438095) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 00:23:48.438419) ========= ========= Total master_lag: 0.18 =========