builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0337 starttime: 1493029668.53 results: success (0) buildid: 20170424020335 builduid: a310b756cca54f04983ae4ed419852ed revision: e5e2984f44c5873e8b9b18b98f330acee4fada71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.530650) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.531334) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.531639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.559700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.560229) ========= 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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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-04-24 03:27:48-- 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% 28.9M=0s 2017-04-24 03:27:48 (28.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146172 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.731674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.732060) ========= 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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.042672 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.797967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:48.798368) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e5e2984f44c5873e8b9b18b98f330acee4fada71 --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 e5e2984f44c5873e8b9b18b98f330acee4fada71 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bgjQp6rxzw/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.J3ymPi5XEB/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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-04-24 03:27:48,907 truncating revision to first 12 chars 2017-04-24 03:27:48,907 Setting DEBUG logging. 2017-04-24 03:27:48,907 attempt 1/10 2017-04-24 03:27:48,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e5e2984f44c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 03:27:49,607 unpacking tar archive at: mozilla-beta-e5e2984f44c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970369 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:49.795086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:49.795610) ========= script_repo_revision: e5e2984f44c5873e8b9b18b98f330acee4fada71 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:49.796261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:49.796710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 03:27:49.818636) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-24 03:27:49.819218) ========= /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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:27:50 INFO - MultiFileLogger online at 20170424 03:27:50 in /builds/slave/test 03:27:50 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 03:27:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:50 INFO - {'append_to_log': False, 03:27:50 INFO - 'base_work_dir': '/builds/slave/test', 03:27:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:27:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:50 INFO - 'branch': 'Mozilla-Beta', 03:27:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:50 INFO - 'config_files': ('talos/mac_config.py',), 03:27:50 INFO - 'default_actions': ('clobber', 03:27:50 INFO - 'read-buildbot-config', 03:27:50 INFO - 'download-and-extract', 03:27:50 INFO - 'populate-webroot', 03:27:50 INFO - 'create-virtualenv', 03:27:50 INFO - 'install', 03:27:50 INFO - 'run-tests'), 03:27:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:50 INFO - 'download_minidump_stackwalk': True, 03:27:50 INFO - 'download_symbols': 'ondemand', 03:27:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:50 INFO - 'gecko_profile': False, 03:27:50 INFO - 'gecko_profile_interval': 0, 03:27:50 INFO - 'installer_path': 'installer.exe', 03:27:50 INFO - 'log_level': 'info', 03:27:50 INFO - 'log_name': 'talos', 03:27:50 INFO - 'log_to_console': True, 03:27:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:27:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:27:50 INFO - 'opt_config_files': (), 03:27:50 INFO - 'pip_index': False, 03:27:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:27:50 INFO - 'cmd': ('bash', 03:27:50 INFO - '-c', 03:27:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:27:50 INFO - 'enabled': True, 03:27:50 INFO - 'halt_on_failure': False, 03:27:50 INFO - 'name': 'check_screen_resolution'},), 03:27:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:27:50 INFO - 'cmd': ('bash', 03:27:50 INFO - '-c', 03:27:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:27:50 INFO - 'enabled': True, 03:27:50 INFO - 'halt_on_failure': False, 03:27:50 INFO - 'name': 'check_screen_resolution'},), 03:27:50 INFO - 'run_cmd_checks_enabled': True, 03:27:50 INFO - 'suite': 'dromaeojs', 03:27:50 INFO - 'system_bits': '32', 03:27:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:50 INFO - 'title': 't-yosemite-r7-0337', 03:27:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:50 INFO - 'use_talos_json': True, 03:27:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:50 INFO - 'work_dir': 'build'} 03:27:50 INFO - [mozharness: 2017-04-24 10:27:50.036574Z] Running clobber step. 03:27:50 INFO - Running pre-action listener: _resource_record_pre_action 03:27:50 INFO - Running main action method: clobber 03:27:50 INFO - rmtree: /builds/slave/test/build 03:27:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:52 INFO - Running post-action listener: _resource_record_post_action 03:27:52 INFO - [mozharness: 2017-04-24 10:27:52.579897Z] Finished clobber step (success) 03:27:52 INFO - [mozharness: 2017-04-24 10:27:52.580126Z] Running read-buildbot-config step. 03:27:52 INFO - Running pre-action listener: _resource_record_pre_action 03:27:52 INFO - Running main action method: read_buildbot_config 03:27:52 INFO - Using buildbot properties: 03:27:52 INFO - { 03:27:52 INFO - "project": "", 03:27:52 INFO - "product": "firefox", 03:27:52 INFO - "script_repo_revision": "production", 03:27:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 03:27:52 INFO - "repository": "", 03:27:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 03:27:52 INFO - "buildid": "20170424020335", 03:27:52 INFO - "pgo_build": "False", 03:27:52 INFO - "basedir": "/builds/slave/test", 03:27:52 INFO - "buildnumber": 22, 03:27:52 INFO - "slavename": "t-yosemite-r7-0337", 03:27:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:27:52 INFO - "platform": "yosemite_r7", 03:27:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:27:52 INFO - "branch": "mozilla-beta", 03:27:52 INFO - "repo_path": "releases/mozilla-beta", 03:27:52 INFO - "revision": "e5e2984f44c5873e8b9b18b98f330acee4fada71", 03:27:52 INFO - "stage_platform": "macosx64", 03:27:52 INFO - "builduid": "a310b756cca54f04983ae4ed419852ed", 03:27:52 INFO - "slavebuilddir": "test" 03:27:52 INFO - } 03:27:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 03:27:52 INFO - Running post-action listener: _resource_record_post_action 03:27:52 INFO - [mozharness: 2017-04-24 10:27:52.585805Z] Finished read-buildbot-config step (success) 03:27:52 INFO - [mozharness: 2017-04-24 10:27:52.586019Z] Running download-and-extract step. 03:27:52 INFO - Running pre-action listener: _resource_record_pre_action 03:27:52 INFO - Running main action method: download_and_extract 03:27:52 INFO - mkdir: /builds/slave/test/build/tests 03:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:52 INFO - trying https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 03:27:52 INFO - Downloading https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/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 03:27:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/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 03:27:53 INFO - Downloaded 1165 bytes. 03:27:53 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 03:27:53 INFO - Using the following test package requirements: 03:27:53 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 03:27:53 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 03:27:53 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 03:27:53 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 03:27:53 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 03:27:53 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:27:53 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 03:27:53 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 03:27:53 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 03:27:53 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 03:27:53 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 03:27:53 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 03:27:53 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 03:27:53 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 03:27:53 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 03:27:53 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 03:27:53 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 03:27:53 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 03:27:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 03:27:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 03:27:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 03:27:55 INFO - Expected file size: 51221152 03:27:55 INFO - Obtained file size: 51221152 03:28:11 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 03:28:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 03:28:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 03:28:11 INFO - Fetch https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 03:28:12 INFO - Expected file size: 51221152 03:28:12 INFO - Obtained file size: 51221152 03:28:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 03:28:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 03:28:27 INFO - Fetch https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 03:28:29 INFO - Expected file size: 14404449 03:28:29 INFO - Obtained file size: 14404449 03:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:29 INFO - trying https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 03:28:29 INFO - Downloading https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 03:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/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 03:28:31 INFO - Downloaded 59541942 bytes. 03:28:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 03:28:31 INFO - mkdir: /builds/slave/test/properties 03:28:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:31 INFO - Contents: 03:28:31 INFO - build_url:https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 03:28:32 INFO - Running post-action listener: _resource_record_post_action 03:28:32 INFO - Running post-action listener: set_extra_try_arguments 03:28:32 INFO - [mozharness: 2017-04-24 10:28:32.370830Z] Finished download-and-extract step (success) 03:28:32 INFO - [mozharness: 2017-04-24 10:28:32.370973Z] Running populate-webroot step. 03:28:32 INFO - Running pre-action listener: _resource_record_pre_action 03:28:32 INFO - Running main action method: populate_webroot 03:28:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:32 INFO - '--tppagecycles', 03:28:32 INFO - '7'], 03:28:32 INFO - 'tests': ['tsvgm']}}, 03:28:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['damp', 'tps']}, 03:28:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:28:32 INFO - 'tests': ['damp', 'tps']}, 03:28:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['dromaeo_dom']}, 03:28:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['basic_compositor_video']}, 03:28:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:28:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['a11yr', 03:28:32 INFO - 'ts_paint', 03:28:32 INFO - 'tpaint', 03:28:32 INFO - 'sessionrestore', 03:28:32 INFO - 'sessionrestore_no_auto_restore', 03:28:32 INFO - 'tabpaint']}, 03:28:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tsvgx', 03:28:32 INFO - 'tsvgr_opacity', 03:28:32 INFO - 'tart', 03:28:32 INFO - 'tscrollx', 03:28:32 INFO - 'cart', 03:28:32 INFO - 'tsvg_static']}, 03:28:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:32 INFO - 'tsvgr_opacity', 03:28:32 INFO - 'tart', 03:28:32 INFO - 'tscrollx', 03:28:32 INFO - 'cart', 03:28:32 INFO - 'tsvg_static']}, 03:28:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s'], 03:28:32 INFO - 'tests': ['tp5o']}, 03:28:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:28:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:28:32 INFO - 'talos_options': ['--disable-e10s', 03:28:32 INFO - '--xperf_path', 03:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:32 INFO - 'tests': ['tp5n']}, 03:28:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:28:32 INFO - 'talos_options': ['--xperf_path', 03:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:32 INFO - 'tests': ['tp5n']}}, 03:28:32 INFO - 'talos.zip': {'path': '', 03:28:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:32 INFO - Running post-action listener: _resource_record_post_action 03:28:32 INFO - [mozharness: 2017-04-24 10:28:32.389464Z] Finished populate-webroot step (success) 03:28:32 INFO - [mozharness: 2017-04-24 10:28:32.389576Z] Running create-virtualenv step. 03:28:32 INFO - Running pre-action listener: _resource_record_pre_action 03:28:32 INFO - Running main action method: create_virtualenv 03:28:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:32 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 03:28:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:32 INFO - Using real prefix '/tools/python27' 03:28:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:36 INFO - Installing pip.................done. 03:28:36 INFO - Return code: 0 03:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:36 INFO - Reading from file tmpfile_stdout 03:28:36 INFO - Output received: 03:28:36 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) 03:28:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:36 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 03:28:36 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 03:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:36 INFO - 'HOME': '/Users/cltbld', 03:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:36 INFO - 'LOGNAME': 'cltbld', 03:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:36 INFO - 'MOZ_NO_REMOTE': '1', 03:28:36 INFO - 'NO_EM_RESTART': '1', 03:28:36 INFO - 'PAGER': '/bin/cat', 03:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:36 INFO - 'PWD': '/builds/slave/test', 03:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:36 INFO - 'SHELL': '/bin/bash', 03:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:36 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:36 INFO - 'USER': 'cltbld', 03:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:36 INFO - 'XPC_FLAGS': '0x0', 03:28:36 INFO - 'XPC_SERVICE_NAME': '0', 03:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:36 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 03:28:36 INFO - Cleaning up... 03:28:36 INFO - Return code: 0 03:28:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:36 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 03:28:36 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 03:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:36 INFO - 'HOME': '/Users/cltbld', 03:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:36 INFO - 'LOGNAME': 'cltbld', 03:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:36 INFO - 'MOZ_NO_REMOTE': '1', 03:28:36 INFO - 'NO_EM_RESTART': '1', 03:28:36 INFO - 'PAGER': '/bin/cat', 03:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:36 INFO - 'PWD': '/builds/slave/test', 03:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:36 INFO - 'SHELL': '/bin/bash', 03:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:36 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:36 INFO - 'USER': 'cltbld', 03:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:36 INFO - 'XPC_FLAGS': '0x0', 03:28:36 INFO - 'XPC_SERVICE_NAME': '0', 03:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:36 INFO - Downloading/unpacking psutil>=3.1.1 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:40 INFO - Installing collected packages: psutil 03:28:40 INFO - Running setup.py install for psutil 03:28:40 INFO - building 'psutil._psutil_osx' extension 03:28:40 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 03:28:41 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 03:28:41 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 03:28:41 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 03:28:41 INFO - building 'psutil._psutil_posix' extension 03:28:41 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 03:28:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:28:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:28:41 INFO - ^ 03:28:41 INFO - 1 warning generated. 03:28:41 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 03:28:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:41 INFO - Successfully installed psutil 03:28:41 INFO - Cleaning up... 03:28:41 INFO - Return code: 0 03:28:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:41 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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:41 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 03:28:41 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 03:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:41 INFO - 'HOME': '/Users/cltbld', 03:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:41 INFO - 'LOGNAME': 'cltbld', 03:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:41 INFO - 'MOZ_NO_REMOTE': '1', 03:28:41 INFO - 'NO_EM_RESTART': '1', 03:28:41 INFO - 'PAGER': '/bin/cat', 03:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:41 INFO - 'PWD': '/builds/slave/test', 03:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:41 INFO - 'SHELL': '/bin/bash', 03:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:41 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:41 INFO - 'USER': 'cltbld', 03:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:41 INFO - 'XPC_FLAGS': '0x0', 03:28:41 INFO - 'XPC_SERVICE_NAME': '0', 03:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:42 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 03:28:42 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 03:28:42 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 03:28:42 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 03:28:42 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 03:28:42 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 03:28:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:44 INFO - Installing collected packages: mozsystemmonitor 03:28:44 INFO - Running setup.py install for mozsystemmonitor 03:28:44 INFO - Successfully installed mozsystemmonitor 03:28:44 INFO - Cleaning up... 03:28:44 INFO - Return code: 0 03:28:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:45 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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:45 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 03:28:45 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 03:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:45 INFO - 'HOME': '/Users/cltbld', 03:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:45 INFO - 'LOGNAME': 'cltbld', 03:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:45 INFO - 'MOZ_NO_REMOTE': '1', 03:28:45 INFO - 'NO_EM_RESTART': '1', 03:28:45 INFO - 'PAGER': '/bin/cat', 03:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:45 INFO - 'PWD': '/builds/slave/test', 03:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:45 INFO - 'SHELL': '/bin/bash', 03:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:45 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:45 INFO - 'USER': 'cltbld', 03:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:45 INFO - 'XPC_FLAGS': '0x0', 03:28:45 INFO - 'XPC_SERVICE_NAME': '0', 03:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:49 INFO - warning: no files found matching '*.txt' 03:28:49 INFO - no previously-included directories found matching 'build' 03:28:49 INFO - no previously-included directories found matching 'dist' 03:28:49 INFO - no previously-included directories found matching '.git*' 03:28:49 INFO - Installing collected packages: jsonschema, functools32 03:28:49 INFO - Running setup.py install for functools32 03:28:49 INFO - warning: no files found matching '*.txt' 03:28:49 INFO - no previously-included directories found matching 'build' 03:28:49 INFO - no previously-included directories found matching 'dist' 03:28:49 INFO - no previously-included directories found matching '.git*' 03:28:49 INFO - Successfully installed jsonschema functools32 03:28:49 INFO - Cleaning up... 03:28:49 INFO - Return code: 0 03:28:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:49 INFO - 'HOME': '/Users/cltbld', 03:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:49 INFO - 'LOGNAME': 'cltbld', 03:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:49 INFO - 'MOZ_NO_REMOTE': '1', 03:28:49 INFO - 'NO_EM_RESTART': '1', 03:28:49 INFO - 'PAGER': '/bin/cat', 03:28:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:49 INFO - 'PWD': '/builds/slave/test', 03:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:49 INFO - 'SHELL': '/bin/bash', 03:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:49 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:49 INFO - 'USER': 'cltbld', 03:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:49 INFO - 'XPC_FLAGS': '0x0', 03:28:49 INFO - 'XPC_SERVICE_NAME': '0', 03:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:49 INFO - Cleaning up... 03:28:49 INFO - Return code: 0 03:28:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:49 INFO - 'HOME': '/Users/cltbld', 03:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:49 INFO - 'LOGNAME': 'cltbld', 03:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:49 INFO - 'MOZ_NO_REMOTE': '1', 03:28:49 INFO - 'NO_EM_RESTART': '1', 03:28:49 INFO - 'PAGER': '/bin/cat', 03:28:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:49 INFO - 'PWD': '/builds/slave/test', 03:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:49 INFO - 'SHELL': '/bin/bash', 03:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:49 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:49 INFO - 'USER': 'cltbld', 03:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:49 INFO - 'XPC_FLAGS': '0x0', 03:28:49 INFO - 'XPC_SERVICE_NAME': '0', 03:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:52 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 03:28:52 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 03:28:52 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 03:28:52 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 03:28:52 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 03:28:52 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 03:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:54 INFO - Downloading docopt-0.6.1.tar.gz 03:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:54 INFO - Running setup.py install for blobuploader 03:28:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:54 INFO - Running setup.py install for requests 03:28:54 INFO - Running setup.py install for docopt 03:28:55 INFO - Successfully installed blobuploader requests docopt 03:28:55 INFO - Cleaning up... 03:28:55 INFO - Return code: 0 03:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:55 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')]} 03:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:55 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')]} 03:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:55 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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:55 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 03:28:55 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 03:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:55 INFO - 'HOME': '/Users/cltbld', 03:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:55 INFO - 'LOGNAME': 'cltbld', 03:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:55 INFO - 'MOZ_NO_REMOTE': '1', 03:28:55 INFO - 'NO_EM_RESTART': '1', 03:28:55 INFO - 'PAGER': '/bin/cat', 03:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:55 INFO - 'PWD': '/builds/slave/test', 03:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:55 INFO - 'SHELL': '/bin/bash', 03:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:55 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:55 INFO - 'USER': 'cltbld', 03:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:55 INFO - 'XPC_FLAGS': '0x0', 03:28:55 INFO - 'XPC_SERVICE_NAME': '0', 03:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:55 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-NkzgAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:55 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-anFvMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:55 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-9gXMnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:55 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-N3IUZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:55 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-jrPgVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:55 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-_sUuwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-kcbZ_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-mTWbQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Nsdjfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-VVyJLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-sdf3ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-AwAjAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-nc6zHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-GFzPID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:56 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-_QtLq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:57 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-mEYyFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:57 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-PY0Ovm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:57 INFO - Running setup.py install for manifestparser 03:28:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Running setup.py install for mozcrash 03:28:57 INFO - Running setup.py install for mozdebug 03:28:57 INFO - Running setup.py install for mozdevice 03:28:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Running setup.py install for mozfile 03:28:57 INFO - Running setup.py install for mozhttpd 03:28:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Running setup.py install for mozinfo 03:28:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Running setup.py install for mozInstall 03:28:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Running setup.py install for mozleak 03:28:58 INFO - Running setup.py install for mozlog 03:28:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Running setup.py install for moznetwork 03:28:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:58 INFO - Running setup.py install for mozprocess 03:28:59 INFO - Running setup.py install for mozprofile 03:28:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:59 INFO - Running setup.py install for mozrunner 03:28:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:59 INFO - Running setup.py install for mozscreenshot 03:28:59 INFO - Running setup.py install for moztest 03:28:59 INFO - Running setup.py install for mozversion 03:28:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:59 INFO - Cleaning up... 03:28:59 INFO - Return code: 0 03:28:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:59 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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:28:59 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 03:28:59 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 03:28:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:28:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:59 INFO - 'HOME': '/Users/cltbld', 03:28:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:59 INFO - 'LOGNAME': 'cltbld', 03:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:59 INFO - 'MOZ_NO_REMOTE': '1', 03:28:59 INFO - 'NO_EM_RESTART': '1', 03:28:59 INFO - 'PAGER': '/bin/cat', 03:28:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:59 INFO - 'PWD': '/builds/slave/test', 03:28:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:59 INFO - 'SHELL': '/bin/bash', 03:28:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:28:59 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:28:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:59 INFO - 'USER': 'cltbld', 03:28:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:59 INFO - 'XPC_FLAGS': '0x0', 03:28:59 INFO - 'XPC_SERVICE_NAME': '0', 03:28:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-71bVa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-eKZMrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-bXg2yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-jEhUQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4qBKXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-8Ct8LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-IbZqqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-S9MIT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:00 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)) 03:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:00 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-6oP1Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-BaFWbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-FqjLtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-u_t7j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-q1FR72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-zUb3RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-2FSE6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-TOalII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:01 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)) 03:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:01 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-QQJU1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:01 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 03:29:01 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 03:29:01 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 03:29:01 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 03:29:01 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 03:29:01 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 03:29:04 INFO - Downloading blessings-1.6.tar.gz 03:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:04 INFO - Installing collected packages: blessings 03:29:04 INFO - Running setup.py install for blessings 03:29:04 INFO - Successfully installed blessings 03:29:04 INFO - Cleaning up... 03:29:05 INFO - Return code: 0 03:29:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:05 INFO - Reading from file tmpfile_stdout 03:29:05 INFO - Current package versions: 03:29:05 INFO - blessings == 1.6 03:29:05 INFO - blobuploader == 1.2.4 03:29:05 INFO - docopt == 0.6.1 03:29:05 INFO - functools32 == 3.2.3-2 03:29:05 INFO - jsonschema == 2.5.1 03:29:05 INFO - manifestparser == 1.1 03:29:05 INFO - mozInstall == 1.12 03:29:05 INFO - mozcrash == 1.0 03:29:05 INFO - mozdebug == 0.1 03:29:05 INFO - mozdevice == 0.49 03:29:05 INFO - mozfile == 1.2 03:29:05 INFO - mozhttpd == 0.7 03:29:05 INFO - mozinfo == 0.9 03:29:05 INFO - mozleak == 0.1 03:29:05 INFO - mozlog == 3.4 03:29:05 INFO - moznetwork == 0.27 03:29:05 INFO - mozprocess == 0.25 03:29:05 INFO - mozprofile == 0.28 03:29:05 INFO - mozrunner == 6.13 03:29:05 INFO - mozscreenshot == 0.1 03:29:05 INFO - mozsystemmonitor == 0.3 03:29:05 INFO - moztest == 0.8 03:29:05 INFO - mozversion == 1.4 03:29:05 INFO - psutil == 3.1.1 03:29:05 INFO - requests == 1.2.3 03:29:05 INFO - wsgiref == 0.1.2 03:29:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:05 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 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:29:05 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 03:29:05 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 03:29:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:29:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:05 INFO - 'HOME': '/Users/cltbld', 03:29:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:05 INFO - 'LOGNAME': 'cltbld', 03:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:05 INFO - 'MOZ_NO_REMOTE': '1', 03:29:05 INFO - 'NO_EM_RESTART': '1', 03:29:05 INFO - 'PAGER': '/bin/cat', 03:29:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:05 INFO - 'PWD': '/builds/slave/test', 03:29:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:05 INFO - 'SHELL': '/bin/bash', 03:29:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:29:05 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:29:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:05 INFO - 'USER': 'cltbld', 03:29:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:05 INFO - 'XPC_FLAGS': '0x0', 03:29:05 INFO - 'XPC_SERVICE_NAME': '0', 03:29:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 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)) 03:29:05 INFO - Cleaning up... 03:29:05 INFO - Return code: 0 03:29:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105856b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105859768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef88476bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, '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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 03:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:29:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:05 INFO - 'HOME': '/Users/cltbld', 03:29:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:05 INFO - 'LOGNAME': 'cltbld', 03:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:05 INFO - 'MOZ_NO_REMOTE': '1', 03:29:05 INFO - 'NO_EM_RESTART': '1', 03:29:05 INFO - 'PAGER': '/bin/cat', 03:29:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:05 INFO - 'PWD': '/builds/slave/test', 03:29:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:05 INFO - 'SHELL': '/bin/bash', 03:29:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:29:05 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:29:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:05 INFO - 'USER': 'cltbld', 03:29:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:05 INFO - 'XPC_FLAGS': '0x0', 03:29:05 INFO - 'XPC_SERVICE_NAME': '0', 03:29:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:05 INFO - Cleaning up... 03:29:05 INFO - Return code: 0 03:29:05 INFO - Running post-action listener: _resource_record_post_action 03:29:05 INFO - Running post-action listener: _start_resource_monitoring 03:29:05 INFO - Starting resource monitoring. 03:29:05 INFO - [mozharness: 2017-04-24 10:29:05.879815Z] Finished create-virtualenv step (success) 03:29:05 INFO - [mozharness: 2017-04-24 10:29:05.880812Z] Running install step. 03:29:05 INFO - Running pre-action listener: _resource_record_pre_action 03:29:05 INFO - Running main action method: install 03:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:06 INFO - Reading from file tmpfile_stdout 03:29:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:06 INFO - Reading from file tmpfile_stdout 03:29:06 INFO - Output received: 03:29:06 INFO - Usage: mozinstall [options] installer 03:29:06 INFO - Options: 03:29:06 INFO - -h, --help show this help message and exit 03:29:06 INFO - -d DEST, --destination=DEST 03:29:06 INFO - Directory to install application into. [default: 03:29:06 INFO - "/builds/slave/test"] 03:29:06 INFO - --app=APP Application being installed. [default: firefox] 03:29:06 INFO - mkdir: /builds/slave/test/build/application 03:29:06 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'] 03:29:06 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 03:29:20 INFO - Reading from file tmpfile_stdout 03:29:20 INFO - Output received: 03:29:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:29:20 INFO - Running post-action listener: _resource_record_post_action 03:29:20 INFO - [mozharness: 2017-04-24 10:29:20.855955Z] Finished install step (success) 03:29:20 INFO - [mozharness: 2017-04-24 10:29:20.856080Z] Running run-tests step. 03:29:20 INFO - Running pre-action listener: _resource_record_pre_action 03:29:20 INFO - Running main action method: run_tests 03:29:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:20 INFO - 2017-04-24 03:29:20.870 screenresolution[1623:7352] starting screenresolution argv=screenresolution get 03:29:20 INFO - 2017-04-24 03:29:20.873 screenresolution[1623:7352] Display 0: 1600x1200x32@60 03:29:20 INFO - 2017-04-24 03:29:20.878 screenresolution[1624:7354] starting screenresolution argv=screenresolution list 03:29:20 INFO - Available Modes on Display 0 03:29:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:21 INFO - Intel Iris: 03:29:21 INFO - Chipset Model: Intel Iris 03:29:21 INFO - Type: GPU 03:29:21 INFO - Bus: Built-In 03:29:21 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:21 INFO - Vendor: Intel (0x8086) 03:29:21 INFO - Device ID: 0x0a2e 03:29:21 INFO - Revision ID: 0x0009 03:29:21 INFO - Displays: 03:29:21 INFO - Display: 03:29:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:21 INFO - Display Serial Number: 1600x1200 60 03:29:21 INFO - Main Display: Yes 03:29:21 INFO - Mirror: Off 03:29:21 INFO - Online: Yes 03:29:21 INFO - Rotation: Supported 03:29:21 INFO - Return code: 0 03:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:21 INFO - Python 2.7.3 03:29:21 INFO - Return code: 0 03:29:21 INFO - grabbing minidump binary from tooltool 03:29:21 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')]} 03:29:21 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 0x105634d30>, '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 0x10555bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105629be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:21 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 03:29:21 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 03:29:21 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 03:29:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:21 INFO - Return code: 0 03:29:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - ENV: RUST_BACKTRACE is now 1 03:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:21 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/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 03:29:21 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/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0337 --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 03:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bgjQp6rxzw/Render', 03:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:21 INFO - 'HOME': '/Users/cltbld', 03:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:21 INFO - 'LOGNAME': 'cltbld', 03:29:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:21 INFO - 'MOZ_NO_REMOTE': '1', 03:29:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:21 INFO - 'NO_EM_RESTART': '1', 03:29:21 INFO - 'PAGER': '/bin/cat', 03:29:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:21 INFO - 'PWD': '/builds/slave/test', 03:29:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:21 INFO - 'RUST_BACKTRACE': '1', 03:29:21 INFO - 'SHELL': '/bin/bash', 03:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3ymPi5XEB/Listeners', 03:29:21 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 03:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:21 INFO - 'USER': 'cltbld', 03:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:21 INFO - 'XPC_FLAGS': '0x0', 03:29:21 INFO - 'XPC_SERVICE_NAME': '0', 03:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:21 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/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 03:29:21 INFO - mozversion application_buildid: 20170424020335 03:29:21 INFO - mozversion application_changeset: e5e2984f44c5873e8b9b18b98f330acee4fada71 03:29:21 INFO - mozversion application_display_name: Firefox 03:29:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:21 INFO - mozversion application_name: Firefox 03:29:21 INFO - mozversion application_remotingname: firefox 03:29:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:29:21 INFO - mozversion application_vendor: Mozilla 03:29:21 INFO - mozversion application_version: 54.0 03:29:21 INFO - mozversion platform_buildid: 20170424020335 03:29:21 INFO - mozversion platform_changeset: e5e2984f44c5873e8b9b18b98f330acee4fada71 03:29:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:29:21 INFO - mozversion platform_version: 54.0 03:29:21 INFO - using testdate: 1493029761 03:29:21 INFO - actual date: 1493029761 03:29:21 INFO - starting webserver on 'localhost:49236' 03:29:21 INFO - SUITE-START | Running 2 tests 03:29:21 INFO - TEST-START | dromaeo_css 03:29:21 INFO - operating with platform_type : mac_ 03:29:21 INFO - Initialising browser for dromaeo_css test... 03:29:21 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpmgJeVA/profile http://localhost:49236/getInfo.html) 03:29:23 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 03:29:23 INFO - PROCESS | 1634 | colorDepth:24 03:29:23 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 03:29:23 INFO - PROCESS | 1634 | __metrics 03:29:24 INFO - PROCESS | 1634 | 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" 03:29:24 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:24 INFO - TEST-INFO | 1634: exit 0 03:29:24 INFO - Browser initialized. 03:29:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:24 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpmgJeVA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:36 INFO - PROCESS | 1637 | RSS: Main: 165244928 03:29:36 INFO - PROCESS | 1637 | 03:32:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 03:32:42 INFO - PROCESS | 1637 | RSS: Main: 352538624 03:32:42 INFO - PROCESS | 1637 | 03:35:44 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 03:35:45 INFO - PROCESS | 1637 | RSS: Main: 306241536 03:35:45 INFO - PROCESS | 1637 | 03:38:47 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 03:38:48 INFO - PROCESS | 1637 | RSS: Main: 299126784 03:38:48 INFO - PROCESS | 1637 | 03:41:51 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 03:41:51 INFO - PROCESS | 1637 | RSS: Main: 275619840 03:41:51 INFO - PROCESS | 1637 | 03:44:55 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 03:44:56 INFO - PROCESS | 1637 | RSS: Main: 272236544 03:44:56 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 03:47:59 INFO - PROCESS | 1637 | RSS: Main: 448688128 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | __start_tp_report 03:47:59 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 03:47:59 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 03:47:59 INFO - PROCESS | 1637 | |i|pagename|runs| 03:47:59 INFO - PROCESS | 1637 | |0;dojo.html;3454.1019334972907;3480.1125712943194;3510.842012109455;3548.8757893473735;3551.9822400887992;5190.455002224769;5557.444255574445;5884.440978107078;5889.8822023559505;5952.345242023374;5875.618084824483;5924.6445213287125;5934.347221805598;5959.523238140949;5964.045752679572;5336.519713225809;5353.304070470834;5354.170103633943;5402.189671549279;5460.672359658433;5243.790248390079;5255.763490642911;5256.553192978582;5464.672119672812;5465.72671366432;5359.035373632744;5360.678359298455;5364.597655175858;5370.731463426832;5373.570114390859;5412.91880621791;5428.972855135718;5451.991381594417;5460.235567020621;5482.314710661148;5318.44156363584;5397.568194544427;5405.108157154064;5406.756695948692;5462.754176062087;5701.344345400249;5716.428357164292;5742.856428589319;5962.880742385171;5993.6104153230335;6299.622022678654;6332.588381755171;6351.174347334817;6351.364863513658;6361.713722882435;5571.888562228733;6357.618542887441;6365.8408539786415;6370.012648039561;6374.681265936684;5840.678762668009;6043.7280322385595;6055;6097.420745029215;6106.78626248088;6315.936840631627;6325.620462772248;6342.873142537123;6349.492040636738;6373.490120790326;6339.144215530937;6363.172787537591;6366;6373.840653983688;6375.904361434582;6295.937040629535;6361;6373.52198585108;6383.6488993104895;6403.359664033559;6197.03945888388;6324;6356.77751278703;6361.713722882481;6362;6299.6850157491945;6303.558750887394;6313.40022697843;6346.428821406095;6369.490440764727;4594.977025114853;4829.613630909519;5075.56857667095;5088.949110508847;5119.283300337956;4502.369668246448;4559.042601053749;4564.726116433025;4567.2464043432465;4585.28928016158;5896.174535565025;5936.22829032223;5981.132735753292;6009;6019.247594050744;5493.258410114663;6299.149614802035;6317.778877739349;6336.968315158395;6389.744410223539;6134.069235337315;6166;6167.444929956236;6176.042713379434;6187.504999600022;5533.363663178786;5549.750261238254;5595.916061259084;5604.775808967677;5625.099984002622;6343;6379.585326953733;6401.583897046677;6596.73613055482;6615.636140012345;6308.936910631019;6311.463525600376;6315.431611155018;6327.114204011534;6342.809715708536;6357.841053973688;6414.326495717883;6514.250861151028;6529.412352888073;6571.57284776488;5225.346831646044;6303.991361382157;6316.368363163647;6326.715297811517;6337.271213810471;5458.7444887675265;5909.6158749681135;5911.113333000085;6349.523785716182;6349.682515874096;5224.425313215467;6108.72510737009;6198.721057552511;6221.06683997404;6299.464545513682;6262.3111457738705;6281.560290779602;6293.496520278458;6297.590656607306;6301.936980630135;6198.752049917953;6229.937700622936;6248.312685604671;6270.184875966095;6276.184096067482;6142.938570614416;6282.057691346335;6301.180846489927;6319.273283572448;6330.272018717907;6107.811218530279;6116.5106791457465;6117.571769976059;6120.632762034292;6143.972489078683 03:47:59 INFO - PROCESS | 1637 | |1;ext.html;717.6017310392732;773.9535627862325;828.9917100828992;896.3053633434083;899.5547204133954;29632.851835740847;41185.79407102964;41833;41859.74420767374;41924.95187620311;42838.57161428385;43077;43113.35329970045;43158;43235.78382108085;7974.880376794353;9191.126842949925;9308;9335.719928402159;9337.766555836124;7980;11581.768364632702;11724.882751172507;12015.759684806299;12023.15837891348;11742.882571174265;11827.645170644895;11839.171258011942;11844.11169162312;11881.821772673416;11759.529618815237;11785.528578856836;11802.350870702108;11811.291322520676;11861.406929653484;11534.307941523535;11536.365499897502;11576.189666723332;11591.24656897299;11604.187706860523;40420;40640.18719625591;40773.79613101945;40778.980525486804;40809.387859182134;3392.8812491562676;3957.406389041638;3973.5231772187235;4040.0909795296116;4075.5924407559305;28499.430011399654;28664.42671146586;28810;30053.849730751208;30146.84926575353;2747.244507760362;3169.556262123305;3213.4697774867354;3345.9498107528407;3421.26442814796;370695;371011;371033.9999999973;371824;371925;53055;53288;53336.73331633317;53344.46655533473;53357;55183;55395;55474;55515;55624.721876391166;15304.770428443582;15411.460598878986;15433.614159646098;15437.536873893801;15450.922745386426;11592;13301.201927884164;13317.267550284827;13327.133736307303;13337.53318633843;10977.176711746652;11061;12020.759584808255;12332.876671233353;12527.874721252852;5267.9736601316745;5350.839474815762;5370.3287089113865;5395.78416863321;5405.459454054563;1149.6780901347636;1151.2862025544048;1153.9249948753304;1156.930584164936;1197.706561892342;27330.5900411494;27451.862740686167;27871;27990;28137;1256.497401039573;1266.2845492296822;1273.40150129439;1301.9739605207842;1322.490841026212;13528.053036287365;14177.645558860904;14244.717975382266;14455.855441445661;14557.417703291962;473189;473228;473250;475514;525230;51011.23483147756;51404;51505.48494515082;51576.74211628918;51636;1411.9717605648034;1451.7096580683906;1458.2854401343266;1459.058907004976;1463.436576917873;24636.891339890106;27263.59104613472;27921.860390697915;28327.43345133127;28452.28869278202;42108.15783684248;42430.57569424266;42488.78755606202;42519.14961700811;42575;471408;472934;473985;474570;474604;29608.259793505335;30341;30388.69611303947;30409.543856842607;30436.84781576078;38739;39697.88609650369;39822;39855.80072099621;40376.79811600923;24047.879760601085;27282.77227524806;28787.136385908456;29189.270268243465;29340.97306594259;27592.586111207947;27753.44493110167;28507.572386413805;28617.28456788597;28859.42281154407;32991.340173195924;33362;33656.49515257224;33729.83135084309;33745.493817592265;26915.59626605642;28155.155345339674;29127.563086553295;29205.561916570845;29357.119286421443;20637.793622063586;21221.469463263544;22585.548289034457;22834.885825570767;23268.836558171686 03:47:59 INFO - PROCESS | 1637 | |2;jquery.html;398.4083635800837;411.8146833924733;428.77060772486726;437.23483903169455;442.9269170586852;19785.505362365948;20571.971401429924;21611;22172.667409988862;22325.888370558165;22718.318450446473;23982.52034959304;24038.759612403872;24057.639135412985;24299.878500607516;6676.799696009115;6893.4140598049225;7015.859682806341;7019.227884932653;7029.22678505364;6629.171353580802;6786.457083433338;6846.281140480252;6877.2091209511045;6888.448924086061;6867.484938629623;6867.965660171692;7278.563286202819;7568.470207085506;7778.922210777876;7470.85058298831;7671.654775535114;7720.420968427362;7775.494592851474;7790.571518566477;7472.813179670497;7475.6262186890435;7480.326770590618;7482.4762266641355;7500.549967001943;26704.73295267042;27110;27321.726782732316;27652.723472765218;27818.887244510195;3407.6592340765974;3424.109731469811;3433.399155147864;3434.4676575130893;3491.6857482826667;16417.507474775775;16433.1552933674;16510.42213522533;16960.08627834747;16960.406385776438;1979.7624285085737;2070.4823794051485;2071.730675012239;2076.584683063393;2086.175960495611;166815;169156;184332.07833960745;184410;190392.9999999986;16038.71690264776;18620;20061.197552097754;20377.796222037887;20759.896200518902;32626.347473050406;33136.3372732544;33138.84014059496;33222.50166247508;33227.83386083054;8106.675732970615;8576.013758417737;10288.794224115476;10549.20880933933;10748.623798167027;8785.692500762443;8808.647654093893;8821.426607270507;8973.910260897308;8980;9235;9554.092361225672;9629.677761172385;9632.518374081268;9635.421874687541;3161.2887100402227;3227.5481432599454;3242.7567932405163;3751.9494541528416;3768.5854555998817;921.9585118669676;944.2776276148752;947.928905332089;955.4124213608719;964.2141654551518;18302.542436439195;21215;21621.67567486489;22569;22680.432989175402;922.8338898998111;954.289054654287;956.4596003258137;961.6634178037771;968.6028728221395;11286.435678216056;11481.942590286995;11561.595344162914;11625.24435911663;11725.76548469043;764991;782694;785093.0745346237;792259;802529;165124;166462;167672;168465.3153468474;172268;1214.5870404062662;1244.2658831289582;1273.6624794429483;1273.9554115605908;1275.5408053100875;18600.627987440446;18601.44195674132;18920.7161892569;18954.526136846136;19048.52378690544;60403;65317.67341163264;65814.67092664506;66735.33264667485;67851.66074169795;79684.40631187228;94467;94661;96057.51971240099;98037.50981245049;11449.255798373079;11557.479913404086;11923.880761192277;11934.150206717972;11958.760824783281;12726.918211952088;12796.912262457796;12993.870061299644;13381.464741410624;13461.326933653474;11217.33081586021;11669;11669.416529173677;11742.882571174521;11772.352520611106;10412.531436085546;10588.1000114988;10640.148788097089;10654.786904261717;11045.171612128961;10906.291091079054;11560.364179969845;11676.649700508999;11909;12056;11541.538338466367;11584.710382240512;11884.881151188378;11895.583654572049;11907.404629768651;11394.03150732197;11406.258593191416;11676.532938682698;11751.412429378326;11865.991390731884 03:47:59 INFO - PROCESS | 1637 | |3;mootools.html;1379.0484565649708;1621.8378162183783;1622.8377162283773;1638.7132251855926;1648.925798339074;9366.203872670823;9775.36460130092;11032.613858514944;11124.49939752711;11486.483108260127;11149.331040137597;11251.987321141096;11253.324800511975;11255.831162532568;11265.549378024889;2066.3387715930908;2130.7336582927132;2434.9878250608767;2506.1228570000444;2511.3721569607596;2110.683397490381;2189.9452513687124;2441.4872876695913;2517.710463296726;2532.8860201290986;2467.259822053386;2472.431340791619;2503.7621425964503;2505.837120587156;2508.79929605632;2245.259064508708;2248.830608083804;2489.141246270034;2496.9250922472356;2502.4995000999784;2424.3024926904104;2430.611102223636;2452.092725691488;2459.95080098397;2476.6656501372263;11434.714132146679;11473;11486.885131148665;11507.136964727679;11508;5045.445001049881;5890.882182356372;6028.336882942873;6052.243469566304;6067.211262535886;2876.3384421582946;3582.283543291352;3682.1899182180146;3791.1280405506614;3808.390657494815;1053.3574519543072;1065.978680426395;1125.9887401125966;1239.4298622633598;1290.6450726050412;15409.383624655;15561.688766224612;15603.92198039014;15614.375424982987;15617.531474055797;4272.380504826845;4860.4896485869185;5026.396832380138;5105.412877519058;5140.897182056338;12898.355082246038;12918.289494077915;12940.547080852126;12941.611751647466;12996.415161317764;6126.693665316717;6135.815925522242;6138.478229350466;6155.261368635793;6156.107364432221;4708.95291047092;5330.840074797762;5509.173623956439;5556.16657501378;5615;3819.121602031493;3923.4507168996365;4160.231901441875;4203.726757760735;4266.338717498793;1177.4819079604947;1178.2400351773058;1181.6455063481094;1198.4906414773686;1198.7602479504135;960.2462067277294;982.0915653020927;989.4162444157981;1003.1122456625793;1003.372891942536;6101.267847858286;6719.496037797185;6770.627615481196;6778.288279730557;7101.431885449152;1042.4006196437078;1062.0653824634426;1087.7008822573855;1101.5208384352832;1136.4772204785727;4228.725132866415;4360.084382279757;4372.322290045048;4478.977605111953;4488.3940668010055;13527.45890164402;13845.861541384658;13941.163530188018;13956.581302560939;13989.860101398855;12973.740525189443;13450.663733406744;13726.176429414267;13735.725285494234;13744.381502832397;10352.896471035343;10605.939406059486;10607.41659208751;10611.204159688054;10639.41483218415;6722.193336799615;7000.439964802702;7159.248278930846;7190.137183538009;7248.782536523912;12342.938285308515;12480;12484.937575312066;12746.49014039428;12770.87229127734;12801.679958001125;12868.034897382546;13014.15407998477;13049.412776424893;13073.738525229632;9320.813583728423;9365;9417.811643767223;9449.905500944902;9485.241180705665;9210.493422861538;9446.763830904283;9585;10325.896741032793;10596.947015264874;8847.330873799865;8980.203210425248;8999.460032398078;9097.363184577016;9221.492817894812;8765.693200737944;8784.341174412073;8843.955780221058;8850.73447796567;8856.335774816785;8034.87947680797;8225.629846656795;8233.917660823554;8239.134890836376;8247.587620619064;5751.712414379181;5944.791932282349;5998.1002849572915;6173.32093469709;6200.596961197508;5984.491318237999;6041.848953776191;6123.357047509948;6206.844828879314;6287.434130928055 03:47:59 INFO - PROCESS | 1637 | |4;prototype.html;384.85567912032985;390.61524398467486;391.2780919204067;393.8306528192876;397.21549938870714;4221.915561688765;4598.218302888508;4637.628989680826;4879.146149423855;4894;3687.547780725814;4563.634909207264;4611.7232966021975;4720.362751028611;4873.5126487351245;3168.8732450701946;3799.164183879542;3817.6256547642824;3934.2721596504593;4295.334223195409;3464.297847678802;3474.0817713120973;4099.754014759124;4129.359949207863;4163.604457576525;3367.646397128303;3585.4980302757504;4120.072983578686;4121.9175616487655;4163.417901197541;3685.4202058559117;3813.6820965759966;3835.463035175078;4127.8968025799295;4178.600168943392;3561.6972557332656;3769.8869033929027;3802.7147963902817;3807.8857634271017;3821.9044523887123;4373.059792144672;4581.381513495702;4751.548602882721;4787.976060119712;4793.9280910786365;4334.393184954109;4714.96270820419;4731.716097034189;4748.907751217205;4813.807447702087;4655.930161047587;4890.902181956377;5225.372955245357;5262.552683021948;5263.31576895005;4244.427002354673;4249.681273904439;4277.802215379698;4287.834643505041;4314.985978295098;4744.864810835138;4951.113375999859;5113.744312784346;5212.50481204285;5253.9737301313635;3732.9813350933614;3750.362438385481;3884.6698030667144;4142.730722503027;4174.603412675791;4165.937510937339;4361.847335343247;4384.583464570861;4385.539518350591;4405.40527028847;4137.40007698882;4383.057642606855;4749.691270067435;4751.885410992145;4788.084766093591;4394.538573449806;4878.707277563358;5089.607884294376;5236.062656817002;5244.190754189798;1204.2112416367293;1335.8196643453205;1350.9459621615026;1402.978955315671;1487.367868655817;1066.2855886556026;1118.0999295566985;1139.225326777799;1144.8969592736528;1146.4267866066966;4679.27471241958;4767.9736112152195;4891.04624598207;4952.430470495867;4954.653174277766;5392.676439413648;5401.082615671458;5425.945740542623;5442.8911421771345;5481.397046324901;4140.3168477200925;4595.954800113917;4930.802767889316;4949.727764972889;5039.924401133986;2468.4939587384542;2791.7906157038306;2798.3769413739983;2819.5488721804822;2842.8436435995804;5207.750139966381;5244.554212891947;5330.600204984642;5552.444755524415;5573.164025396223;4944.629152813553;5303.121128561733;5530.861728456821;5578.693171875505;5580.493266817936;5129.74351282427;5346.117890548016;5370.865728356823;5415.48552887475;5440.727963601804;4833.830815921426;4862.95137048625;5208.713520756395;5257.684538927677;5378.946210538001;5157.6647517911215;5162.09663308912;5313.654612450178;5315.468453154654;5398.946010539844;5314.813981510629;5600;5603.775848966159;5665.745041473226;5720.799772007959;4299.656027517729;4329.523752387172;4348.651917905459;4348.826046958086;4372;5412.702301373462;5419.864503387447;5446.945530544644;5456.48163424474;5478.287822583039;4607.709841244457;4646.303054541846;5016.849494515171;5182.134431604694;5275.44141091578;4405.493368262562;4779.510957001339;4879.7786368585275;4897.795991803774;5201.6098792591465;4592.15045216636;4849.739067842457;4854;5140.30605868203;5155.948440515547;4699.600533954652;4832.323474713473;5200.349956255468;5277.894442111213;5279.46895400345;4901.3383193268455;4947.356843610308;5136.563392111712;5143.742812859267;5171.069207542679 03:47:59 INFO - PROCESS | 1637 | |5;yui.html;783.025133708533;801.2908575910321;842.2293601354761;892.5135800988463;896.6010125494155;15545.378184872605;16833.32666693331;16921.576960575992;17250.223739931702;17288.394906178288;15464.536063918073;15906.920465397685;16155.596110097253;16189.676206475864;16195.514134575953;982.7002764156947;994.2940512236321;995.7261753017906;999.7200783780517;999.9350042247268;988.3822610868208;1004.1414590525105;1033.0495943731746;1042.5360714482058;1043.5095505112622;1049.9160067194607;1053.826118690419;1055.3034996902047;1055.9102476289524;1056.4717641179411;1047.0942634621;1047.8218702820463;1047.8375851742992;1048.905598496135;1049.8477720730489;786.2020049649553;787.2167193642306;787.4487858499074;789.3961119743401;789.9131095579539;15859.286332115082;16048.679026419406;16106.677866442606;17189.226484808212;17314.220860061327;14476.348564314525;14722.926385368111;14763.33564989578;14984.850151498455;15285;11586.362750048744;11750.764984700343;11984.460699268553;12121.818172727417;12514.687132821662;3879.534455865314;3931.5871833457363;3939.8424063037446;4109.260333140033;4110.794460276974;120666.39666801697;120981;121342.39328803388;123570;123892.38053809764;11275.041621462267;11384.65846024604;11655;11706;11730.302030532854;23442.53114937692;24223.456537063706;24255.393615159763;24292.271231863073;24307.392315191908;6997.335253150943;7022.92977070233;7058.364747172676;7074.3633073023675;7167.677454514559;4499.775011249424;4542.409486766699;4567.680262381601;4673.766311684402;4676.883077923011;3573.8213089345427;3699.648533389324;3770.057485628593;3775.4903088083306;3781.6596506314563;672.4788289075907;674.6120980436269;676.9898451523231;686.2725510958301;693.4071368979551;708.3907839258234;724.1744411371042;739.4232498651061;748.3227678950558;804.2761514636874;8507.829843403097;10753.731156720987;10891.509882055327;10923.945380273048;11269.380184089954;655.570601256178;685.0512040823495;711.3171355498675;720.7693538067768;722.989155162673;5140.691558506502;5310.336207974004;5316.441773613792;5326.493983071679;5332.840014799563;78880;92548;102639.48680256552;102957.48521257346;105135.4743226279;59587.70206148941;60425.39574604198;64839.81281497469;84941.30117397617;88220.5588972051;75086;76600;76873;77672.83490747643;78727.4254514918;8701.608427620899;11236.606718765132;11274.154438417316;11363.147763917574;11490.885091149315;50640.987180256925;50851;51369;51822;52551.737241313545;63960.68019659872;64153.396165096245;64309.35690643221;66813.33186668072;67051.65896682137;12724.554640587905;13112.73774524485;13145.34273286351;13261.469541218243;13289.734205315646;14589.270536473347;14757.483488077865;14799;15109.47116850905;15121.773173402187;13757.724845502833;13808.447662093806;14275.286235688382;14278.500252491112;14285.42858285657;13313.400896959467;14181.645458863612;14186.29068546548;14306;14462.421503139756;13227.470901163846;13647.38586763618;13668.93165534166;14156.604008465081;14360.281985900454;9654.903450965401;10330.48347582633;10383.2212584055;10386.324888882198;10519.421431821323;9942.652007179713;10780.113480140788;11202.215844891105;11603;11611.245269057485 03:47:59 INFO - PROCESS | 1637 | __end_tp_report 03:47:59 INFO - PROCESS | 1637 | __start_cc_report 03:47:59 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1894 03:47:59 INFO - PROCESS | 1637 | __end_cc_report 03:47:59 INFO - PROCESS | 1637 | __startTimestamp1493030879394__endTimestamp 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | ------- Summary: start ------- 03:47:59 INFO - PROCESS | 1637 | Number of tests: 6 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5874.67 Median:6134.07 stddev:643.15 (10.5%) stddev-sans-first:616.46 03:47:59 INFO - PROCESS | 1637 | Values: 3454.1 3480.1 3510.8 3548.9 3552.0 5190.5 5557.4 5884.4 5889.9 5952.3 5875.6 5924.6 5934.3 5959.5 5964.0 5336.5 5353.3 5354.2 5402.2 5460.7 5243.8 5255.8 5256.6 5464.7 5465.7 5359.0 5360.7 5364.6 5370.7 5373.6 5412.9 5429.0 5452.0 5460.2 5482.3 5318.4 5397.6 5405.1 5406.8 5462.8 5701.3 5716.4 5742.9 5962.9 5993.6 6299.6 6332.6 6351.2 6351.4 6361.7 5571.9 6357.6 6365.8 6370.0 6374.7 5840.7 6043.7 6055.0 6097.4 6106.8 6315.9 6325.6 6342.9 6349.5 6373.5 6339.1 6363.2 6366.0 6373.8 6375.9 6295.9 6361.0 6373.5 6383.6 6403.4 6197.0 6324.0 6356.8 6361.7 6362.0 6299.7 6303.6 6313.4 6346.4 6369.5 4595.0 4829.6 5075.6 5088.9 5119.3 4502.4 4559.0 4564.7 4567.2 4585.3 5896.2 5936.2 5981.1 6009.0 6019.2 5493.3 6299.1 6317.8 6337.0 6389.7 6134.1 6166.0 6167.4 6176.0 6187.5 5533.4 5549.8 5595.9 5604.8 5625.1 6343.0 6379.6 6401.6 6596.7 6615.6 6308.9 6311.5 6315.4 6327.1 6342.8 6357.8 6414.3 6514.3 6529.4 6571.6 5225.3 6304.0 6316.4 6326.7 6337.3 5458.7 5909.6 5911.1 6349.5 6349.7 5224.4 6108.7 6198.7 6221.1 6299.5 6262.3 6281.6 6293.5 6297.6 6301.9 6198.8 6229.9 6248.3 6270.2 6276.2 6142.9 6282.1 6301.2 6319.3 6330.3 6107.8 6116.5 6117.6 6120.6 6144.0 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:57658.35 Median:30100.35 stddev:118518.63 (393.7%) stddev-sans-first:118774.00 03:47:59 INFO - PROCESS | 1637 | Values: 717.6 774.0 829.0 896.3 899.6 29632.9 41185.8 41833.0 41859.7 41925.0 42838.6 43077.0 43113.4 43158.0 43235.8 7974.9 9191.1 9308.0 9335.7 9337.8 7980.0 11581.8 11724.9 12015.8 12023.2 11742.9 11827.6 11839.2 11844.1 11881.8 11759.5 11785.5 11802.4 11811.3 11861.4 11534.3 11536.4 11576.2 11591.2 11604.2 40420.0 40640.2 40773.8 40779.0 40809.4 3392.9 3957.4 3973.5 4040.1 4075.6 28499.4 28664.4 28810.0 30053.8 30146.8 2747.2 3169.6 3213.5 3345.9 3421.3 370695.0 371011.0 371034.0 371824.0 371925.0 53055.0 53288.0 53336.7 53344.5 53357.0 55183.0 55395.0 55474.0 55515.0 55624.7 15304.8 15411.5 15433.6 15437.5 15450.9 11592.0 13301.2 13317.3 13327.1 13337.5 10977.2 11061.0 12020.8 12332.9 12527.9 5268.0 5350.8 5370.3 5395.8 5405.5 1149.7 1151.3 1153.9 1156.9 1197.7 27330.6 27451.9 27871.0 27990.0 28137.0 1256.5 1266.3 1273.4 1302.0 1322.5 13528.1 14177.6 14244.7 14455.9 14557.4 473189.0 473228.0 473250.0 475514.0 525230.0 51011.2 51404.0 51505.5 51576.7 51636.0 1412.0 1451.7 1458.3 1459.1 1463.4 24636.9 27263.6 27921.9 28327.4 28452.3 42108.2 42430.6 42488.8 42519.1 42575.0 471408.0 472934.0 473985.0 474570.0 474604.0 29608.3 30341.0 30388.7 30409.5 30436.8 38739.0 39697.9 39822.0 39855.8 40376.8 24047.9 27282.8 28787.1 29189.3 29341.0 27592.6 27753.4 28507.6 28617.3 28859.4 32991.3 33362.0 33656.5 33729.8 33745.5 26915.6 28155.2 29127.6 29205.6 29357.1 20637.8 21221.5 22585.5 22834.9 23268.8 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:45616.01 Median:24048.20 stddev:131757.79 (547.9%) stddev-sans-first:132083.66 03:47:59 INFO - PROCESS | 1637 | Values: 398.4 411.8 428.8 437.2 442.9 19785.5 20572.0 21611.0 22172.7 22325.9 22718.3 23982.5 24038.8 24057.6 24299.9 6676.8 6893.4 7015.9 7019.2 7029.2 6629.2 6786.5 6846.3 6877.2 6888.4 6867.5 6868.0 7278.6 7568.5 7778.9 7470.9 7671.7 7720.4 7775.5 7790.6 7472.8 7475.6 7480.3 7482.5 7500.5 26704.7 27110.0 27321.7 27652.7 27818.9 3407.7 3424.1 3433.4 3434.5 3491.7 16417.5 16433.2 16510.4 16960.1 16960.4 1979.8 2070.5 2071.7 2076.6 2086.2 166815.0 169156.0 184332.1 184410.0 190393.0 16038.7 18620.0 20061.2 20377.8 20759.9 32626.3 33136.3 33138.8 33222.5 33227.8 8106.7 8576.0 10288.8 10549.2 10748.6 8785.7 8808.6 8821.4 8973.9 8980.0 9235.0 9554.1 9629.7 9632.5 9635.4 3161.3 3227.5 3242.8 3751.9 3768.6 922.0 944.3 947.9 955.4 964.2 18302.5 21215.0 21621.7 22569.0 22680.4 922.8 954.3 956.5 961.7 968.6 11286.4 11481.9 11561.6 11625.2 11725.8 764991.0 782694.0 785093.1 792259.0 802529.0 165124.0 166462.0 167672.0 168465.3 172268.0 1214.6 1244.3 1273.7 1274.0 1275.5 18600.6 18601.4 18920.7 18954.5 19048.5 60403.0 65317.7 65814.7 66735.3 67851.7 79684.4 94467.0 94661.0 96057.5 98037.5 11449.3 11557.5 11923.9 11934.2 11958.8 12726.9 12796.9 12993.9 13381.5 13461.3 11217.3 11669.0 11669.4 11742.9 11772.4 10412.5 10588.1 10640.1 10654.8 11045.2 10906.3 11560.4 11676.6 11909.0 12056.0 11541.5 11584.7 11884.9 11895.6 11907.4 11394.0 11406.3 11676.5 11751.4 11866.0 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6906.84 Median:2504.80 stddev:4309.51 (172.0%) stddev-sans-first:4301.58 03:47:59 INFO - PROCESS | 1637 | Values: 1379.0 1621.8 1622.8 1638.7 1648.9 9366.2 9775.4 11032.6 11124.5 11486.5 11149.3 11252.0 11253.3 11255.8 11265.5 2066.3 2130.7 2435.0 2506.1 2511.4 2110.7 2189.9 2441.5 2517.7 2532.9 2467.3 2472.4 2503.8 2505.8 2508.8 2245.3 2248.8 2489.1 2496.9 2502.5 2424.3 2430.6 2452.1 2460.0 2476.7 11434.7 11473.0 11486.9 11507.1 11508.0 5045.4 5890.9 6028.3 6052.2 6067.2 2876.3 3582.3 3682.2 3791.1 3808.4 1053.4 1066.0 1126.0 1239.4 1290.6 15409.4 15561.7 15603.9 15614.4 15617.5 4272.4 4860.5 5026.4 5105.4 5140.9 12898.4 12918.3 12940.5 12941.6 12996.4 6126.7 6135.8 6138.5 6155.3 6156.1 4709.0 5330.8 5509.2 5556.2 5615.0 3819.1 3923.5 4160.2 4203.7 4266.3 1177.5 1178.2 1181.6 1198.5 1198.8 960.2 982.1 989.4 1003.1 1003.4 6101.3 6719.5 6770.6 6778.3 7101.4 1042.4 1062.1 1087.7 1101.5 1136.5 4228.7 4360.1 4372.3 4479.0 4488.4 13527.5 13845.9 13941.2 13956.6 13989.9 12973.7 13450.7 13726.2 13735.7 13744.4 10352.9 10605.9 10607.4 10611.2 10639.4 6722.2 7000.4 7159.2 7190.1 7248.8 12342.9 12480.0 12484.9 12746.5 12770.9 12801.7 12868.0 13014.2 13049.4 13073.7 9320.8 9365.0 9417.8 9449.9 9485.2 9210.5 9446.8 9585.0 10325.9 10596.9 8847.3 8980.2 8999.5 9097.4 9221.5 8765.7 8784.3 8844.0 8850.7 8856.3 8034.9 8225.6 8233.9 8239.1 8247.6 5751.7 5944.8 5998.1 6173.3 6200.6 5984.5 6041.8 6123.4 6206.8 6287.4 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4365.96 Median:4749.30 stddev:1218.07 (25.6%) stddev-sans-first:1184.27 03:47:59 INFO - PROCESS | 1637 | Values: 384.9 390.6 391.3 393.8 397.2 4221.9 4598.2 4637.6 4879.1 4894.0 3687.5 4563.6 4611.7 4720.4 4873.5 3168.9 3799.2 3817.6 3934.3 4295.3 3464.3 3474.1 4099.8 4129.4 4163.6 3367.6 3585.5 4120.1 4121.9 4163.4 3685.4 3813.7 3835.5 4127.9 4178.6 3561.7 3769.9 3802.7 3807.9 3821.9 4373.1 4581.4 4751.5 4788.0 4793.9 4334.4 4715.0 4731.7 4748.9 4813.8 4655.9 4890.9 5225.4 5262.6 5263.3 4244.4 4249.7 4277.8 4287.8 4315.0 4744.9 4951.1 5113.7 5212.5 5254.0 3733.0 3750.4 3884.7 4142.7 4174.6 4165.9 4361.8 4384.6 4385.5 4405.4 4137.4 4383.1 4749.7 4751.9 4788.1 4394.5 4878.7 5089.6 5236.1 5244.2 1204.2 1335.8 1350.9 1403.0 1487.4 1066.3 1118.1 1139.2 1144.9 1146.4 4679.3 4768.0 4891.0 4952.4 4954.7 5392.7 5401.1 5425.9 5442.9 5481.4 4140.3 4596.0 4930.8 4949.7 5039.9 2468.5 2791.8 2798.4 2819.5 2842.8 5207.8 5244.6 5330.6 5552.4 5573.2 4944.6 5303.1 5530.9 5578.7 5580.5 5129.7 5346.1 5370.9 5415.5 5440.7 4833.8 4863.0 5208.7 5257.7 5378.9 5157.7 5162.1 5313.7 5315.5 5398.9 5314.8 5600.0 5603.8 5665.7 5720.8 4299.7 4329.5 4348.7 4348.8 4372.0 5412.7 5419.9 5446.9 5456.5 5478.3 4607.7 4646.3 5016.8 5182.1 5275.4 4405.5 4779.5 4879.8 4897.8 5201.6 4592.2 4849.7 4854.0 5140.3 5155.9 4699.6 4832.3 5200.3 5277.9 5279.5 4901.3 4947.4 5136.6 5143.7 5171.1 03:47:59 INFO - PROCESS | 1637 | 03:47:59 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20573.06 Median:17269.31 stddev:29257.77 (169.4%) stddev-sans-first:29302.11 03:47:59 INFO - PROCESS | 1637 | Values: 783.0 801.3 842.2 892.5 896.6 15545.4 16833.3 16921.6 17250.2 17288.4 15464.5 15906.9 16155.6 16189.7 16195.5 982.7 994.3 995.7 999.7 999.9 988.4 1004.1 1033.0 1042.5 1043.5 1049.9 1053.8 1055.3 1055.9 1056.5 1047.1 1047.8 1047.8 1048.9 1049.8 786.2 787.2 787.4 789.4 789.9 15859.3 16048.7 16106.7 17189.2 17314.2 14476.3 14722.9 14763.3 14984.9 15285.0 11586.4 11750.8 11984.5 12121.8 12514.7 3879.5 3931.6 3939.8 4109.3 4110.8 120666.4 120981.0 121342.4 123570.0 123892.4 11275.0 11384.7 11655.0 11706.0 11730.3 23442.5 24223.5 24255.4 24292.3 24307.4 6997.3 7022.9 7058.4 7074.4 7167.7 4499.8 4542.4 4567.7 4673.8 4676.9 3573.8 3699.6 3770.1 3775.5 3781.7 672.5 674.6 677.0 686.3 693.4 708.4 724.2 739.4 748.3 804.3 8507.8 10753.7 10891.5 10923.9 11269.4 655.6 685.1 711.3 720.8 723.0 5140.7 5310.3 5316.4 5326.5 5332.8 78880.0 92548.0 102639.5 102957.5 105135.5 59587.7 60425.4 64839.8 84941.3 88220.6 75086.0 76600.0 76873.0 77672.8 78727.4 8701.6 11236.6 11274.2 11363.1 11490.9 50641.0 50851.0 51369.0 51822.0 52551.7 63960.7 64153.4 64309.4 66813.3 67051.7 12724.6 13112.7 13145.3 13261.5 13289.7 14589.3 14757.5 14799.0 15109.5 15121.8 13757.7 13808.4 14275.3 14278.5 14285.4 13313.4 14181.6 14186.3 14306.0 14462.4 13227.5 13647.4 13668.9 14156.6 14360.3 9654.9 10330.5 10383.2 10386.3 10519.4 9942.7 10780.1 11202.2 11603.0 11611.2 03:47:59 INFO - PROCESS | 1637 | -------- Summary: end -------- 03:47:59 INFO - PROCESS | 1637 | 03:48:00 INFO - TEST-INFO | 1637: exit 0 03:48:00 INFO - TEST-OK | dromaeo_css | took 1118589ms 03:48:00 INFO - TEST-START | kraken 03:48:00 INFO - operating with platform_type : mac_ 03:48:00 INFO - Initialising browser for kraken test... 03:48:00 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpgKICwu/profile http://localhost:49236/getInfo.html) 03:48:02 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 03:48:02 INFO - PROCESS | 1670 | colorDepth:24 03:48:02 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 03:48:02 INFO - PROCESS | 1670 | __metrics 03:48:02 INFO - PROCESS | 1670 | 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" 03:48:02 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:48:03 INFO - TEST-INFO | 1670: exit 0 03:48:03 INFO - Browser initialized. 03:48:03 INFO - Running cycle 1/1 for kraken test... 03:48:03 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpgKICwu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:15 INFO - PROCESS | 1672 | RSS: Main: 165675008 03:48:15 INFO - PROCESS | 1672 | 03:48:18 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:19 INFO - PROCESS | 1672 | RSS: Main: 216014848 03:48:19 INFO - PROCESS | 1672 | 03:48:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 03:48:22 INFO - PROCESS | 1672 | RSS: Main: 231272448 03:48:22 INFO - PROCESS | 1672 | 03:48:25 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 03:48:25 INFO - PROCESS | 1672 | RSS: Main: 327786496 03:48:25 INFO - PROCESS | 1672 | 03:48:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 03:48:28 INFO - PROCESS | 1672 | RSS: Main: 229359616 03:48:28 INFO - PROCESS | 1672 | 03:48:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:31 INFO - PROCESS | 1672 | RSS: Main: 230772736 03:48:31 INFO - PROCESS | 1672 | 03:48:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:34 INFO - PROCESS | 1672 | RSS: Main: 270516224 03:48:34 INFO - PROCESS | 1672 | 03:48:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:38 INFO - PROCESS | 1672 | RSS: Main: 272867328 03:48:38 INFO - PROCESS | 1672 | 03:48:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 03:48:41 INFO - PROCESS | 1672 | RSS: Main: 269012992 03:48:41 INFO - PROCESS | 1672 | 03:48:43 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:43 INFO - PROCESS | 1672 | RSS: Main: 245858304 03:48:43 INFO - PROCESS | 1672 | 03:48:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:46 INFO - PROCESS | 1672 | RSS: Main: 249700352 03:48:46 INFO - PROCESS | 1672 | 03:48:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:49 INFO - PROCESS | 1672 | RSS: Main: 253628416 03:48:49 INFO - PROCESS | 1672 | 03:48:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:52 INFO - PROCESS | 1672 | RSS: Main: 273281024 03:48:52 INFO - PROCESS | 1672 | 03:48:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:56 INFO - PROCESS | 1672 | RSS: Main: 267431936 03:48:56 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 03:48:58 INFO - PROCESS | 1672 | RSS: Main: 311975936 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | __start_tp_report 03:48:58 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 03:48:58 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 03:48:58 INFO - PROCESS | 1672 | |i|pagename|runs| 03:48:58 INFO - PROCESS | 1672 | |0;ai-astar;104;115;113;115;115;115;113;113;115;114 03:48:58 INFO - PROCESS | 1672 | |1;audio-beat-detection;137;110;138;158;109;108;105;105;127;104 03:48:58 INFO - PROCESS | 1672 | |2;audio-dft;181;183;182;185;184;186;188;181;183;188 03:48:58 INFO - PROCESS | 1672 | |3;audio-fft;82;59;61;93;64;61;63;58;74;59 03:48:58 INFO - PROCESS | 1672 | |4;audio-oscillator;89;68;85;71;70;70;80;68;68;81 03:48:58 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;87;88;87;86;87;87;87;87;88;86 03:48:58 INFO - PROCESS | 1672 | |6;imaging-darkroom;95;95;93;94;94;93;94;94;93;93 03:48:58 INFO - PROCESS | 1672 | |7;imaging-desaturate;84;85;83;84;86;83;84;85;84;84 03:48:58 INFO - PROCESS | 1672 | |8;json-parse-financial;65;59;62;59;60;63;64;63;63;63 03:48:58 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;60;57;58;63;62;57;56;57;58;57 03:48:58 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;89;95;100;100;100;80;81;80;82;84 03:48:58 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;136;135;132;135;136;138;140;141;191;125 03:48:58 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;163;163;160;160;161;161;172;160;162;161 03:48:58 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;64;65;65;64;63;64;64;66;65;73 03:48:58 INFO - PROCESS | 1672 | __end_tp_report 03:48:58 INFO - PROCESS | 1672 | __start_cc_report 03:48:58 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2168 03:48:58 INFO - PROCESS | 1672 | __end_cc_report 03:48:58 INFO - PROCESS | 1672 | __startTimestamp1493030938326__endTimestamp 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | ------- Summary: start ------- 03:48:58 INFO - PROCESS | 1672 | Number of tests: 14 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:113.20 Median:115.00 stddev:3.36 (2.9%) stddev-sans-first:0.97 03:48:58 INFO - PROCESS | 1672 | Values: 104.0 115.0 113.0 115.0 115.0 115.0 113.0 113.0 115.0 114.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:118.50 stddev:18.79 (15.9%) stddev-sans-first:18.91 03:48:58 INFO - PROCESS | 1672 | Values: 137.0 110.0 138.0 158.0 109.0 108.0 105.0 105.0 127.0 104.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:2.60 (1.4%) stddev-sans-first:2.51 03:48:58 INFO - PROCESS | 1672 | Values: 181.0 183.0 182.0 185.0 184.0 186.0 188.0 181.0 183.0 188.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:67.40 Median:63.50 stddev:11.81 (18.6%) stddev-sans-first:11.28 03:48:58 INFO - PROCESS | 1672 | Values: 82.0 59.0 61.0 93.0 64.0 61.0 63.0 58.0 74.0 59.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:75.50 stddev:7.96 (10.5%) stddev-sans-first:6.64 03:48:58 INFO - PROCESS | 1672 | Values: 89.0 68.0 85.0 71.0 70.0 70.0 80.0 68.0 68.0 81.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 03:48:58 INFO - PROCESS | 1672 | Values: 87.0 88.0 87.0 86.0 87.0 87.0 87.0 87.0 88.0 86.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 03:48:58 INFO - PROCESS | 1672 | Values: 95.0 95.0 93.0 94.0 94.0 93.0 94.0 94.0 93.0 93.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 03:48:58 INFO - PROCESS | 1672 | Values: 84.0 85.0 83.0 84.0 86.0 83.0 84.0 85.0 84.0 84.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:2.08 (3.3%) stddev-sans-first:1.92 03:48:58 INFO - PROCESS | 1672 | Values: 65.0 59.0 62.0 59.0 60.0 63.0 64.0 63.0 63.0 63.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:2.37 (4.1%) stddev-sans-first:2.45 03:48:58 INFO - PROCESS | 1672 | Values: 60.0 57.0 58.0 63.0 62.0 57.0 56.0 57.0 58.0 57.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:81.50 stddev:8.81 (10.8%) stddev-sans-first:9.35 03:48:58 INFO - PROCESS | 1672 | Values: 89.0 95.0 100.0 100.0 100.0 80.0 81.0 80.0 82.0 84.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:137.00 stddev:18.16 (13.3%) stddev-sans-first:19.18 03:48:58 INFO - PROCESS | 1672 | Values: 136.0 135.0 132.0 135.0 136.0 138.0 140.0 141.0 191.0 125.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:161.50 stddev:3.59 (2.2%) stddev-sans-first:3.80 03:48:58 INFO - PROCESS | 1672 | Values: 163.0 163.0 160.0 160.0 161.0 161.0 172.0 160.0 162.0 161.0 03:48:58 INFO - PROCESS | 1672 | 03:48:58 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.83 (4.4%) stddev-sans-first:2.96 03:48:58 INFO - PROCESS | 1672 | Values: 64.0 65.0 65.0 64.0 63.0 64.0 64.0 66.0 65.0 73.0 03:48:58 INFO - PROCESS | 1672 | -------- Summary: end -------- 03:48:58 INFO - PROCESS | 1672 | 03:48:59 INFO - TEST-INFO | 1672: exit 0 03:48:59 INFO - TEST-OK | kraken | took 59135ms 03:48:59 INFO - SUITE-END | took 1177s 03:48:59 INFO - Completed test suite (00:19:37) 03:48:59 INFO - javascript benchmark 03:48:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7779.426663690491, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3454.1019334972907, 3480.1125712943194, 3510.842012109455, 3548.8757893473735, 3551.9822400887992, 5190.455002224769, 5557.444255574445, 5884.440978107078, 5889.8822023559505, 5952.345242023374, 5875.618084824483, 5924.6445213287125, 5934.347221805598, 5959.523238140949, 5964.045752679572, 5336.519713225809, 5353.304070470834, 5354.170103633943, 5402.189671549279, 5460.672359658433, 5243.790248390079, 5255.763490642911, 5256.553192978582, 5464.672119672812, 5465.72671366432, 5359.035373632744, 5360.678359298455, 5364.597655175858, 5370.731463426832, 5373.570114390859, 5412.91880621791, 5428.972855135718, 5451.991381594417, 5460.235567020621, 5482.314710661148, 5318.44156363584, 5397.568194544427, 5405.108157154064, 5406.756695948692, 5462.754176062087, 5701.344345400249, 5716.428357164292, 5742.856428589319, 5962.880742385171, 5993.6104153230335, 6299.622022678654, 6332.588381755171, 6351.174347334817, 6351.364863513658, 6361.713722882435, 5571.888562228733, 6357.618542887441, 6365.8408539786415, 6370.012648039561, 6374.681265936684, 5840.678762668009, 6043.7280322385595, 6055.0, 6097.420745029215, 6106.78626248088, 6315.936840631627, 6325.620462772248, 6342.873142537123, 6349.492040636738, 6373.490120790326, 6339.144215530937, 6363.172787537591, 6366.0, 6373.840653983688, 6375.904361434582, 6295.937040629535, 6361.0, 6373.52198585108, 6383.6488993104895, 6403.359664033559, 6197.03945888388, 6324.0, 6356.77751278703, 6361.713722882481, 6362.0, 6299.6850157491945, 6303.558750887394, 6313.40022697843, 6346.428821406095, 6369.490440764727, 4594.977025114853, 4829.613630909519, 5075.56857667095, 5088.949110508847, 5119.283300337956, 4502.369668246448, 4559.042601053749, 4564.726116433025, 4567.2464043432465, 4585.28928016158, 5896.174535565025, 5936.22829032223, 5981.132735753292, 6009.0, 6019.247594050744, 5493.258410114663, 6299.149614802035, 6317.778877739349, 6336.968315158395, 6389.744410223539, 6134.069235337315, 6166.0, 6167.444929956236, 6176.042713379434, 6187.504999600022, 5533.363663178786, 5549.750261238254, 5595.916061259084, 5604.775808967677, 5625.099984002622, 6343.0, 6379.585326953733, 6401.583897046677, 6596.73613055482, 6615.636140012345, 6308.936910631019, 6311.463525600376, 6315.431611155018, 6327.114204011534, 6342.809715708536, 6357.841053973688, 6414.326495717883, 6514.250861151028, 6529.412352888073, 6571.57284776488, 5225.346831646044, 6303.991361382157, 6316.368363163647, 6326.715297811517, 6337.271213810471, 5458.7444887675265, 5909.6158749681135, 5911.113333000085, 6349.523785716182, 6349.682515874096, 5224.425313215467, 6108.72510737009, 6198.721057552511, 6221.06683997404, 6299.464545513682, 6262.3111457738705, 6281.560290779602, 6293.496520278458, 6297.590656607306, 6301.936980630135, 6198.752049917953, 6229.937700622936, 6248.312685604671, 6270.184875966095, 6276.184096067482, 6142.938570614416, 6282.057691346335, 6301.180846489927, 6319.273283572448, 6330.272018717907, 6107.811218530279, 6116.5106791457465, 6117.571769976059, 6120.632762034292, 6143.972489078683], "value": 5835.597206212031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6017310392732, 773.9535627862325, 828.9917100828992, 896.3053633434083, 899.5547204133954, 29632.851835740847, 41185.79407102964, 41833.0, 41859.74420767374, 41924.95187620311, 42838.57161428385, 43077.0, 43113.35329970045, 43158.0, 43235.78382108085, 7974.880376794353, 9191.126842949925, 9308.0, 9335.719928402159, 9337.766555836124, 7980.0, 11581.768364632702, 11724.882751172507, 12015.759684806299, 12023.15837891348, 11742.882571174265, 11827.645170644895, 11839.171258011942, 11844.11169162312, 11881.821772673416, 11759.529618815237, 11785.528578856836, 11802.350870702108, 11811.291322520676, 11861.406929653484, 11534.307941523535, 11536.365499897502, 11576.189666723332, 11591.24656897299, 11604.187706860523, 40420.0, 40640.18719625591, 40773.79613101945, 40778.980525486804, 40809.387859182134, 3392.8812491562676, 3957.406389041638, 3973.5231772187235, 4040.0909795296116, 4075.5924407559305, 28499.430011399654, 28664.42671146586, 28810.0, 30053.849730751208, 30146.84926575353, 2747.244507760362, 3169.556262123305, 3213.4697774867354, 3345.9498107528407, 3421.26442814796, 370695.0, 371011.0, 371033.9999999973, 371824.0, 371925.0, 53055.0, 53288.0, 53336.73331633317, 53344.46655533473, 53357.0, 55183.0, 55395.0, 55474.0, 55515.0, 55624.721876391166, 15304.770428443582, 15411.460598878986, 15433.614159646098, 15437.536873893801, 15450.922745386426, 11592.0, 13301.201927884164, 13317.267550284827, 13327.133736307303, 13337.53318633843, 10977.176711746652, 11061.0, 12020.759584808255, 12332.876671233353, 12527.874721252852, 5267.9736601316745, 5350.839474815762, 5370.3287089113865, 5395.78416863321, 5405.459454054563, 1149.6780901347636, 1151.2862025544048, 1153.9249948753304, 1156.930584164936, 1197.706561892342, 27330.5900411494, 27451.862740686167, 27871.0, 27990.0, 28137.0, 1256.497401039573, 1266.2845492296822, 1273.40150129439, 1301.9739605207842, 1322.490841026212, 13528.053036287365, 14177.645558860904, 14244.717975382266, 14455.855441445661, 14557.417703291962, 473189.0, 473228.0, 473250.0, 475514.0, 525230.0, 51011.23483147756, 51404.0, 51505.48494515082, 51576.74211628918, 51636.0, 1411.9717605648034, 1451.7096580683906, 1458.2854401343266, 1459.058907004976, 1463.436576917873, 24636.891339890106, 27263.59104613472, 27921.860390697915, 28327.43345133127, 28452.28869278202, 42108.15783684248, 42430.57569424266, 42488.78755606202, 42519.14961700811, 42575.0, 471408.0, 472934.0, 473985.0, 474570.0, 474604.0, 29608.259793505335, 30341.0, 30388.69611303947, 30409.543856842607, 30436.84781576078, 38739.0, 39697.88609650369, 39822.0, 39855.80072099621, 40376.79811600923, 24047.879760601085, 27282.77227524806, 28787.136385908456, 29189.270268243465, 29340.97306594259, 27592.586111207947, 27753.44493110167, 28507.572386413805, 28617.28456788597, 28859.42281154407, 32991.340173195924, 33362.0, 33656.49515257224, 33729.83135084309, 33745.493817592265, 26915.59626605642, 28155.155345339674, 29127.563086553295, 29205.561916570845, 29357.119286421443, 20637.793622063586, 21221.469463263544, 22585.548289034457, 22834.885825570767, 23268.836558171686], "value": 18989.6970859852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.4083635800837, 411.8146833924733, 428.77060772486726, 437.23483903169455, 442.9269170586852, 19785.505362365948, 20571.971401429924, 21611.0, 22172.667409988862, 22325.888370558165, 22718.318450446473, 23982.52034959304, 24038.759612403872, 24057.639135412985, 24299.878500607516, 6676.799696009115, 6893.4140598049225, 7015.859682806341, 7019.227884932653, 7029.22678505364, 6629.171353580802, 6786.457083433338, 6846.281140480252, 6877.2091209511045, 6888.448924086061, 6867.484938629623, 6867.965660171692, 7278.563286202819, 7568.470207085506, 7778.922210777876, 7470.85058298831, 7671.654775535114, 7720.420968427362, 7775.494592851474, 7790.571518566477, 7472.813179670497, 7475.6262186890435, 7480.326770590618, 7482.4762266641355, 7500.549967001943, 26704.73295267042, 27110.0, 27321.726782732316, 27652.723472765218, 27818.887244510195, 3407.6592340765974, 3424.109731469811, 3433.399155147864, 3434.4676575130893, 3491.6857482826667, 16417.507474775775, 16433.1552933674, 16510.42213522533, 16960.08627834747, 16960.406385776438, 1979.7624285085737, 2070.4823794051485, 2071.730675012239, 2076.584683063393, 2086.175960495611, 166815.0, 169156.0, 184332.07833960745, 184410.0, 190392.9999999986, 16038.71690264776, 18620.0, 20061.197552097754, 20377.796222037887, 20759.896200518902, 32626.347473050406, 33136.3372732544, 33138.84014059496, 33222.50166247508, 33227.83386083054, 8106.675732970615, 8576.013758417737, 10288.794224115476, 10549.20880933933, 10748.623798167027, 8785.692500762443, 8808.647654093893, 8821.426607270507, 8973.910260897308, 8980.0, 9235.0, 9554.092361225672, 9629.677761172385, 9632.518374081268, 9635.421874687541, 3161.2887100402227, 3227.5481432599454, 3242.7567932405163, 3751.9494541528416, 3768.5854555998817, 921.9585118669676, 944.2776276148752, 947.928905332089, 955.4124213608719, 964.2141654551518, 18302.542436439195, 21215.0, 21621.67567486489, 22569.0, 22680.432989175402, 922.8338898998111, 954.289054654287, 956.4596003258137, 961.6634178037771, 968.6028728221395, 11286.435678216056, 11481.942590286995, 11561.595344162914, 11625.24435911663, 11725.76548469043, 764991.0, 782694.0, 785093.0745346237, 792259.0, 802529.0, 165124.0, 166462.0, 167672.0, 168465.3153468474, 172268.0, 1214.5870404062662, 1244.2658831289582, 1273.6624794429483, 1273.9554115605908, 1275.5408053100875, 18600.627987440446, 18601.44195674132, 18920.7161892569, 18954.526136846136, 19048.52378690544, 60403.0, 65317.67341163264, 65814.67092664506, 66735.33264667485, 67851.66074169795, 79684.40631187228, 94467.0, 94661.0, 96057.51971240099, 98037.50981245049, 11449.255798373079, 11557.479913404086, 11923.880761192277, 11934.150206717972, 11958.760824783281, 12726.918211952088, 12796.912262457796, 12993.870061299644, 13381.464741410624, 13461.326933653474, 11217.33081586021, 11669.0, 11669.416529173677, 11742.882571174521, 11772.352520611106, 10412.531436085546, 10588.1000114988, 10640.148788097089, 10654.786904261717, 11045.171612128961, 10906.291091079054, 11560.364179969845, 11676.649700508999, 11909.0, 12056.0, 11541.538338466367, 11584.710382240512, 11884.881151188378, 11895.583654572049, 11907.404629768651, 11394.03150732197, 11406.258593191416, 11676.532938682698, 11751.412429378326, 11865.991390731884], "value": 11916.368043076009, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.0484565649708, 1621.8378162183783, 1622.8377162283773, 1638.7132251855926, 1648.925798339074, 9366.203872670823, 9775.36460130092, 11032.613858514944, 11124.49939752711, 11486.483108260127, 11149.331040137597, 11251.987321141096, 11253.324800511975, 11255.831162532568, 11265.549378024889, 2066.3387715930908, 2130.7336582927132, 2434.9878250608767, 2506.1228570000444, 2511.3721569607596, 2110.683397490381, 2189.9452513687124, 2441.4872876695913, 2517.710463296726, 2532.8860201290986, 2467.259822053386, 2472.431340791619, 2503.7621425964503, 2505.837120587156, 2508.79929605632, 2245.259064508708, 2248.830608083804, 2489.141246270034, 2496.9250922472356, 2502.4995000999784, 2424.3024926904104, 2430.611102223636, 2452.092725691488, 2459.95080098397, 2476.6656501372263, 11434.714132146679, 11473.0, 11486.885131148665, 11507.136964727679, 11508.0, 5045.445001049881, 5890.882182356372, 6028.336882942873, 6052.243469566304, 6067.211262535886, 2876.3384421582946, 3582.283543291352, 3682.1899182180146, 3791.1280405506614, 3808.390657494815, 1053.3574519543072, 1065.978680426395, 1125.9887401125966, 1239.4298622633598, 1290.6450726050412, 15409.383624655, 15561.688766224612, 15603.92198039014, 15614.375424982987, 15617.531474055797, 4272.380504826845, 4860.4896485869185, 5026.396832380138, 5105.412877519058, 5140.897182056338, 12898.355082246038, 12918.289494077915, 12940.547080852126, 12941.611751647466, 12996.415161317764, 6126.693665316717, 6135.815925522242, 6138.478229350466, 6155.261368635793, 6156.107364432221, 4708.95291047092, 5330.840074797762, 5509.173623956439, 5556.16657501378, 5615.0, 3819.121602031493, 3923.4507168996365, 4160.231901441875, 4203.726757760735, 4266.338717498793, 1177.4819079604947, 1178.2400351773058, 1181.6455063481094, 1198.4906414773686, 1198.7602479504135, 960.2462067277294, 982.0915653020927, 989.4162444157981, 1003.1122456625793, 1003.372891942536, 6101.267847858286, 6719.496037797185, 6770.627615481196, 6778.288279730557, 7101.431885449152, 1042.4006196437078, 1062.0653824634426, 1087.7008822573855, 1101.5208384352832, 1136.4772204785727, 4228.725132866415, 4360.084382279757, 4372.322290045048, 4478.977605111953, 4488.3940668010055, 13527.45890164402, 13845.861541384658, 13941.163530188018, 13956.581302560939, 13989.860101398855, 12973.740525189443, 13450.663733406744, 13726.176429414267, 13735.725285494234, 13744.381502832397, 10352.896471035343, 10605.939406059486, 10607.41659208751, 10611.204159688054, 10639.41483218415, 6722.193336799615, 7000.439964802702, 7159.248278930846, 7190.137183538009, 7248.782536523912, 12342.938285308515, 12480.0, 12484.937575312066, 12746.49014039428, 12770.87229127734, 12801.679958001125, 12868.034897382546, 13014.15407998477, 13049.412776424893, 13073.738525229632, 9320.813583728423, 9365.0, 9417.811643767223, 9449.905500944902, 9485.241180705665, 9210.493422861538, 9446.763830904283, 9585.0, 10325.896741032793, 10596.947015264874, 8847.330873799865, 8980.203210425248, 8999.460032398078, 9097.363184577016, 9221.492817894812, 8765.693200737944, 8784.341174412073, 8843.955780221058, 8850.73447796567, 8856.335774816785, 8034.87947680797, 8225.629846656795, 8233.917660823554, 8239.134890836376, 8247.587620619064, 5751.712414379181, 5944.791932282349, 5998.1002849572915, 6173.32093469709, 6200.596961197508, 5984.491318237999, 6041.848953776191, 6123.357047509948, 6206.844828879314, 6287.434130928055], "value": 5279.443209864958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.85567912032985, 390.61524398467486, 391.2780919204067, 393.8306528192876, 397.21549938870714, 4221.915561688765, 4598.218302888508, 4637.628989680826, 4879.146149423855, 4894.0, 3687.547780725814, 4563.634909207264, 4611.7232966021975, 4720.362751028611, 4873.5126487351245, 3168.8732450701946, 3799.164183879542, 3817.6256547642824, 3934.2721596504593, 4295.334223195409, 3464.297847678802, 3474.0817713120973, 4099.754014759124, 4129.359949207863, 4163.604457576525, 3367.646397128303, 3585.4980302757504, 4120.072983578686, 4121.9175616487655, 4163.417901197541, 3685.4202058559117, 3813.6820965759966, 3835.463035175078, 4127.8968025799295, 4178.600168943392, 3561.6972557332656, 3769.8869033929027, 3802.7147963902817, 3807.8857634271017, 3821.9044523887123, 4373.059792144672, 4581.381513495702, 4751.548602882721, 4787.976060119712, 4793.9280910786365, 4334.393184954109, 4714.96270820419, 4731.716097034189, 4748.907751217205, 4813.807447702087, 4655.930161047587, 4890.902181956377, 5225.372955245357, 5262.552683021948, 5263.31576895005, 4244.427002354673, 4249.681273904439, 4277.802215379698, 4287.834643505041, 4314.985978295098, 4744.864810835138, 4951.113375999859, 5113.744312784346, 5212.50481204285, 5253.9737301313635, 3732.9813350933614, 3750.362438385481, 3884.6698030667144, 4142.730722503027, 4174.603412675791, 4165.937510937339, 4361.847335343247, 4384.583464570861, 4385.539518350591, 4405.40527028847, 4137.40007698882, 4383.057642606855, 4749.691270067435, 4751.885410992145, 4788.084766093591, 4394.538573449806, 4878.707277563358, 5089.607884294376, 5236.062656817002, 5244.190754189798, 1204.2112416367293, 1335.8196643453205, 1350.9459621615026, 1402.978955315671, 1487.367868655817, 1066.2855886556026, 1118.0999295566985, 1139.225326777799, 1144.8969592736528, 1146.4267866066966, 4679.27471241958, 4767.9736112152195, 4891.04624598207, 4952.430470495867, 4954.653174277766, 5392.676439413648, 5401.082615671458, 5425.945740542623, 5442.8911421771345, 5481.397046324901, 4140.3168477200925, 4595.954800113917, 4930.802767889316, 4949.727764972889, 5039.924401133986, 2468.4939587384542, 2791.7906157038306, 2798.3769413739983, 2819.5488721804822, 2842.8436435995804, 5207.750139966381, 5244.554212891947, 5330.600204984642, 5552.444755524415, 5573.164025396223, 4944.629152813553, 5303.121128561733, 5530.861728456821, 5578.693171875505, 5580.493266817936, 5129.74351282427, 5346.117890548016, 5370.865728356823, 5415.48552887475, 5440.727963601804, 4833.830815921426, 4862.95137048625, 5208.713520756395, 5257.684538927677, 5378.946210538001, 5157.6647517911215, 5162.09663308912, 5313.654612450178, 5315.468453154654, 5398.946010539844, 5314.813981510629, 5600.0, 5603.775848966159, 5665.745041473226, 5720.799772007959, 4299.656027517729, 4329.523752387172, 4348.651917905459, 4348.826046958086, 4372.0, 5412.702301373462, 5419.864503387447, 5446.945530544644, 5456.48163424474, 5478.287822583039, 4607.709841244457, 4646.303054541846, 5016.849494515171, 5182.134431604694, 5275.44141091578, 4405.493368262562, 4779.510957001339, 4879.7786368585275, 4897.795991803774, 5201.6098792591465, 4592.15045216636, 4849.739067842457, 4854.0, 5140.30605868203, 5155.948440515547, 4699.600533954652, 4832.323474713473, 5200.349956255468, 5277.894442111213, 5279.46895400345, 4901.3383193268455, 4947.356843610308, 5136.563392111712, 5143.742812859267, 5171.069207542679], "value": 4015.9307186230003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.025133708533, 801.2908575910321, 842.2293601354761, 892.5135800988463, 896.6010125494155, 15545.378184872605, 16833.32666693331, 16921.576960575992, 17250.223739931702, 17288.394906178288, 15464.536063918073, 15906.920465397685, 16155.596110097253, 16189.676206475864, 16195.514134575953, 982.7002764156947, 994.2940512236321, 995.7261753017906, 999.7200783780517, 999.9350042247268, 988.3822610868208, 1004.1414590525105, 1033.0495943731746, 1042.5360714482058, 1043.5095505112622, 1049.9160067194607, 1053.826118690419, 1055.3034996902047, 1055.9102476289524, 1056.4717641179411, 1047.0942634621, 1047.8218702820463, 1047.8375851742992, 1048.905598496135, 1049.8477720730489, 786.2020049649553, 787.2167193642306, 787.4487858499074, 789.3961119743401, 789.9131095579539, 15859.286332115082, 16048.679026419406, 16106.677866442606, 17189.226484808212, 17314.220860061327, 14476.348564314525, 14722.926385368111, 14763.33564989578, 14984.850151498455, 15285.0, 11586.362750048744, 11750.764984700343, 11984.460699268553, 12121.818172727417, 12514.687132821662, 3879.534455865314, 3931.5871833457363, 3939.8424063037446, 4109.260333140033, 4110.794460276974, 120666.39666801697, 120981.0, 121342.39328803388, 123570.0, 123892.38053809764, 11275.041621462267, 11384.65846024604, 11655.0, 11706.0, 11730.302030532854, 23442.53114937692, 24223.456537063706, 24255.393615159763, 24292.271231863073, 24307.392315191908, 6997.335253150943, 7022.92977070233, 7058.364747172676, 7074.3633073023675, 7167.677454514559, 4499.775011249424, 4542.409486766699, 4567.680262381601, 4673.766311684402, 4676.883077923011, 3573.8213089345427, 3699.648533389324, 3770.057485628593, 3775.4903088083306, 3781.6596506314563, 672.4788289075907, 674.6120980436269, 676.9898451523231, 686.2725510958301, 693.4071368979551, 708.3907839258234, 724.1744411371042, 739.4232498651061, 748.3227678950558, 804.2761514636874, 8507.829843403097, 10753.731156720987, 10891.509882055327, 10923.945380273048, 11269.380184089954, 655.570601256178, 685.0512040823495, 711.3171355498675, 720.7693538067768, 722.989155162673, 5140.691558506502, 5310.336207974004, 5316.441773613792, 5326.493983071679, 5332.840014799563, 78880.0, 92548.0, 102639.48680256552, 102957.48521257346, 105135.4743226279, 59587.70206148941, 60425.39574604198, 64839.81281497469, 84941.30117397617, 88220.5588972051, 75086.0, 76600.0, 76873.0, 77672.83490747643, 78727.4254514918, 8701.608427620899, 11236.606718765132, 11274.154438417316, 11363.147763917574, 11490.885091149315, 50640.987180256925, 50851.0, 51369.0, 51822.0, 52551.737241313545, 63960.68019659872, 64153.396165096245, 64309.35690643221, 66813.33186668072, 67051.65896682137, 12724.554640587905, 13112.73774524485, 13145.34273286351, 13261.469541218243, 13289.734205315646, 14589.270536473347, 14757.483488077865, 14799.0, 15109.47116850905, 15121.773173402187, 13757.724845502833, 13808.447662093806, 14275.286235688382, 14278.500252491112, 14285.42858285657, 13313.400896959467, 14181.645458863612, 14186.29068546548, 14306.0, 14462.421503139756, 13227.470901163846, 13647.38586763618, 13668.93165534166, 14156.604008465081, 14360.281985900454, 9654.903450965401, 10330.48347582633, 10383.2212584055, 10386.324888882198, 10519.421431821323, 9942.652007179713, 10780.113480140788, 11202.215844891105, 11603.0, 11611.245269057485], "value": 7916.2577205605285, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1403.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 115.0, 115.0, 115.0, 113.0, 113.0, 115.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 110.0, 138.0, 158.0, 109.0, 108.0, 105.0, 105.0, 127.0, 104.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 182.0, 185.0, 184.0, 186.0, 188.0, 181.0, 183.0, 188.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 61.0, 93.0, 64.0, 61.0, 63.0, 58.0, 74.0, 59.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 85.0, 71.0, 70.0, 70.0, 80.0, 68.0, 68.0, 81.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 86.0, 87.0, 87.0, 87.0, 87.0, 88.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 84.0, 86.0, 83.0, 84.0, 85.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 59.0, 62.0, 59.0, 60.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 58.0, 63.0, 62.0, 57.0, 56.0, 57.0, 58.0, 57.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 95.0, 100.0, 100.0, 100.0, 80.0, 81.0, 80.0, 82.0, 84.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 132.0, 135.0, 136.0, 138.0, 140.0, 141.0, 191.0, 125.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 160.0, 160.0, 161.0, 161.0, 172.0, 160.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 63.0, 64.0, 64.0, 66.0, 65.0, 73.0], "value": 65.3, "unit": "score"}]}]} 03:48:59 INFO - Return code: 0 03:48:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:59 INFO - # TBPL SUCCESS # 03:48:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:48:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:48:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:48:59 INFO - 2017-04-24 03:48:59.630 screenresolution[1676:9875] starting screenresolution argv=screenresolution get 03:48:59 INFO - 2017-04-24 03:48:59.632 screenresolution[1676:9875] Display 0: 1600x1200x32@60 03:48:59 INFO - 2017-04-24 03:48:59.638 screenresolution[1677:9878] starting screenresolution argv=screenresolution list 03:48:59 INFO - Available Modes on Display 0 03:48:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:48:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:48:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:48:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:48:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:48:59 INFO - Intel Iris: 03:48:59 INFO - Chipset Model: Intel Iris 03:48:59 INFO - Type: GPU 03:48:59 INFO - Bus: Built-In 03:48:59 INFO - VRAM (Dynamic, Max): 1536 MB 03:48:59 INFO - Vendor: Intel (0x8086) 03:48:59 INFO - Device ID: 0x0a2e 03:48:59 INFO - Revision ID: 0x0009 03:48:59 INFO - Displays: 03:48:59 INFO - Display: 03:48:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:48:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:48:59 INFO - Display Serial Number: 1600x1200 60 03:48:59 INFO - Main Display: Yes 03:48:59 INFO - Mirror: Off 03:48:59 INFO - Online: Yes 03:48:59 INFO - Rotation: Supported 03:48:59 INFO - Return code: 0 03:48:59 INFO - Running post-action listener: _resource_record_post_action 03:48:59 INFO - [mozharness: 2017-04-24 10:48:59.886856Z] Finished run-tests step (success) 03:48:59 INFO - Running post-run listener: _resource_record_post_run 03:48:59 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38749184; Write bytes: 423186944; Read time: 247; Write time: 1377 03:48:59 INFO - TinderboxPrint: CPU usage
53.7% 03:48:59 INFO - TinderboxPrint: I/O read bytes / time
38,749,184 / 247 03:48:59 INFO - TinderboxPrint: I/O write bytes / time
423,186,944 / 1,377 03:48:59 INFO - TinderboxPrint: CPU idle
2,211.2 (46.3%) 03:48:59 INFO - TinderboxPrint: CPU system
947.2 (19.8%) 03:48:59 INFO - TinderboxPrint: CPU user
1,615.2 (33.8%) 03:48:59 INFO - TinderboxPrint: Swap in / out
160,366,592 / 0 03:48:59 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 110701056; Write bytes: 105805824; Read time: 9894; Write time: 232 03:48:59 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37815296; Write bytes: 297544192; Read time: 236; Write time: 1093 03:49:00 INFO - Running post-run listener: _upload_blobber_files 03:49:00 INFO - Blob upload gear active. 03:49:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:00 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 03:49:00 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'] 03:49:00 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 03:49:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:49:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:02 INFO - (blobuploader) - INFO - Done attempting. 03:49:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:49:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:03 INFO - (blobuploader) - INFO - Done attempting. 03:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:04 INFO - (blobuploader) - INFO - Done attempting. 03:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:06 INFO - (blobuploader) - INFO - Done attempting. 03:49:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:06 INFO - Return code: 0 03:49:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80801b90a21b27aa6d359ef42cd2861335ffef33f61fa920d207e46e4100b5c74123e9c1cbbe95e4095bca7339ac9698816aa4c938804bc202c643a2c003cdbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69dbfddb771c38f85a19516e42b7fcf749bbe57300de9fc394ada7d75f3cfe7826c79e7dd67d90f99f530f4ab17a01a77d65a8d29efcc4d3808b3055062b1fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d71f77821a2e4dd696095e135421d357ffe53958369cb800b982bc4f5e641807d0062876667219675aa6b1172fb2709434d187ce94c1ab431b5ae3605c31989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa91483e8fbd552ebdc0c2ad3a10e62c3cc43e1508cd3bbb576657adc7f373022e43c0ac0f984bfc3577f236f9c9e2e39f1fccf99b63858008172a86e33f1886"} 03:49:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:06 INFO - Contents: 03:49:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80801b90a21b27aa6d359ef42cd2861335ffef33f61fa920d207e46e4100b5c74123e9c1cbbe95e4095bca7339ac9698816aa4c938804bc202c643a2c003cdbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69dbfddb771c38f85a19516e42b7fcf749bbe57300de9fc394ada7d75f3cfe7826c79e7dd67d90f99f530f4ab17a01a77d65a8d29efcc4d3808b3055062b1fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d71f77821a2e4dd696095e135421d357ffe53958369cb800b982bc4f5e641807d0062876667219675aa6b1172fb2709434d187ce94c1ab431b5ae3605c31989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa91483e8fbd552ebdc0c2ad3a10e62c3cc43e1508cd3bbb576657adc7f373022e43c0ac0f984bfc3577f236f9c9e2e39f1fccf99b63858008172a86e33f1886"} 03:49:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:06 INFO - Copying logs to upload dir... 03:49:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.998160 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-24 03:49:06.860888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 03:49:06.864458) ========= 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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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/80801b90a21b27aa6d359ef42cd2861335ffef33f61fa920d207e46e4100b5c74123e9c1cbbe95e4095bca7339ac9698816aa4c938804bc202c643a2c003cdbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69dbfddb771c38f85a19516e42b7fcf749bbe57300de9fc394ada7d75f3cfe7826c79e7dd67d90f99f530f4ab17a01a77d65a8d29efcc4d3808b3055062b1fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d71f77821a2e4dd696095e135421d357ffe53958369cb800b982bc4f5e641807d0062876667219675aa6b1172fb2709434d187ce94c1ab431b5ae3605c31989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa91483e8fbd552ebdc0c2ad3a10e62c3cc43e1508cd3bbb576657adc7f373022e43c0ac0f984bfc3577f236f9c9e2e39f1fccf99b63858008172a86e33f1886"} build_url:https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/SFV58sTCSBajaXnJ_I87IQ/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/80801b90a21b27aa6d359ef42cd2861335ffef33f61fa920d207e46e4100b5c74123e9c1cbbe95e4095bca7339ac9698816aa4c938804bc202c643a2c003cdbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69dbfddb771c38f85a19516e42b7fcf749bbe57300de9fc394ada7d75f3cfe7826c79e7dd67d90f99f530f4ab17a01a77d65a8d29efcc4d3808b3055062b1fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d71f77821a2e4dd696095e135421d357ffe53958369cb800b982bc4f5e641807d0062876667219675aa6b1172fb2709434d187ce94c1ab431b5ae3605c31989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa91483e8fbd552ebdc0c2ad3a10e62c3cc43e1508cd3bbb576657adc7f373022e43c0ac0f984bfc3577f236f9c9e2e39f1fccf99b63858008172a86e33f1886"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 03:49:06.900246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:49:06.900564) ========= 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.bgjQp6rxzw/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.J3ymPi5XEB/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.005083 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 03:49:06.948891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 03:49:06.949208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 03:49:06.949542) ========= ========= Total master_lag: 0.19 =========