builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0388 starttime: 1488583726.99 results: success (0) buildid: 20170303135823 builduid: 9bb67bad43d14c0a832680263066cf55 revision: 5fd05d2d980957d2657b68de28e0242f2deb12d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:46.988751) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:46.989246) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:46.989534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:47.016229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:47.016647) ========= 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.yblOCwIWCT/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.InWLIiwRvC/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-03 15:28:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.8M=0.001s 2017-03-03 15:28:47 (16.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:47.135340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:47.135749) ========= 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.yblOCwIWCT/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.InWLIiwRvC/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.025659 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:47.184604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 15:28:47.184984) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5fd05d2d980957d2657b68de28e0242f2deb12d7 --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-aurora --rev 5fd05d2d980957d2657b68de28e0242f2deb12d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yblOCwIWCT/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.InWLIiwRvC/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-03 15:28:47,295 truncating revision to first 12 chars 2017-03-03 15:28:47,295 Setting DEBUG logging. 2017-03-03 15:28:47,295 attempt 1/10 2017-03-03 15:28:47,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5fd05d2d9809?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 15:28:48,508 unpacking tar archive at: mozilla-aurora-5fd05d2d9809/testing/mozharness/ program finished with exit code 0 elapsedTime=1.474448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 15:28:48.682785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:48.683121) ========= script_repo_revision: 5fd05d2d980957d2657b68de28e0242f2deb12d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:48.683531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:48.683825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 15:28:48.704459) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-03 15:28:48.705030) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yblOCwIWCT/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.InWLIiwRvC/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:28:48 INFO - MultiFileLogger online at 20170303 15:28:48 in /builds/slave/test 15:28:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:28:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:48 INFO - {'append_to_log': False, 15:28:48 INFO - 'base_work_dir': '/builds/slave/test', 15:28:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:28:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:48 INFO - 'branch': 'Mozilla-Aurora', 15:28:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:48 INFO - 'config_files': ('talos/mac_config.py',), 15:28:48 INFO - 'default_actions': ('clobber', 15:28:48 INFO - 'read-buildbot-config', 15:28:48 INFO - 'download-and-extract', 15:28:48 INFO - 'populate-webroot', 15:28:48 INFO - 'create-virtualenv', 15:28:48 INFO - 'install', 15:28:48 INFO - 'run-tests'), 15:28:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:48 INFO - 'download_minidump_stackwalk': True, 15:28:48 INFO - 'download_symbols': 'ondemand', 15:28:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:48 INFO - 'installer_path': 'installer.exe', 15:28:48 INFO - 'log_level': 'info', 15:28:48 INFO - 'log_name': 'talos', 15:28:48 INFO - 'log_to_console': True, 15:28:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:28:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:28:48 INFO - 'opt_config_files': (), 15:28:48 INFO - 'pip_index': False, 15:28:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:28:48 INFO - 'cmd': ('bash', 15:28:48 INFO - '-c', 15:28:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:28:48 INFO - 'enabled': True, 15:28:48 INFO - 'halt_on_failure': False, 15:28:48 INFO - 'name': 'check_screen_resolution'},), 15:28:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:28:48 INFO - 'cmd': ('bash', 15:28:48 INFO - '-c', 15:28:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:28:48 INFO - 'enabled': True, 15:28:48 INFO - 'halt_on_failure': False, 15:28:48 INFO - 'name': 'check_screen_resolution'},), 15:28:48 INFO - 'run_cmd_checks_enabled': True, 15:28:48 INFO - 'sps_profile': False, 15:28:48 INFO - 'sps_profile_interval': 0, 15:28:48 INFO - 'suite': 'dromaeojs', 15:28:48 INFO - 'system_bits': '32', 15:28:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:48 INFO - 'title': 't-yosemite-r7-0388', 15:28:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:48 INFO - 'use_talos_json': True, 15:28:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:48 INFO - 'work_dir': 'build'} 15:28:48 INFO - [mozharness: 2017-03-03 23:28:48.923933Z] Running clobber step. 15:28:48 INFO - Running pre-action listener: _resource_record_pre_action 15:28:48 INFO - Running main action method: clobber 15:28:48 INFO - rmtree: /builds/slave/test/build 15:28:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:51 INFO - Running post-action listener: _resource_record_post_action 15:28:51 INFO - [mozharness: 2017-03-03 23:28:51.410437Z] Finished clobber step (success) 15:28:51 INFO - [mozharness: 2017-03-03 23:28:51.410568Z] Running read-buildbot-config step. 15:28:51 INFO - Running pre-action listener: _resource_record_pre_action 15:28:51 INFO - Running main action method: read_buildbot_config 15:28:51 INFO - Using buildbot properties: 15:28:51 INFO - { 15:28:51 INFO - "project": "", 15:28:51 INFO - "product": "firefox", 15:28:51 INFO - "script_repo_revision": "production", 15:28:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:28:51 INFO - "repository": "", 15:28:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:28:51 INFO - "buildid": "20170303135823", 15:28:51 INFO - "pgo_build": "False", 15:28:51 INFO - "basedir": "/builds/slave/test", 15:28:51 INFO - "buildnumber": 46, 15:28:51 INFO - "slavename": "t-yosemite-r7-0388", 15:28:51 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 15:28:51 INFO - "platform": "yosemite_r7", 15:28:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:28:51 INFO - "branch": "mozilla-aurora", 15:28:51 INFO - "repo_path": "releases/mozilla-aurora", 15:28:51 INFO - "revision": "5fd05d2d980957d2657b68de28e0242f2deb12d7", 15:28:51 INFO - "stage_platform": "macosx64", 15:28:51 INFO - "builduid": "9bb67bad43d14c0a832680263066cf55", 15:28:51 INFO - "slavebuilddir": "test" 15:28:51 INFO - } 15:28:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 15:28:51 INFO - Running post-action listener: _resource_record_post_action 15:28:51 INFO - [mozharness: 2017-03-03 23:28:51.413825Z] Finished read-buildbot-config step (success) 15:28:51 INFO - [mozharness: 2017-03-03 23:28:51.413955Z] Running download-and-extract step. 15:28:51 INFO - Running pre-action listener: _resource_record_pre_action 15:28:51 INFO - Running main action method: download_and_extract 15:28:51 INFO - mkdir: /builds/slave/test/build/tests 15:28:51 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')]} 15:28:51 INFO - trying https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 15:28:51 INFO - Downloading https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 15:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 15:28:52 INFO - Downloaded 1199 bytes. 15:28:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 15:28:52 INFO - Using the following test package requirements: 15:28:52 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 15:28:52 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 15:28:52 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 15:28:52 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'jsshell-mac.zip'], 15:28:52 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 15:28:52 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 15:28:52 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 15:28:52 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 15:28:52 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 15:28:52 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 15:28:52 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 15:28:52 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:28:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 15:28:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:28:52 INFO - Fetch https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 15:28:53 INFO - Expected file size: 16357695 15:28:53 INFO - Obtained file size: 16357695 15:29:00 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:29:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 15:29:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:29:00 INFO - Fetch https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 15:29:00 INFO - Expected file size: 16357695 15:29:00 INFO - Obtained file size: 16357695 15:29:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 15:29:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:29:07 INFO - Fetch https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 15:29:08 INFO - Expected file size: 14403650 15:29:08 INFO - Obtained file size: 14403650 15:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:08 INFO - trying https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 15:29:08 INFO - Downloading https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 15:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 15:29:10 INFO - Downloaded 73934818 bytes. 15:29:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 15:29:10 INFO - mkdir: /builds/slave/test/properties 15:29:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:29:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:29:10 INFO - Contents: 15:29:10 INFO - build_url:https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 15:29:11 INFO - Running post-action listener: _resource_record_post_action 15:29:11 INFO - Running post-action listener: set_extra_try_arguments 15:29:11 INFO - [mozharness: 2017-03-03 23:29:11.600627Z] Finished download-and-extract step (success) 15:29:11 INFO - [mozharness: 2017-03-03 23:29:11.600770Z] Running populate-webroot step. 15:29:11 INFO - Running pre-action listener: _resource_record_pre_action 15:29:11 INFO - Running main action method: populate_webroot 15:29:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:29:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:29:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:29:11 INFO - '--tppagecycles', 15:29:11 INFO - '7'], 15:29:11 INFO - 'tests': ['tsvgm']}}, 15:29:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:29:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:29:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:29:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:29:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:29:11 INFO - 'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:29:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:29:11 INFO - 'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['damp', 'tps']}, 15:29:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:29:11 INFO - 'tests': ['damp', 'tps']}, 15:29:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['dromaeo_dom']}, 15:29:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:29:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['basic_compositor_video']}, 15:29:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:29:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['a11yr', 15:29:11 INFO - 'ts_paint', 15:29:11 INFO - 'tpaint', 15:29:11 INFO - 'sessionrestore', 15:29:11 INFO - 'sessionrestore_no_auto_restore', 15:29:11 INFO - 'tabpaint']}, 15:29:11 INFO - 'other-e10s': {'tests': ['a11yr', 15:29:11 INFO - 'ts_paint', 15:29:11 INFO - 'tpaint', 15:29:11 INFO - 'sessionrestore', 15:29:11 INFO - 'sessionrestore_no_auto_restore', 15:29:11 INFO - 'tabpaint']}, 15:29:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:29:11 INFO - 'ts_paint', 15:29:11 INFO - 'tpaint', 15:29:11 INFO - 'sessionrestore', 15:29:11 INFO - 'sessionrestore_no_auto_restore', 15:29:11 INFO - 'tabpaint']}, 15:29:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:29:11 INFO - 'ts_paint', 15:29:11 INFO - 'tpaint', 15:29:11 INFO - 'sessionrestore', 15:29:11 INFO - 'sessionrestore_no_auto_restore', 15:29:11 INFO - 'tabpaint']}, 15:29:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['a11yr', 15:29:11 INFO - 'ts_paint', 15:29:11 INFO - 'tpaint', 15:29:11 INFO - 'sessionrestore', 15:29:11 INFO - 'sessionrestore_no_auto_restore', 15:29:11 INFO - 'tabpaint']}, 15:29:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['a11yr', 15:29:11 INFO - 'ts_paint', 15:29:11 INFO - 'tpaint', 15:29:11 INFO - 'sessionrestore', 15:29:11 INFO - 'sessionrestore_no_auto_restore', 15:29:11 INFO - 'tabpaint']}, 15:29:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['tsvgx', 15:29:11 INFO - 'tsvgr_opacity', 15:29:11 INFO - 'tart', 15:29:11 INFO - 'tscrollx', 15:29:11 INFO - 'cart', 15:29:11 INFO - 'tsvg_static']}, 15:29:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:29:11 INFO - 'tsvgr_opacity', 15:29:11 INFO - 'tart', 15:29:11 INFO - 'tscrollx', 15:29:11 INFO - 'cart', 15:29:11 INFO - 'tsvg_static']}, 15:29:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:29:11 INFO - 'talos_options': ['--disable-e10s'], 15:29:11 INFO - 'tests': ['tp5o']}, 15:29:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:29:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:29:11 INFO - 'talos_options': ['--disable-e10s', 15:29:11 INFO - '--xperf_path', 15:29:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:29:11 INFO - 'tests': ['tp5n']}, 15:29:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:29:11 INFO - 'talos_options': ['--xperf_path', 15:29:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:29:11 INFO - 'tests': ['tp5n']}}, 15:29:11 INFO - 'talos.zip': {'path': '', 15:29:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:29:11 INFO - Running post-action listener: _resource_record_post_action 15:29:11 INFO - [mozharness: 2017-03-03 23:29:11.619145Z] Finished populate-webroot step (success) 15:29:11 INFO - [mozharness: 2017-03-03 23:29:11.619286Z] Running create-virtualenv step. 15:29:11 INFO - Running pre-action listener: _resource_record_pre_action 15:29:11 INFO - Running main action method: create_virtualenv 15:29:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:29:11 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 15:29:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:29:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:29:11 INFO - Using real prefix '/tools/python27' 15:29:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:29:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:29:15 INFO - Installing pip.................done. 15:29:15 INFO - Return code: 0 15:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:29:15 INFO - Reading from file tmpfile_stdout 15:29:15 INFO - Output received: 15:29:15 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) 15:29:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:29:15 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')]} 15:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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')]} 15:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:15 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 15:29:15 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 15:29:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:15 INFO - 'HOME': '/Users/cltbld', 15:29:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:15 INFO - 'LOGNAME': 'cltbld', 15:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:15 INFO - 'MOZ_NO_REMOTE': '1', 15:29:15 INFO - 'NO_EM_RESTART': '1', 15:29:15 INFO - 'PAGER': '/bin/cat', 15:29:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:15 INFO - 'PWD': '/builds/slave/test', 15:29:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:15 INFO - 'SHELL': '/bin/bash', 15:29:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:15 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:15 INFO - 'USER': 'cltbld', 15:29:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:15 INFO - 'XPC_FLAGS': '0x0', 15:29:15 INFO - 'XPC_SERVICE_NAME': '0', 15:29:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:15 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 15:29:15 INFO - Cleaning up... 15:29:15 INFO - Return code: 0 15:29:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:29:15 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')]} 15:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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')]} 15:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:15 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 15:29:15 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 15:29:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:15 INFO - 'HOME': '/Users/cltbld', 15:29:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:15 INFO - 'LOGNAME': 'cltbld', 15:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:15 INFO - 'MOZ_NO_REMOTE': '1', 15:29:15 INFO - 'NO_EM_RESTART': '1', 15:29:15 INFO - 'PAGER': '/bin/cat', 15:29:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:15 INFO - 'PWD': '/builds/slave/test', 15:29:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:15 INFO - 'SHELL': '/bin/bash', 15:29:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:15 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:15 INFO - 'USER': 'cltbld', 15:29:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:15 INFO - 'XPC_FLAGS': '0x0', 15:29:15 INFO - 'XPC_SERVICE_NAME': '0', 15:29:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:16 INFO - Downloading/unpacking psutil>=3.1.1 15:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:29:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:19 INFO - Installing collected packages: psutil 15:29:19 INFO - Running setup.py install for psutil 15:29:19 INFO - building 'psutil._psutil_osx' extension 15:29:19 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 15:29:20 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 15:29:20 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 15:29:20 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 15:29:20 INFO - building 'psutil._psutil_posix' extension 15:29:20 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 15:29:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:29:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:29:20 INFO - ^ 15:29:20 INFO - 1 warning generated. 15:29:20 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 15:29:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:20 INFO - Successfully installed psutil 15:29:20 INFO - Cleaning up... 15:29:20 INFO - Return code: 0 15:29:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:29:20 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')]} 15:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:20 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')]} 15:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:20 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:20 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 15:29:20 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 15:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:20 INFO - 'HOME': '/Users/cltbld', 15:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:20 INFO - 'LOGNAME': 'cltbld', 15:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:20 INFO - 'MOZ_NO_REMOTE': '1', 15:29:20 INFO - 'NO_EM_RESTART': '1', 15:29:20 INFO - 'PAGER': '/bin/cat', 15:29:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:20 INFO - 'PWD': '/builds/slave/test', 15:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:20 INFO - 'SHELL': '/bin/bash', 15:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:20 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:20 INFO - 'USER': 'cltbld', 15:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:20 INFO - 'XPC_FLAGS': '0x0', 15:29:20 INFO - 'XPC_SERVICE_NAME': '0', 15:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:29:23 INFO - Installing collected packages: mozsystemmonitor 15:29:23 INFO - Running setup.py install for mozsystemmonitor 15:29:23 INFO - Successfully installed mozsystemmonitor 15:29:23 INFO - Cleaning up... 15:29:24 INFO - Return code: 0 15:29:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:29:24 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')]} 15:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:24 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')]} 15:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:24 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:24 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 15:29:24 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 15:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:24 INFO - 'HOME': '/Users/cltbld', 15:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:24 INFO - 'LOGNAME': 'cltbld', 15:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:24 INFO - 'MOZ_NO_REMOTE': '1', 15:29:24 INFO - 'NO_EM_RESTART': '1', 15:29:24 INFO - 'PAGER': '/bin/cat', 15:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:24 INFO - 'PWD': '/builds/slave/test', 15:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:24 INFO - 'SHELL': '/bin/bash', 15:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:24 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:24 INFO - 'USER': 'cltbld', 15:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:24 INFO - 'XPC_FLAGS': '0x0', 15:29:24 INFO - 'XPC_SERVICE_NAME': '0', 15:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:29:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:29:27 INFO - warning: no files found matching '*.txt' 15:29:27 INFO - no previously-included directories found matching 'build' 15:29:27 INFO - no previously-included directories found matching 'dist' 15:29:27 INFO - no previously-included directories found matching '.git*' 15:29:27 INFO - Installing collected packages: jsonschema, functools32 15:29:27 INFO - Running setup.py install for functools32 15:29:27 INFO - warning: no files found matching '*.txt' 15:29:27 INFO - no previously-included directories found matching 'build' 15:29:27 INFO - no previously-included directories found matching 'dist' 15:29:27 INFO - no previously-included directories found matching '.git*' 15:29:27 INFO - Successfully installed jsonschema functools32 15:29:27 INFO - Cleaning up... 15:29:27 INFO - Return code: 0 15:29:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:29:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:27 INFO - 'HOME': '/Users/cltbld', 15:29:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:27 INFO - 'LOGNAME': 'cltbld', 15:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:27 INFO - 'MOZ_NO_REMOTE': '1', 15:29:27 INFO - 'NO_EM_RESTART': '1', 15:29:27 INFO - 'PAGER': '/bin/cat', 15:29:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:27 INFO - 'PWD': '/builds/slave/test', 15:29:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:27 INFO - 'SHELL': '/bin/bash', 15:29:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:27 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:27 INFO - 'USER': 'cltbld', 15:29:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:27 INFO - 'XPC_FLAGS': '0x0', 15:29:27 INFO - 'XPC_SERVICE_NAME': '0', 15:29:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:29:27 INFO - Cleaning up... 15:29:27 INFO - Return code: 0 15:29:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:28 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')]} 15:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:28 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:28 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 15:29:28 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 15:29:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:28 INFO - 'HOME': '/Users/cltbld', 15:29:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:28 INFO - 'LOGNAME': 'cltbld', 15:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:28 INFO - 'MOZ_NO_REMOTE': '1', 15:29:28 INFO - 'NO_EM_RESTART': '1', 15:29:28 INFO - 'PAGER': '/bin/cat', 15:29:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:28 INFO - 'PWD': '/builds/slave/test', 15:29:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:28 INFO - 'SHELL': '/bin/bash', 15:29:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:28 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:28 INFO - 'USER': 'cltbld', 15:29:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:28 INFO - 'XPC_FLAGS': '0x0', 15:29:28 INFO - 'XPC_SERVICE_NAME': '0', 15:29:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:29:28 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 15:29:28 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 15:29:28 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 15:29:28 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 15:29:28 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 15:29:28 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 15:29:30 INFO - Downloading blobuploader-1.2.4.tar.gz 15:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:29:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:29:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:32 INFO - Downloading docopt-0.6.1.tar.gz 15:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:29:32 INFO - Installing collected packages: blobuploader, requests, docopt 15:29:32 INFO - Running setup.py install for blobuploader 15:29:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:29:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:29:32 INFO - Running setup.py install for requests 15:29:32 INFO - Running setup.py install for docopt 15:29:33 INFO - Successfully installed blobuploader requests docopt 15:29:33 INFO - Cleaning up... 15:29:33 INFO - Return code: 0 15:29:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:33 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:33 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 15:29:33 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 15:29:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:33 INFO - 'HOME': '/Users/cltbld', 15:29:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:33 INFO - 'LOGNAME': 'cltbld', 15:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:33 INFO - 'MOZ_NO_REMOTE': '1', 15:29:33 INFO - 'NO_EM_RESTART': '1', 15:29:33 INFO - 'PAGER': '/bin/cat', 15:29:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:33 INFO - 'PWD': '/builds/slave/test', 15:29:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:33 INFO - 'SHELL': '/bin/bash', 15:29:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:33 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:33 INFO - 'USER': 'cltbld', 15:29:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:33 INFO - 'XPC_FLAGS': '0x0', 15:29:33 INFO - 'XPC_SERVICE_NAME': '0', 15:29:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:33 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-lgTfsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:33 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-cXRnOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:33 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-svDpN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:33 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-SMOrmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:33 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-yRDpSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:33 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-u_2x6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-OWMIHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-zzS8Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-G3mRiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-oX0KnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-pI3un7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-JNdd9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-STlWHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-collWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-hbeN7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:34 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-KwfgBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:35 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-GYNMOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:29:35 INFO - Running setup.py install for manifestparser 15:29:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:29:35 INFO - Running setup.py install for mozcrash 15:29:35 INFO - Running setup.py install for mozdebug 15:29:35 INFO - Running setup.py install for mozdevice 15:29:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:29:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:29:35 INFO - Running setup.py install for mozfile 15:29:35 INFO - Running setup.py install for mozhttpd 15:29:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Running setup.py install for mozinfo 15:29:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Running setup.py install for mozInstall 15:29:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Running setup.py install for mozleak 15:29:36 INFO - Running setup.py install for mozlog 15:29:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Running setup.py install for moznetwork 15:29:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:29:36 INFO - Running setup.py install for mozprocess 15:29:36 INFO - Running setup.py install for mozprofile 15:29:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Running setup.py install for mozrunner 15:29:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Running setup.py install for mozscreenshot 15:29:37 INFO - Running setup.py install for moztest 15:29:37 INFO - Running setup.py install for mozversion 15:29:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:37 INFO - Cleaning up... 15:29:37 INFO - Return code: 0 15:29:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:37 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:37 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 15:29:37 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 15:29:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:37 INFO - 'HOME': '/Users/cltbld', 15:29:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:37 INFO - 'LOGNAME': 'cltbld', 15:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:37 INFO - 'MOZ_NO_REMOTE': '1', 15:29:37 INFO - 'NO_EM_RESTART': '1', 15:29:37 INFO - 'PAGER': '/bin/cat', 15:29:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:37 INFO - 'PWD': '/builds/slave/test', 15:29:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:37 INFO - 'SHELL': '/bin/bash', 15:29:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:37 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:37 INFO - 'USER': 'cltbld', 15:29:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:37 INFO - 'XPC_FLAGS': '0x0', 15:29:37 INFO - 'XPC_SERVICE_NAME': '0', 15:29:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-z0TgPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-d4882l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-wzUT0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-HVFfY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-x1ZSQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-RBwjaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-AHi24p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-7MwM3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-JDnXLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:38 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)) 15:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:38 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-I4Ce5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:39 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)) 15:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:39 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-NYbZnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:39 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)) 15:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:39 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-W63eC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:39 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-IHCq8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:39 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)) 15:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:39 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-q0wETB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:39 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)) 15:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:39 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-SEgodJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:39 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)) 15:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:39 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-OO6JPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:39 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)) 15:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:39 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-1C0LHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:39 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)) 15:29:39 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)) 15:29:39 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)) 15:29:39 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)) 15:29:39 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)) 15:29:39 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)) 15:29:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:42 INFO - Downloading blessings-1.6.tar.gz 15:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:42 INFO - Installing collected packages: blessings 15:29:42 INFO - Running setup.py install for blessings 15:29:42 INFO - Successfully installed blessings 15:29:42 INFO - Cleaning up... 15:29:42 INFO - Return code: 0 15:29:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:43 INFO - Reading from file tmpfile_stdout 15:29:43 INFO - Current package versions: 15:29:43 INFO - blessings == 1.6 15:29:43 INFO - blobuploader == 1.2.4 15:29:43 INFO - docopt == 0.6.1 15:29:43 INFO - functools32 == 3.2.3-2 15:29:43 INFO - jsonschema == 2.5.1 15:29:43 INFO - manifestparser == 1.1 15:29:43 INFO - mozInstall == 1.12 15:29:43 INFO - mozcrash == 1.0 15:29:43 INFO - mozdebug == 0.1 15:29:43 INFO - mozdevice == 0.49 15:29:43 INFO - mozfile == 1.2 15:29:43 INFO - mozhttpd == 0.7 15:29:43 INFO - mozinfo == 0.9 15:29:43 INFO - mozleak == 0.1 15:29:43 INFO - mozlog == 3.4 15:29:43 INFO - moznetwork == 0.27 15:29:43 INFO - mozprocess == 0.24 15:29:43 INFO - mozprofile == 0.28 15:29:43 INFO - mozrunner == 6.13 15:29:43 INFO - mozscreenshot == 0.1 15:29:43 INFO - mozsystemmonitor == 0.3 15:29:43 INFO - moztest == 0.8 15:29:43 INFO - mozversion == 1.4 15:29:43 INFO - psutil == 3.1.1 15:29:43 INFO - requests == 1.2.3 15:29:43 INFO - wsgiref == 0.1.2 15:29:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:44 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 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:44 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 15:29:44 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 15:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:44 INFO - 'HOME': '/Users/cltbld', 15:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:44 INFO - 'LOGNAME': 'cltbld', 15:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:44 INFO - 'MOZ_NO_REMOTE': '1', 15:29:44 INFO - 'NO_EM_RESTART': '1', 15:29:44 INFO - 'PAGER': '/bin/cat', 15:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:44 INFO - 'PWD': '/builds/slave/test', 15:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:44 INFO - 'SHELL': '/bin/bash', 15:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:44 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:44 INFO - 'USER': 'cltbld', 15:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:44 INFO - 'XPC_FLAGS': '0x0', 15:29:44 INFO - 'XPC_SERVICE_NAME': '0', 15:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 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)) 15:29:44 INFO - Cleaning up... 15:29:44 INFO - Return code: 0 15:29:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:29: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')]} 15:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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')]} 15:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95b9ce6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, '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.yblOCwIWCT/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.InWLIiwRvC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:44 INFO - 'HOME': '/Users/cltbld', 15:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:44 INFO - 'LOGNAME': 'cltbld', 15:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:44 INFO - 'MOZ_NO_REMOTE': '1', 15:29:44 INFO - 'NO_EM_RESTART': '1', 15:29:44 INFO - 'PAGER': '/bin/cat', 15:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:44 INFO - 'PWD': '/builds/slave/test', 15:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:44 INFO - 'SHELL': '/bin/bash', 15:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:29:44 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:44 INFO - 'USER': 'cltbld', 15:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:44 INFO - 'XPC_FLAGS': '0x0', 15:29:44 INFO - 'XPC_SERVICE_NAME': '0', 15:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:29:45 INFO - Cleaning up... 15:29:45 INFO - Return code: 0 15:29:45 INFO - Running post-action listener: _resource_record_post_action 15:29:45 INFO - Running post-action listener: _start_resource_monitoring 15:29:45 INFO - Starting resource monitoring. 15:29:45 INFO - [mozharness: 2017-03-03 23:29:45.057250Z] Finished create-virtualenv step (success) 15:29:45 INFO - [mozharness: 2017-03-03 23:29:45.058104Z] Running install step. 15:29:45 INFO - Running pre-action listener: _resource_record_pre_action 15:29:45 INFO - Running main action method: install 15:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:45 INFO - Reading from file tmpfile_stdout 15:29:45 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:29:45 INFO - Reading from file tmpfile_stdout 15:29:45 INFO - Output received: 15:29:45 INFO - Usage: mozinstall [options] installer 15:29:45 INFO - Options: 15:29:45 INFO - -h, --help show this help message and exit 15:29:45 INFO - -d DEST, --destination=DEST 15:29:45 INFO - Directory to install application into. [default: 15:29:45 INFO - "/builds/slave/test"] 15:29:45 INFO - --app=APP Application being installed. [default: firefox] 15:29:45 INFO - mkdir: /builds/slave/test/build/application 15:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:30:05 INFO - Reading from file tmpfile_stdout 15:30:05 INFO - Output received: 15:30:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:30:05 INFO - Running post-action listener: _resource_record_post_action 15:30:05 INFO - [mozharness: 2017-03-03 23:30:05.371257Z] Finished install step (success) 15:30:05 INFO - [mozharness: 2017-03-03 23:30:05.371408Z] Running run-tests step. 15:30:05 INFO - Running pre-action listener: _resource_record_pre_action 15:30:05 INFO - Running main action method: run_tests 15:30:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:30:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:30:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:30:05 INFO - 2017-03-03 15:30:05.385 screenresolution[1627:7357] starting screenresolution argv=screenresolution get 15:30:05 INFO - 2017-03-03 15:30:05.388 screenresolution[1627:7357] Display 0: 1600x1200x32@60 15:30:05 INFO - 2017-03-03 15:30:05.394 screenresolution[1628:7359] starting screenresolution argv=screenresolution list 15:30:05 INFO - Available Modes on Display 0 15:30:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:30:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:30:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:30:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:30:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:30:05 INFO - Intel Iris: 15:30:05 INFO - Chipset Model: Intel Iris 15:30:05 INFO - Type: GPU 15:30:05 INFO - Bus: Built-In 15:30:05 INFO - VRAM (Dynamic, Max): 1536 MB 15:30:05 INFO - Vendor: Intel (0x8086) 15:30:05 INFO - Device ID: 0x0a2e 15:30:05 INFO - Revision ID: 0x0009 15:30:05 INFO - Displays: 15:30:05 INFO - Display: 15:30:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:30:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:30:05 INFO - Display Serial Number: 1600x1200 60 15:30:05 INFO - Main Display: Yes 15:30:05 INFO - Mirror: Off 15:30:05 INFO - Online: Yes 15:30:05 INFO - Rotation: Supported 15:30:05 INFO - Return code: 0 15:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:30:05 INFO - Python 2.7.3 15:30:05 INFO - Return code: 0 15:30:05 INFO - grabbing minidump binary from tooltool 15:30: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')]} 15:30:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd22d30>, '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 0x10bc49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd17be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:30:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:30:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:30:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:30:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:30:05 INFO - Return code: 0 15:30:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:30:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:30:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:30:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:30:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 15:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0388 --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 15:30:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yblOCwIWCT/Render', 15:30:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:30:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:30:05 INFO - 'HOME': '/Users/cltbld', 15:30:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:30:05 INFO - 'LOGNAME': 'cltbld', 15:30:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:30:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:05 INFO - 'MOZ_NO_REMOTE': '1', 15:30:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:30:05 INFO - 'NO_EM_RESTART': '1', 15:30:05 INFO - 'PAGER': '/bin/cat', 15:30:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:05 INFO - 'PWD': '/builds/slave/test', 15:30:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:30:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:30:05 INFO - 'SHELL': '/bin/bash', 15:30:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.InWLIiwRvC/Listeners', 15:30:05 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:30:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:30:05 INFO - 'USER': 'cltbld', 15:30:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:30:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:05 INFO - 'XPC_FLAGS': '0x0', 15:30:05 INFO - 'XPC_SERVICE_NAME': '0', 15:30:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:30:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 15:30:05 INFO - mozversion application_buildid: 20170303135823 15:30:05 INFO - mozversion application_changeset: 5fd05d2d980957d2657b68de28e0242f2deb12d7 15:30:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:30:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:30:05 INFO - mozversion application_name: Firefox 15:30:05 INFO - mozversion application_remotingname: firefox-dev 15:30:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:30:05 INFO - mozversion application_vendor: Mozilla 15:30:05 INFO - mozversion application_version: 53.0a2 15:30:05 INFO - mozversion platform_buildid: 20170303135823 15:30:05 INFO - mozversion platform_changeset: 5fd05d2d980957d2657b68de28e0242f2deb12d7 15:30:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:30:05 INFO - mozversion platform_version: 53.0a2 15:30:05 INFO - using testdate: 1488583805 15:30:05 INFO - actual date: 1488583805 15:30:05 INFO - starting webserver on 'localhost:49241' 15:30:05 INFO - SUITE-START | Running 2 tests 15:30:05 INFO - TEST-START | dromaeo_css 15:30:05 INFO - operating with platform_type : mac_ 15:30:05 INFO - Initialising browser for dromaeo_css test... 15:30:05 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpjHUxHA/profile http://localhost:49241/getInfo.html) 15:30:08 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 15:30:08 INFO - PROCESS | 1638 | colorDepth:24 15:30:08 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 15:30:08 INFO - PROCESS | 1638 | __metrics 15:30:08 INFO - PROCESS | 1638 | 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" 15:30:08 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:30:09 INFO - TEST-INFO | 1638: exit 0 15:30:09 INFO - Browser initialized. 15:30:09 INFO - Running cycle 1/1 for dromaeo_css test... 15:30:09 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpjHUxHA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:21 INFO - PROCESS | 1640 | RSS: Main: 212578304 15:30:21 INFO - PROCESS | 1640 | 15:33:24 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 15:33:26 INFO - PROCESS | 1640 | RSS: Main: 399663104 15:33:26 INFO - PROCESS | 1640 | 15:35:10 INFO - PROCESS | 1640 | ************************* 15:35:10 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 15:35:10 INFO - PROCESS | 1640 | 15:35:10 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:35:10 INFO - PROCESS | 1640 | Full stack: 15:35:10 INFO - PROCESS | 1640 | ************************* 15:36:29 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 15:36:30 INFO - PROCESS | 1640 | RSS: Main: 358174720 15:36:30 INFO - PROCESS | 1640 | 15:39:32 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:39:33 INFO - PROCESS | 1640 | RSS: Main: 344608768 15:39:33 INFO - PROCESS | 1640 | 15:42:35 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:42:36 INFO - PROCESS | 1640 | RSS: Main: 328466432 15:42:36 INFO - PROCESS | 1640 | 15:45:39 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:45:40 INFO - PROCESS | 1640 | RSS: Main: 315764736 15:45:40 INFO - PROCESS | 1640 | 15:48:43 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:48:44 INFO - PROCESS | 1640 | RSS: Main: 363610112 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | __start_tp_report 15:48:44 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 15:48:44 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 15:48:44 INFO - PROCESS | 1640 | |i|pagename|runs| 15:48:44 INFO - PROCESS | 1640 | |0;dojo.html;3350.4806754952992;3350.9162270943225;3363.6804503572152;3364.764466487347;3416.940748368006;5671.2060311556415;5725.370209276986;5736.512396446296;5777.508911742497;5786.479216870481;5726.7422965966525;5778.219940308068;5782.277215348082;5784.132380142981;5789.131630255464;5239.266502689627;5259.447757985405;5284.973575132138;5291.86770330741;5342.973285133569;5118.718470484122;5126.231065340192;5136.922946155811;5324.1215199492035;5340.25236466895;5225.921611175835;5229.267902493654;5263.76313065911;5265.394479634833;5277.366715994086;5256.763445644936;5264.499872512143;5265.7893684252585;5266.736663166846;5272.736363181825;5126.71803050832;5209.322788037531;5227.738613069331;5230.764615592308;5238.13570760824;5735.426457354231;5736.598438109334;5745.597808153431;5758.193852860602;5762;6148.108524264001;6180.84547886302;6191.845203869894;6200.069989501566;6203.255609326865;6178.258608966908;6215.28524219716;6227.0036794113175;6243.094751261042;6249.500039996835;4326.935095973563;5515.31782806244;5764.394738552475;5821.15593238978;5869.677167755772;6264.561480696399;6342.746290148342;6343.175387199681;6343.365663433666;6347.841303967438;6074.605150665193;6078.0882867569335;6110.908336374958;6165.260168779775;6187.907181392283;6264.686765661699;6280.842978925563;6281.937180628135;6284.308726040132;6288.465480434123;6211.068339749074;6214.751409943552;6219.689015549205;6247.406496382836;6247.718852651642;6105.558094708146;6178.598391104653;6189.195404597373;6201.317855036033;6286.119943207955;5005.624578156653;5013.924791128136;5023.120953833065;5034.647574669738;5060.443351231362;4457.465104187519;4481.3726078349055;4494.258447356215;4517.932231016537;4528.139653465831;5714.79998200061;5725.914111288334;5778.797742079007;5908.852278693067;5917.993941030035;5167.302414174113;5449.373322068013;6250.718717657716;6292.559520833498;6336.112944187817;5731.340895796953;5792.594518383673;5847.9415205848245;5871.6770577618645;5873.911891321633;5341.599380046434;5459.754311056012;5461.863453413696;5467.890642187134;5469.671819690831;5289.709066001253;6229.470495007975;6243.7814676486105;6278.0269058296035;6294.65379404128;6138.664296166039;6327.746890124344;6331.841703957253;6349.0476428536085;6356.459700925473;6268;6275.184226050585;6283.8114856554375;6298.149749783721;6302.747890084529;5192.948070519246;6184.6598437086395;6284.151639528788;6296.212973378328;6300.21247344082;5354.732263386893;5767.307923049261;6308.116863639186;6311.2426508819235;6319.96840015797;5940.702964851826;5941.732622032106;5950.434708702666;6042.2749270086115;6051.152838602511;6131.590761709946;6144.201253837151;6153.323134455296;6161.137440758208;6175.6912154393;5998.25021872266;6045.455908968038;6049;6051.636901785907;6057.121717351048;5960.493358064613;6045.697715114315;6052.727627256696;6088.391160883876;6166.414190651881;5906.70466476683;5990.610610310316;5992.64044157352;6016.127661489147;6039.607425517327 15:48:44 INFO - PROCESS | 1640 | |1;ext.html;434.42221844946215;463.1431851075513;510.69103192568497;519.1511878079339;533.8478533617917;30627.846860765694;39254.411183832264;40835.59164408351;40885.59114408855;41143.38284925729;42694;43048.92377690552;43101.56898431015;43192.352114718306;43316.350254746205;9212.907870921288;9373.81252374952;9414.482203478807;9415.764605884873;9419.340646154771;8250.83498330033;8479.66081356745;8490.787730306762;8572;8576.0995095515;9518.476483793389;11072.280301780398;11344.886551134465;11464.541418343299;11485.483153258081;11137.665870023913;11190;11256.54973801047;11285.322880627147;11303;8329.625166867505;11080.501377438035;11171.385573793437;11173.83239251412;11180.944095279552;31369.52945705816;39754.20491590152;40377;40621.98445038868;42503.57496425058;3923.3134201514904;3924.1759230561615;3930.430087637305;3944.5666212867095;3964.4647972523917;25756.356091097685;29852.701472985427;29919;29954.55068173979;30774;3160.8577614007427;3178.7457003439667;3192.8403579821147;3200.8399580020905;3222.2910959588853;489371;491689;491755;492569;493718.0628193744;57834.132488012714;57940;59387.406125938185;59432.999999999134;59478.405215947285;63731.681341592994;63805;63809.68095159494;63818.68090659517;63861.36138638554;16102.19489025544;16689.582760430843;16746.91626541884;16756.497305080866;16797.832021679627;13003.284819334838;13124.737505249841;13130.277834719182;13135;13156.473741050251;14322.212278324792;14710.33803478846;15617.843821561639;16194.514164575081;16278.104704241143;6262.436380725665;6492.415682588589;7493.587852668046;7534.510256833289;7682.962800022037;868.8436081505263;891.892972843263;894.9194572488377;918.875951746519;930.251147825993;28936.27659308492;29952.550711739343;30176.84911575428;30224.546631800542;30438.69561304403;1066.2802608239408;1071.8285074388216;1102.327580176092;1113.8329250612474;1119.9160062995309;14752.462402826048;15076.773848392282;15428.768568471482;15526.433358153388;15616.687666246838;599857;605734;605975;606851.9657401773;608230;59626.70186649126;59962.400375996556;60017.799644006875;60041.39958600445;60084.69957650271;1419.4464158978008;1464.4581504843277;1478.8003619511228;1481.7777333400077;1482.5404124721372;26697.86651066732;29148.7085129146;29456.397463881465;29751.404971900007;29766.70233297726;50286.49713502965;50553;50564;50688.74655626698;50782;523567;527692;527718;529441;529490;38453.530566516805;38959;39446.60553394429;39667.404988925766;39789.60210397975;46075.53924460713;46308.07383852371;46633.76683116562;46723.532764671916;46931.76534117308;37112.07219819526;37235.441468378536;37654.811725941196;38744;39005;37668.43497347487;38190.80904595459;38719.225615488096;38971.02572435712;39283.410748839364;31222.687773122885;36387;36852.447213291285;37343.87968360845;37730.8113459431;31854;32651.34697305993;32865.50701739428;33680;33958.49062264118;20510.79489205089;24769.110826802877;24784.50430991334;24809.1316803911;24948.625770613817 15:48:44 INFO - PROCESS | 1640 | |2;jquery.html;352.8341679410677;368.3296400550995;382.2126419575674;396.1008510680754;418.7906046976512;15060.84939150608;15175.9376843621;17451.389201377955;17652.38216662417;21066.157353705832;21065.578688426223;21344.786552134476;21669;21720.2397916073;21726.3482095537;5584.469475399851;5656.575756818234;5755.740991655385;5910.0543912973935;5918.2898052233795;5778.595498315099;5822.737976791033;5839.9124013139835;5849.327327357366;5890.087036509327;4195.496540415139;4407.955920440787;6256;6510.251321098063;6584.473242140642;6378.362163783631;6559.950407934755;6616.206055273374;6629.73481060757;6639.402453779159;5761.366249712528;5788.363280039192;5792.797252096157;5798.681072541009;5813.098969659667;25877.96488140472;26113.73886261132;26134;26167.869160654074;26530.204093877215;2705.9729402705916;2808.9016884408948;2814.6340975673033;2816.662000559925;2821.2382656682785;14729.410823567045;15043.924780376028;15169.393224271016;15822.841771582367;15871.28579213938;1762.4624489530688;1788.6243888783372;1798.5144011116925;1810.36637176987;1811.1759149586906;122330.38834805858;124357;125118;126940;129862;11191.32852028881;11641.243319184226;11693.473793679304;11707.473163707653;11854.525818967317;14280.428782848778;14726.779098313535;14750.188739619423;14758.704825903422;14834.62913427173;8449.74650760466;8514.446560973642;8721.215090641872;8790.384673072824;8883.955580222058;8669.479831210148;8682.262007729287;8689.913100869036;8855.096154326851;8864.113588641214;7118.074650295532;7239.8552028960175;7251;7254.347108760131;7266.309700578542;1909.312647446918;1928.8746231494908;1939.3890924358782;1944.9708254376196;1945.2608008956506;679.4360680635061;846.1834329871704;868.4702331577859;875.1161327059716;883.4787475389551;22326.88836555807;23019.654705179102;23274.883625581762;23341.53316933652;23439.531209375717;940.3464592108555;949.7578117580111;950.7052813627797;951.177231694593;966.1546147121269;11281.984621384116;12055.336956467303;12244.326562039174;12287.447064882102;12325.322107284006;677097;730784;748044.2597786976;750841;778760;134283;135471;138781;150010;153934;1012.7113772574928;1054.5718705060974;1067.5729708116814;1073.8174510333263;1075.876274228458;15861.762073568674;19600.803991960467;20346.08442620056;20359.287424940056;20364.79635203629;57541.13688294763;57819;60676.08985865127;60993.695031524556;62932.48270069146;78522;80834;80954;81854.18145818466;83220;8000.039990202437;8049.637766300648;8170.3055240302865;8649.351298652751;8709.259712924473;13153.473861045833;13193.538226162038;13457.125286856322;13606.183628982293;13719.657008574866;8209.79475513117;11605.941970290094;11716.531338746354;11834.763304733684;11867.643970680894;11138.053265472525;11310.604128855779;11328.093752499944;11680;11830;11205.775884482102;11392.316461012366;11513.481893314653;11761.705957351134;11902.166848320534;8182.877256841271;8305;8424.705135320235;8456.95771521163;8670.219680228809;10839.403832789272;11012.724681883017;11182;11295.887041129812;11435.542578297107 15:48:44 INFO - PROCESS | 1640 | |3;mootools.html;1415.1150696570621;1431.1985288238586;1446.9131852088876;1455.1196526101708;1458.9197594132324;7998.240167184115;8439.185575101352;8449.57752112395;8458.238758511732;8461.661533538667;7241.312075352833;7475.738349157767;7480.700771969115;7954.125046244909;8146.959265203681;2292.805111565515;2332.988335058331;2334.1947028275217;2338.7193536775526;2341.379534423379;2321.6169332060276;2364.1725396111397;2366.881655917206;2377.714674239085;2379.6311571706415;2048.0988365119374;2294.4149241943364;2317.4669825940045;2349.0603758496654;2353.8116950643994;2277.0664027748626;2290.461741490765;2297.437127903666;2311.3528212100637;2318.652202169688;2335.894884730174;2365.077619728307;2365.0894405653776;2366.183666635008;2368.39605900496;8214.794630134234;8271.834563308761;8299.585020748998;8300.916990830136;8309.418340716153;4999.4250661174065;5156.407013193456;5159.968006398698;5165.302684137669;5172.094883395391;3254.7070763631386;3273.623533293678;3452.792832430037;3523.40102182627;3530.135116896377;1139.2765593847882;1163.5694792926672;1207.3178654060428;1208.576998050684;1213.9635810925597;10688.412137332443;10768.407737574431;10773.138148947986;10786.352818830896;10787.67636970892;4353.194658988034;4591.517890621503;4606.401167848158;4634.930476042795;4685.695429797052;9387.57755900986;9455.338126331091;9468.57391417388;9477.28920330978;9483.66807161746;5226.059309324358;5232.529072383504;5238.083335416287;5239.633225674243;5241.554467870197;4247.872563823028;4369.563043695605;4596.770161491912;4682.81268749253;4756.548127927841;3819.618038196158;3847.211321679049;3944.9211015779524;3951.881443556698;3957.940630890539;1114.0586204657052;1252.6054292897709;1271.8219449276924;1275.3930048139412;1293.8835504804613;780.8070660552868;862.4480332587149;902.7291812456368;906.4425378392241;925.1396201532505;5518.089515230023;5537.335519737577;5621.7189140542805;5751.298953855997;5813.157092221689;900.3697411811758;965.7633879699519;974.6150270643057;976.4873441443299;1008.3748076192808;3130.7495400367916;3713.9257214856093;3808.447775072599;3909.3354129798004;3937.1928754605237;9751.512424378752;9937.900620993842;9987.101160895554;9996.400215987063;10048.246381521416;9322.906770932339;9777.266704997153;9946.801063978824;9951.701448956543;9961.203103751683;7681.846363072707;7892.250236227549;7897.24976127267;7897.802554936173;7911.604419778988;4500.5274446182675;5556.16657501378;5573.27547418833;5813.505852002627;5846.239988801599;8204.179582041748;8910.777230569287;8963.59663815143;8980.281577473917;9275.2579793615;8330.708425205088;9146.222571081267;9255.167034966886;9435.009324020879;9512.571934262836;6570.375814297634;6717.16035495563;7157.85684286301;7287.890681639674;7294.671739771617;7515.39876809843;7839.05931288249;7936.246056624612;8059.798505037421;8061.4760040597175;6972.686229119803;7050.858982820418;7092.716291348288;7119.501634885508;7220.566765994057;6883.27725588806;6906.516543841883;6931.549449285781;6944.756933507303;6979.127609048869;6238;6332.398422149889;6427.807165784847;6433.967830160819;6440.484761218998;4925.21196608541;4931.926021109758;4961;4971.254311853251;5010.674306170087;4873.707577545359;4917.188663870421;4921.926171107508;5007.69953802773;5050.191969284897 15:48:44 INFO - PROCESS | 1640 | |4;prototype.html;352.51001108459246;357.2640360856636;362.3749032918216;373.71037445979346;374.5728773373447;5071.619628527857;5277.604179686525;5293.497117773805;5383.380911195214;5410.996896722318;4302.440682711251;4750.192467280562;4842.878928026801;5349.255521135202;5362.785488580462;3834.4440056191834;4001.3797861331395;4102.302608556538;4168.270167880326;4193.391958166064;3313.1385839681616;3676.1728611062563;3749.700023998087;4194.643455306303;4240.427542281799;3244.8377581120967;3536.3104194682046;4138.8965275868195;4151.2112698587325;4176.143890502455;3734.3838266685966;3745;3876.6898648108086;4029.174019326031;4127.731697439672;3701.8524257480267;3709.517762690833;3717.290046578577;3727.329080765461;3742.559114740817;4298.742075475481;5035.597152227813;5172.66377685453;5181.222816577506;5224.8650809514365;4294.785260736982;4514.706544074625;4788.449328327218;4813.711177329372;4829.855104346875;5581.8457729323945;5595.972020139914;5600.8319750407145;5643.322801263834;5647.209390685307;3181.347823696137;3448.327576122657;3597.8380972856285;4012.3981402789523;4082.9183416331803;4330.956690433087;4999.250112483121;5839.7664093436215;5853.312413179669;5879.353271140214;4135.56576559463;4153.584641535822;4156.56356082613;4159.334506478949;4170.791460426966;3916.823742931575;4156.875293741193;4189.685773566995;4208.695304455568;4229.365595160751;4699.741514216751;4726.983698504838;4731.2903064539905;4745.83389581363;4755.405574303212;4690.929636055462;5571.470710282517;5615.8596035098635;5624.100143977026;5653.547716182696;1111.7554138089608;1199.196538319328;1200.6338066889507;1316.5457917018805;1349.6773162300804;826.6734639817358;956.8661136553206;960.4573416019927;971.3491960386558;983.593461350276;4502.932456013163;4648.790804413809;4768.666193366431;4768.7601223681395;5029.2958985742025;4731.090379416634;5348.144296912553;5508.338999320107;5528.778848846082;5549.67019788132;4536.274196128604;4806.831760888422;4944.2288191894995;4954.826581069645;4994.400671919393;2578.4456341886207;2810.723314115573;2866.4091429256964;2873.84193869335;2883.3944871577205;4484.2376795944765;4737.620990320766;5363.490468405495;5514.338279406497;5637.774489020393;5007.474215207423;5543.891221755665;5610.691411972381;5640.435956404327;5680.6307590007345;4885.60915126789;5633.887322253532;5713.771449141987;5717.942820571741;5734.598578099576;4448.966562924032;5406.648567843235;5417.539509141767;5447.809326673548;5449.329828384142;4529.569690879362;4650.906981860411;5420.723296215678;5451.727413629382;5503.834884953458;5560.860978475571;5597.972010139923;5698.088305871041;5699.458551437607;5718.971405142947;3767.868124615625;3841.654251117413;3860.80695965195;3872.7482713623526;3878.398848178537;5083.364579427572;5292.41783403833;5434.483724046209;5669.659820410789;5814.854628634149;4670.131947221139;5148.021875843578;5627.915581266366;5628.915566266427;5660.320761508646;5588.295569851234;5664.235328230636;5669.291338582677;5674.375818660027;5676.375598684059;4739.549742774431;4869.31829543857;4907.337509436323;5374.516293533445;5420.728963551728;4907.386576677915;5350.8127215547265;5536.695481748542;5541.916871246854;5583.497485226349;4992.80028798844;5405.864853378697;5475.397706252389;5491.670499770026;5506.339239291311 15:48:44 INFO - PROCESS | 1640 | |5;yui.html;698.4761428928304;743.7025189924029;744.05505008639;809.1867672988648;825.9917400825993;12060.216085954407;15318.617034574141;15532.922335388335;16248.51254462368;17234;15764.921175394107;15787;16247.918760406212;16395.098269595168;16525.33898644053;838.4466252273501;839.1356902390517;839.1859895900966;842.1031601344548;842.6250318608222;668.1814776898285;688.102026854954;691.9411849992757;832.0057531250159;832.4797001873828;744.5011842065802;909.417972497602;914.3782228084899;916.9266458683289;919.2508105893709;872.2106493623281;905.4748246017294;906.6962567539882;907.3059109781022;907.564369102831;514.6423235851084;527.6570229350914;674.6727836999052;676.5669971218424;677.8915373540259;14629.6342591435;15188.392464301414;15250.771238431433;15518.922405388013;15546.61133471661;13712.862871371359;13826.792598111037;13874.722505549933;13936.094153880067;13998.300084995812;11219.495122719498;11239.494222759913;11266.605668801634;11810.645680629508;11908.106891983136;3553.4492153716214;3565.5721313442295;3620.837062332201;3683.447482877563;3746.83139258734;102141.4892925538;108704.91295087028;111338;111917.32124018147;113233.43383283031;10150.949245253727;10449.373037617766;10539.473026348653;11119.610813621646;11250.887491124984;22141.89290535499;22401.327960161223;22495.550088998454;22497.775022249567;22546.323610291718;7680.846383072308;7697.153313135551;7742.7677169685;7839.529628222325;8005.359571234288;3982.820773065219;4108.856190033334;4181.91270269726;4405.3612226227015;4483.529229430863;3521.9119522012156;3600.171960449059;3623.166671665532;3633.94549081764;3646;643.8486955565438;649.04590252329;653.6927644007309;656.9835754106185;660.8876490996446;644.6390021587832;664.707528687376;676.3811112831802;681.4718593090296;704.0987535953988;9418.90581094194;9658.806823863484;9948.08703957558;10135.76010741462;10263.58945642166;655.5476721062452;659.788867562385;670.2426258328059;672.3444641474523;680;4361.869143925687;4850.5149485051215;4855.6115510759055;4863.4650188479945;4890.388701412324;96046.51976740212;96268.55597166048;97161;99088.50455747676;99217.50391247998;90262.54868725745;91383.08616913746;93656;94448;94996;61369.386306136366;79511;82319;83302.5834870834;86196.56901715451;9363.250939924654;9520.761980950532;9525.904740952501;9538.570764315484;9545.904540954501;50910.490895090574;51155;51740.48259517357;53215;53233.46766532285;67600.94394336356;68454;70653.94019089614;71096.64451677709;71313;11564.537418503165;11605.245659032136;11694.415279236175;11937.403129843648;12017.459214335551;11959.641210763692;12277;12574.497020119094;12715.237085774514;12922.612321630366;9701.611935522782;11524.654260372203;11557.653270401901;11887.108466865193;12258.877411225774;11591.884081159418;11837.289762614271;12061.336626485627;12102.515899363927;12181.14731968789;10973.945130274298;11306.94346528262;11413.486393112164;11620.360880151673;11732.86278262965;9385.671501497414;9416.210919925192;9757.902420975699;9814.901850981685;9885.258605604464;9677.129058384779;9681.128698417177;9719.9028009719;9740.853887191555;9791.755206119618 15:48:44 INFO - PROCESS | 1640 | __end_tp_report 15:48:44 INFO - PROCESS | 1640 | __start_cc_report 15:48:44 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1828 15:48:44 INFO - PROCESS | 1640 | __end_cc_report 15:48:44 INFO - PROCESS | 1640 | __startTimestamp1488584924137__endTimestamp 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | ------- Summary: start ------- 15:48:44 INFO - PROCESS | 1640 | Number of tests: 6 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5736.61 Median:5940.70 stddev:636.25 (10.7%) stddev-sans-first:610.05 15:48:44 INFO - PROCESS | 1640 | Values: 3350.5 3350.9 3363.7 3364.8 3416.9 5671.2 5725.4 5736.5 5777.5 5786.5 5726.7 5778.2 5782.3 5784.1 5789.1 5239.3 5259.4 5285.0 5291.9 5343.0 5118.7 5126.2 5136.9 5324.1 5340.3 5225.9 5229.3 5263.8 5265.4 5277.4 5256.8 5264.5 5265.8 5266.7 5272.7 5126.7 5209.3 5227.7 5230.8 5238.1 5735.4 5736.6 5745.6 5758.2 5762.0 6148.1 6180.8 6191.8 6200.1 6203.3 6178.3 6215.3 6227.0 6243.1 6249.5 4326.9 5515.3 5764.4 5821.2 5869.7 6264.6 6342.7 6343.2 6343.4 6347.8 6074.6 6078.1 6110.9 6165.3 6187.9 6264.7 6280.8 6281.9 6284.3 6288.5 6211.1 6214.8 6219.7 6247.4 6247.7 6105.6 6178.6 6189.2 6201.3 6286.1 5005.6 5013.9 5023.1 5034.6 5060.4 4457.5 4481.4 4494.3 4517.9 4528.1 5714.8 5725.9 5778.8 5908.9 5918.0 5167.3 5449.4 6250.7 6292.6 6336.1 5731.3 5792.6 5847.9 5871.7 5873.9 5341.6 5459.8 5461.9 5467.9 5469.7 5289.7 6229.5 6243.8 6278.0 6294.7 6138.7 6327.7 6331.8 6349.0 6356.5 6268.0 6275.2 6283.8 6298.1 6302.7 5192.9 6184.7 6284.2 6296.2 6300.2 5354.7 5767.3 6308.1 6311.2 6320.0 5940.7 5941.7 5950.4 6042.3 6051.2 6131.6 6144.2 6153.3 6161.1 6175.7 5998.3 6045.5 6049.0 6051.6 6057.1 5960.5 6045.7 6052.7 6088.4 6166.4 5906.7 5990.6 5992.6 6016.1 6039.6 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:68083.79 Median:21464.16 stddev:144940.67 (675.3%) stddev-sans-first:145258.27 15:48:44 INFO - PROCESS | 1640 | Values: 434.4 463.1 510.7 519.2 533.8 30627.8 39254.4 40835.6 40885.6 41143.4 42694.0 43048.9 43101.6 43192.4 43316.4 9212.9 9373.8 9414.5 9415.8 9419.3 8250.8 8479.7 8490.8 8572.0 8576.1 9518.5 11072.3 11344.9 11464.5 11485.5 11137.7 11190.0 11256.5 11285.3 11303.0 8329.6 11080.5 11171.4 11173.8 11180.9 31369.5 39754.2 40377.0 40622.0 42503.6 3923.3 3924.2 3930.4 3944.6 3964.5 25756.4 29852.7 29919.0 29954.6 30774.0 3160.9 3178.7 3192.8 3200.8 3222.3 489371.0 491689.0 491755.0 492569.0 493718.1 57834.1 57940.0 59387.4 59433.0 59478.4 63731.7 63805.0 63809.7 63818.7 63861.4 16102.2 16689.6 16746.9 16756.5 16797.8 13003.3 13124.7 13130.3 13135.0 13156.5 14322.2 14710.3 15617.8 16194.5 16278.1 6262.4 6492.4 7493.6 7534.5 7683.0 868.8 891.9 894.9 918.9 930.3 28936.3 29952.6 30176.8 30224.5 30438.7 1066.3 1071.8 1102.3 1113.8 1119.9 14752.5 15076.8 15428.8 15526.4 15616.7 599857.0 605734.0 605975.0 606852.0 608230.0 59626.7 59962.4 60017.8 60041.4 60084.7 1419.4 1464.5 1478.8 1481.8 1482.5 26697.9 29148.7 29456.4 29751.4 29766.7 50286.5 50553.0 50564.0 50688.7 50782.0 523567.0 527692.0 527718.0 529441.0 529490.0 38453.5 38959.0 39446.6 39667.4 39789.6 46075.5 46308.1 46633.8 46723.5 46931.8 37112.1 37235.4 37654.8 38744.0 39005.0 37668.4 38190.8 38719.2 38971.0 39283.4 31222.7 36387.0 36852.4 37343.9 37730.8 31854.0 32651.3 32865.5 33680.0 33958.5 20510.8 24769.1 24784.5 24809.1 24948.6 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:40185.78 Median:26123.87 stddev:122475.20 (468.8%) stddev-sans-first:122782.26 15:48:44 INFO - PROCESS | 1640 | Values: 352.8 368.3 382.2 396.1 418.8 15060.8 15175.9 17451.4 17652.4 21066.2 21065.6 21344.8 21669.0 21720.2 21726.3 5584.5 5656.6 5755.7 5910.1 5918.3 5778.6 5822.7 5839.9 5849.3 5890.1 4195.5 4408.0 6256.0 6510.3 6584.5 6378.4 6560.0 6616.2 6629.7 6639.4 5761.4 5788.4 5792.8 5798.7 5813.1 25878.0 26113.7 26134.0 26167.9 26530.2 2706.0 2808.9 2814.6 2816.7 2821.2 14729.4 15043.9 15169.4 15822.8 15871.3 1762.5 1788.6 1798.5 1810.4 1811.2 122330.4 124357.0 125118.0 126940.0 129862.0 11191.3 11641.2 11693.5 11707.5 11854.5 14280.4 14726.8 14750.2 14758.7 14834.6 8449.7 8514.4 8721.2 8790.4 8884.0 8669.5 8682.3 8689.9 8855.1 8864.1 7118.1 7239.9 7251.0 7254.3 7266.3 1909.3 1928.9 1939.4 1945.0 1945.3 679.4 846.2 868.5 875.1 883.5 22326.9 23019.7 23274.9 23341.5 23439.5 940.3 949.8 950.7 951.2 966.2 11282.0 12055.3 12244.3 12287.4 12325.3 677097.0 730784.0 748044.3 750841.0 778760.0 134283.0 135471.0 138781.0 150010.0 153934.0 1012.7 1054.6 1067.6 1073.8 1075.9 15861.8 19600.8 20346.1 20359.3 20364.8 57541.1 57819.0 60676.1 60993.7 62932.5 78522.0 80834.0 80954.0 81854.2 83220.0 8000.0 8049.6 8170.3 8649.4 8709.3 13153.5 13193.5 13457.1 13606.2 13719.7 8209.8 11605.9 11716.5 11834.8 11867.6 11138.1 11310.6 11328.1 11680.0 11830.0 11205.8 11392.3 11513.5 11761.7 11902.2 8182.9 8305.0 8424.7 8457.0 8670.2 10839.4 11012.7 11182.0 11295.9 11435.5 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5395.23 Median:5238.86 stddev:2916.71 (55.7%) stddev-sans-first:2909.55 15:48:44 INFO - PROCESS | 1640 | Values: 1415.1 1431.2 1446.9 1455.1 1458.9 7998.2 8439.2 8449.6 8458.2 8461.7 7241.3 7475.7 7480.7 7954.1 8147.0 2292.8 2333.0 2334.2 2338.7 2341.4 2321.6 2364.2 2366.9 2377.7 2379.6 2048.1 2294.4 2317.5 2349.1 2353.8 2277.1 2290.5 2297.4 2311.4 2318.7 2335.9 2365.1 2365.1 2366.2 2368.4 8214.8 8271.8 8299.6 8300.9 8309.4 4999.4 5156.4 5160.0 5165.3 5172.1 3254.7 3273.6 3452.8 3523.4 3530.1 1139.3 1163.6 1207.3 1208.6 1214.0 10688.4 10768.4 10773.1 10786.4 10787.7 4353.2 4591.5 4606.4 4634.9 4685.7 9387.6 9455.3 9468.6 9477.3 9483.7 5226.1 5232.5 5238.1 5239.6 5241.6 4247.9 4369.6 4596.8 4682.8 4756.5 3819.6 3847.2 3944.9 3951.9 3957.9 1114.1 1252.6 1271.8 1275.4 1293.9 780.8 862.4 902.7 906.4 925.1 5518.1 5537.3 5621.7 5751.3 5813.2 900.4 965.8 974.6 976.5 1008.4 3130.7 3713.9 3808.4 3909.3 3937.2 9751.5 9937.9 9987.1 9996.4 10048.2 9322.9 9777.3 9946.8 9951.7 9961.2 7681.8 7892.3 7897.2 7897.8 7911.6 4500.5 5556.2 5573.3 5813.5 5846.2 8204.2 8910.8 8963.6 8980.3 9275.3 8330.7 9146.2 9255.2 9435.0 9512.6 6570.4 6717.2 7157.9 7287.9 7294.7 7515.4 7839.1 7936.2 8059.8 8061.5 6972.7 7050.9 7092.7 7119.5 7220.6 6883.3 6906.5 6931.5 6944.8 6979.1 6238.0 6332.4 6427.8 6434.0 6440.5 4925.2 4931.9 4961.0 4971.3 5010.7 4873.7 4917.2 4921.9 5007.7 5050.2 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4469.37 Median:4877.46 stddev:1334.08 (27.4%) stddev-sans-first:1301.55 15:48:44 INFO - PROCESS | 1640 | Values: 352.5 357.3 362.4 373.7 374.6 5071.6 5277.6 5293.5 5383.4 5411.0 4302.4 4750.2 4842.9 5349.3 5362.8 3834.4 4001.4 4102.3 4168.3 4193.4 3313.1 3676.2 3749.7 4194.6 4240.4 3244.8 3536.3 4138.9 4151.2 4176.1 3734.4 3745.0 3876.7 4029.2 4127.7 3701.9 3709.5 3717.3 3727.3 3742.6 4298.7 5035.6 5172.7 5181.2 5224.9 4294.8 4514.7 4788.4 4813.7 4829.9 5581.8 5596.0 5600.8 5643.3 5647.2 3181.3 3448.3 3597.8 4012.4 4082.9 4331.0 4999.3 5839.8 5853.3 5879.4 4135.6 4153.6 4156.6 4159.3 4170.8 3916.8 4156.9 4189.7 4208.7 4229.4 4699.7 4727.0 4731.3 4745.8 4755.4 4690.9 5571.5 5615.9 5624.1 5653.5 1111.8 1199.2 1200.6 1316.5 1349.7 826.7 956.9 960.5 971.3 983.6 4502.9 4648.8 4768.7 4768.8 5029.3 4731.1 5348.1 5508.3 5528.8 5549.7 4536.3 4806.8 4944.2 4954.8 4994.4 2578.4 2810.7 2866.4 2873.8 2883.4 4484.2 4737.6 5363.5 5514.3 5637.8 5007.5 5543.9 5610.7 5640.4 5680.6 4885.6 5633.9 5713.8 5717.9 5734.6 4449.0 5406.6 5417.5 5447.8 5449.3 4529.6 4650.9 5420.7 5451.7 5503.8 5560.9 5598.0 5698.1 5699.5 5719.0 3767.9 3841.7 3860.8 3872.7 3878.4 5083.4 5292.4 5434.5 5669.7 5814.9 4670.1 5148.0 5627.9 5628.9 5660.3 5588.3 5664.2 5669.3 5674.4 5676.4 4739.5 4869.3 4907.3 5374.5 5420.7 4907.4 5350.8 5536.7 5541.9 5583.5 4992.8 5405.9 5475.4 5491.7 5506.3 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20390.05 Median:26871.33 stddev:29853.31 (111.1%) stddev-sans-first:29900.44 15:48:44 INFO - PROCESS | 1640 | Values: 698.5 743.7 744.1 809.2 826.0 12060.2 15318.6 15532.9 16248.5 17234.0 15764.9 15787.0 16247.9 16395.1 16525.3 838.4 839.1 839.2 842.1 842.6 668.2 688.1 691.9 832.0 832.5 744.5 909.4 914.4 916.9 919.3 872.2 905.5 906.7 907.3 907.6 514.6 527.7 674.7 676.6 677.9 14629.6 15188.4 15250.8 15518.9 15546.6 13712.9 13826.8 13874.7 13936.1 13998.3 11219.5 11239.5 11266.6 11810.6 11908.1 3553.4 3565.6 3620.8 3683.4 3746.8 102141.5 108704.9 111338.0 111917.3 113233.4 10150.9 10449.4 10539.5 11119.6 11250.9 22141.9 22401.3 22495.6 22497.8 22546.3 7680.8 7697.2 7742.8 7839.5 8005.4 3982.8 4108.9 4181.9 4405.4 4483.5 3521.9 3600.2 3623.2 3633.9 3646.0 643.8 649.0 653.7 657.0 660.9 644.6 664.7 676.4 681.5 704.1 9418.9 9658.8 9948.1 10135.8 10263.6 655.5 659.8 670.2 672.3 680.0 4361.9 4850.5 4855.6 4863.5 4890.4 96046.5 96268.6 97161.0 99088.5 99217.5 90262.5 91383.1 93656.0 94448.0 94996.0 61369.4 79511.0 82319.0 83302.6 86196.6 9363.3 9520.8 9525.9 9538.6 9545.9 50910.5 51155.0 51740.5 53215.0 53233.5 67600.9 68454.0 70653.9 71096.6 71313.0 11564.5 11605.2 11694.4 11937.4 12017.5 11959.6 12277.0 12574.5 12715.2 12922.6 9701.6 11524.7 11557.7 11887.1 12258.9 11591.9 11837.3 12061.3 12102.5 12181.1 10973.9 11306.9 11413.5 11620.4 11732.9 9385.7 9416.2 9757.9 9814.9 9885.3 9677.1 9681.1 9719.9 9740.9 9791.8 15:48:44 INFO - PROCESS | 1640 | -------- Summary: end -------- 15:48:44 INFO - PROCESS | 1640 | 15:48:44 INFO - TEST-INFO | 1640: exit 0 15:48:44 INFO - TEST-OK | dromaeo_css | took 1118800ms 15:48:44 INFO - TEST-START | kraken 15:48:44 INFO - operating with platform_type : mac_ 15:48:44 INFO - Initialising browser for kraken test... 15:48:44 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpcvdg5s/profile http://localhost:49241/getInfo.html) 15:48:47 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 15:48:47 INFO - PROCESS | 1649 | colorDepth:24 15:48:47 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 15:48:47 INFO - PROCESS | 1649 | __metrics 15:48:47 INFO - PROCESS | 1649 | 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" 15:48:47 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:48 INFO - TEST-INFO | 1649: exit 0 15:48:48 INFO - Browser initialized. 15:48:48 INFO - Running cycle 1/1 for kraken test... 15:48:48 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpcvdg5s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:00 INFO - PROCESS | 1650 | RSS: Main: 213127168 15:49:00 INFO - PROCESS | 1650 | 15:49:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 15:49:03 INFO - PROCESS | 1650 | RSS: Main: 265396224 15:49:03 INFO - PROCESS | 1650 | 15:49:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 15:49:06 INFO - PROCESS | 1650 | RSS: Main: 274243584 15:49:06 INFO - PROCESS | 1650 | 15:49:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 15:49:10 INFO - PROCESS | 1650 | RSS: Main: 371781632 15:49:10 INFO - PROCESS | 1650 | 15:49:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 15:49:13 INFO - PROCESS | 1650 | RSS: Main: 275398656 15:49:13 INFO - PROCESS | 1650 | 15:49:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:49:16 INFO - PROCESS | 1650 | RSS: Main: 278069248 15:49:16 INFO - PROCESS | 1650 | 15:49:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 15:49:19 INFO - PROCESS | 1650 | RSS: Main: 318607360 15:49:19 INFO - PROCESS | 1650 | 15:49:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 15:49:23 INFO - PROCESS | 1650 | RSS: Main: 318779392 15:49:23 INFO - PROCESS | 1650 | 15:49:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 15:49:26 INFO - PROCESS | 1650 | RSS: Main: 317616128 15:49:26 INFO - PROCESS | 1650 | 15:49:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:49:28 INFO - PROCESS | 1650 | RSS: Main: 294539264 15:49:28 INFO - PROCESS | 1650 | 15:49:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:49:31 INFO - PROCESS | 1650 | RSS: Main: 297930752 15:49:31 INFO - PROCESS | 1650 | 15:49:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:49:34 INFO - PROCESS | 1650 | RSS: Main: 304979968 15:49:34 INFO - PROCESS | 1650 | 15:49:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:49:38 INFO - PROCESS | 1650 | RSS: Main: 316403712 15:49:38 INFO - PROCESS | 1650 | 15:49:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:49:41 INFO - PROCESS | 1650 | RSS: Main: 309944320 15:49:41 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 15:49:43 INFO - PROCESS | 1650 | RSS: Main: 354496512 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | __start_tp_report 15:49:43 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 15:49:43 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 15:49:43 INFO - PROCESS | 1650 | |i|pagename|runs| 15:49:43 INFO - PROCESS | 1650 | |0;ai-astar;115;115;112;114;113;114;114;115;114;114 15:49:43 INFO - PROCESS | 1650 | |1;audio-beat-detection;145;107;108;145;111;110;111;107;130;109 15:49:43 INFO - PROCESS | 1650 | |2;audio-dft;198;260;204;183;184;186;183;184;185;183 15:49:43 INFO - PROCESS | 1650 | |3;audio-fft;82;58;58;89;75;81;81;80;74;58 15:49:43 INFO - PROCESS | 1650 | |4;audio-oscillator;92;92;118;83;68;68;81;68;68;84 15:49:43 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;88;88;93;131;134;86;90;88;89;87 15:49:43 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;96;95;96;96;95;95;96;94;95 15:49:43 INFO - PROCESS | 1650 | |7;imaging-desaturate;127;139;87;86;87;87;85;86;88;86 15:49:43 INFO - PROCESS | 1650 | |8;json-parse-financial;58;56;53;54;54;57;58;56;57;57 15:49:43 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;65;68;79;75;72;67;67;67;68;68 15:49:43 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;86;97;105;104;83;82;84;85;85;89 15:49:43 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;141;156;147;123;146;147;156;138;185;141 15:49:43 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;165;167;165;166;176;228;197;169;166;166 15:49:43 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;66;67;65;65;63;65;64;66;65 15:49:43 INFO - PROCESS | 1650 | __end_tp_report 15:49:43 INFO - PROCESS | 1650 | __start_cc_report 15:49:43 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2156 15:49:43 INFO - PROCESS | 1650 | __end_cc_report 15:49:43 INFO - PROCESS | 1650 | __startTimestamp1488584983703__endTimestamp 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | ------- Summary: start ------- 15:49:43 INFO - PROCESS | 1650 | Number of tests: 14 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 15:49:43 INFO - PROCESS | 1650 | Values: 115.0 115.0 112.0 114.0 113.0 114.0 114.0 115.0 114.0 114.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:111.00 stddev:15.59 (14.0%) stddev-sans-first:13.20 15:49:43 INFO - PROCESS | 1650 | Values: 145.0 107.0 108.0 145.0 111.0 110.0 111.0 107.0 130.0 109.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:195.00 Median:185.50 stddev:23.97 (12.9%) stddev-sans-first:25.40 15:49:43 INFO - PROCESS | 1650 | Values: 198.0 260.0 204.0 183.0 184.0 186.0 183.0 184.0 185.0 183.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:73.60 Median:80.50 stddev:11.50 (14.3%) stddev-sans-first:11.79 15:49:43 INFO - PROCESS | 1650 | Values: 82.0 58.0 58.0 89.0 75.0 81.0 81.0 80.0 74.0 58.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:82.00 stddev:15.94 (19.4%) stddev-sans-first:16.50 15:49:43 INFO - PROCESS | 1650 | Values: 92.0 92.0 118.0 83.0 68.0 68.0 81.0 68.0 68.0 84.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:88.00 stddev:18.61 (21.1%) stddev-sans-first:19.42 15:49:43 INFO - PROCESS | 1650 | Values: 88.0 88.0 93.0 131.0 134.0 86.0 90.0 88.0 89.0 87.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 15:49:43 INFO - PROCESS | 1650 | Values: 94.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 94.0 95.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:86.50 stddev:19.83 (22.9%) stddev-sans-first:17.52 15:49:43 INFO - PROCESS | 1650 | Values: 127.0 139.0 87.0 86.0 87.0 87.0 85.0 86.0 88.0 86.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.76 (3.1%) stddev-sans-first:1.72 15:49:43 INFO - PROCESS | 1650 | Values: 58.0 56.0 53.0 54.0 54.0 57.0 58.0 56.0 57.0 57.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:68.00 stddev:4.38 (6.4%) stddev-sans-first:4.31 15:49:43 INFO - PROCESS | 1650 | Values: 65.0 68.0 79.0 75.0 72.0 67.0 67.0 67.0 68.0 68.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:85.00 stddev:8.73 (10.3%) stddev-sans-first:9.14 15:49:43 INFO - PROCESS | 1650 | Values: 86.0 97.0 105.0 104.0 83.0 82.0 84.0 85.0 85.0 89.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:147.00 stddev:16.08 (10.9%) stddev-sans-first:16.85 15:49:43 INFO - PROCESS | 1650 | Values: 141.0 156.0 147.0 123.0 146.0 147.0 156.0 138.0 185.0 141.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:168.00 stddev:20.59 (12.3%) stddev-sans-first:21.41 15:49:43 INFO - PROCESS | 1650 | Values: 165.0 167.0 165.0 166.0 176.0 228.0 197.0 169.0 166.0 166.0 15:49:43 INFO - PROCESS | 1650 | 15:49:43 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.17 15:49:43 INFO - PROCESS | 1650 | Values: 67.0 66.0 67.0 65.0 65.0 63.0 65.0 64.0 66.0 65.0 15:49:43 INFO - PROCESS | 1650 | -------- Summary: end -------- 15:49:43 INFO - PROCESS | 1650 | 15:49:44 INFO - TEST-INFO | 1650: exit 0 15:49:44 INFO - TEST-OK | kraken | took 59920ms 15:49:44 INFO - SUITE-END | took 1178s 15:49:44 INFO - Completed test suite (00:19:38) 15:49:44 INFO - javascript benchmark 15:49:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.4806754952992, 3350.9162270943225, 3363.6804503572152, 3364.764466487347, 3416.940748368006, 5671.2060311556415, 5725.370209276986, 5736.512396446296, 5777.508911742497, 5786.479216870481, 5726.7422965966525, 5778.219940308068, 5782.277215348082, 5784.132380142981, 5789.131630255464, 5239.266502689627, 5259.447757985405, 5284.973575132138, 5291.86770330741, 5342.973285133569, 5118.718470484122, 5126.231065340192, 5136.922946155811, 5324.1215199492035, 5340.25236466895, 5225.921611175835, 5229.267902493654, 5263.76313065911, 5265.394479634833, 5277.366715994086, 5256.763445644936, 5264.499872512143, 5265.7893684252585, 5266.736663166846, 5272.736363181825, 5126.71803050832, 5209.322788037531, 5227.738613069331, 5230.764615592308, 5238.13570760824, 5735.426457354231, 5736.598438109334, 5745.597808153431, 5758.193852860602, 5762.0, 6148.108524264001, 6180.84547886302, 6191.845203869894, 6200.069989501566, 6203.255609326865, 6178.258608966908, 6215.28524219716, 6227.0036794113175, 6243.094751261042, 6249.500039996835, 4326.935095973563, 5515.31782806244, 5764.394738552475, 5821.15593238978, 5869.677167755772, 6264.561480696399, 6342.746290148342, 6343.175387199681, 6343.365663433666, 6347.841303967438, 6074.605150665193, 6078.0882867569335, 6110.908336374958, 6165.260168779775, 6187.907181392283, 6264.686765661699, 6280.842978925563, 6281.937180628135, 6284.308726040132, 6288.465480434123, 6211.068339749074, 6214.751409943552, 6219.689015549205, 6247.406496382836, 6247.718852651642, 6105.558094708146, 6178.598391104653, 6189.195404597373, 6201.317855036033, 6286.119943207955, 5005.624578156653, 5013.924791128136, 5023.120953833065, 5034.647574669738, 5060.443351231362, 4457.465104187519, 4481.3726078349055, 4494.258447356215, 4517.932231016537, 4528.139653465831, 5714.79998200061, 5725.914111288334, 5778.797742079007, 5908.852278693067, 5917.993941030035, 5167.302414174113, 5449.373322068013, 6250.718717657716, 6292.559520833498, 6336.112944187817, 5731.340895796953, 5792.594518383673, 5847.9415205848245, 5871.6770577618645, 5873.911891321633, 5341.599380046434, 5459.754311056012, 5461.863453413696, 5467.890642187134, 5469.671819690831, 5289.709066001253, 6229.470495007975, 6243.7814676486105, 6278.0269058296035, 6294.65379404128, 6138.664296166039, 6327.746890124344, 6331.841703957253, 6349.0476428536085, 6356.459700925473, 6268.0, 6275.184226050585, 6283.8114856554375, 6298.149749783721, 6302.747890084529, 5192.948070519246, 6184.6598437086395, 6284.151639528788, 6296.212973378328, 6300.21247344082, 5354.732263386893, 5767.307923049261, 6308.116863639186, 6311.2426508819235, 6319.96840015797, 5940.702964851826, 5941.732622032106, 5950.434708702666, 6042.2749270086115, 6051.152838602511, 6131.590761709946, 6144.201253837151, 6153.323134455296, 6161.137440758208, 6175.6912154393, 5998.25021872266, 6045.455908968038, 6049.0, 6051.636901785907, 6057.121717351048, 5960.493358064613, 6045.697715114315, 6052.727627256696, 6088.391160883876, 6166.414190651881, 5906.70466476683, 5990.610610310316, 5992.64044157352, 6016.127661489147, 6039.607425517327], "value": 5698.052478033075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.42221844946215, 463.1431851075513, 510.69103192568497, 519.1511878079339, 533.8478533617917, 30627.846860765694, 39254.411183832264, 40835.59164408351, 40885.59114408855, 41143.38284925729, 42694.0, 43048.92377690552, 43101.56898431015, 43192.352114718306, 43316.350254746205, 9212.907870921288, 9373.81252374952, 9414.482203478807, 9415.764605884873, 9419.340646154771, 8250.83498330033, 8479.66081356745, 8490.787730306762, 8572.0, 8576.0995095515, 9518.476483793389, 11072.280301780398, 11344.886551134465, 11464.541418343299, 11485.483153258081, 11137.665870023913, 11190.0, 11256.54973801047, 11285.322880627147, 11303.0, 8329.625166867505, 11080.501377438035, 11171.385573793437, 11173.83239251412, 11180.944095279552, 31369.52945705816, 39754.20491590152, 40377.0, 40621.98445038868, 42503.57496425058, 3923.3134201514904, 3924.1759230561615, 3930.430087637305, 3944.5666212867095, 3964.4647972523917, 25756.356091097685, 29852.701472985427, 29919.0, 29954.55068173979, 30774.0, 3160.8577614007427, 3178.7457003439667, 3192.8403579821147, 3200.8399580020905, 3222.2910959588853, 489371.0, 491689.0, 491755.0, 492569.0, 493718.0628193744, 57834.132488012714, 57940.0, 59387.406125938185, 59432.999999999134, 59478.405215947285, 63731.681341592994, 63805.0, 63809.68095159494, 63818.68090659517, 63861.36138638554, 16102.19489025544, 16689.582760430843, 16746.91626541884, 16756.497305080866, 16797.832021679627, 13003.284819334838, 13124.737505249841, 13130.277834719182, 13135.0, 13156.473741050251, 14322.212278324792, 14710.33803478846, 15617.843821561639, 16194.514164575081, 16278.104704241143, 6262.436380725665, 6492.415682588589, 7493.587852668046, 7534.510256833289, 7682.962800022037, 868.8436081505263, 891.892972843263, 894.9194572488377, 918.875951746519, 930.251147825993, 28936.27659308492, 29952.550711739343, 30176.84911575428, 30224.546631800542, 30438.69561304403, 1066.2802608239408, 1071.8285074388216, 1102.327580176092, 1113.8329250612474, 1119.9160062995309, 14752.462402826048, 15076.773848392282, 15428.768568471482, 15526.433358153388, 15616.687666246838, 599857.0, 605734.0, 605975.0, 606851.9657401773, 608230.0, 59626.70186649126, 59962.400375996556, 60017.799644006875, 60041.39958600445, 60084.69957650271, 1419.4464158978008, 1464.4581504843277, 1478.8003619511228, 1481.7777333400077, 1482.5404124721372, 26697.86651066732, 29148.7085129146, 29456.397463881465, 29751.404971900007, 29766.70233297726, 50286.49713502965, 50553.0, 50564.0, 50688.74655626698, 50782.0, 523567.0, 527692.0, 527718.0, 529441.0, 529490.0, 38453.530566516805, 38959.0, 39446.60553394429, 39667.404988925766, 39789.60210397975, 46075.53924460713, 46308.07383852371, 46633.76683116562, 46723.532764671916, 46931.76534117308, 37112.07219819526, 37235.441468378536, 37654.811725941196, 38744.0, 39005.0, 37668.43497347487, 38190.80904595459, 38719.225615488096, 38971.02572435712, 39283.410748839364, 31222.687773122885, 36387.0, 36852.447213291285, 37343.87968360845, 37730.8113459431, 31854.0, 32651.34697305993, 32865.50701739428, 33680.0, 33958.49062264118, 20510.79489205089, 24769.110826802877, 24784.50430991334, 24809.1316803911, 24948.625770613817], "value": 20052.08225542389, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.8341679410677, 368.3296400550995, 382.2126419575674, 396.1008510680754, 418.7906046976512, 15060.84939150608, 15175.9376843621, 17451.389201377955, 17652.38216662417, 21066.157353705832, 21065.578688426223, 21344.786552134476, 21669.0, 21720.2397916073, 21726.3482095537, 5584.469475399851, 5656.575756818234, 5755.740991655385, 5910.0543912973935, 5918.2898052233795, 5778.595498315099, 5822.737976791033, 5839.9124013139835, 5849.327327357366, 5890.087036509327, 4195.496540415139, 4407.955920440787, 6256.0, 6510.251321098063, 6584.473242140642, 6378.362163783631, 6559.950407934755, 6616.206055273374, 6629.73481060757, 6639.402453779159, 5761.366249712528, 5788.363280039192, 5792.797252096157, 5798.681072541009, 5813.098969659667, 25877.96488140472, 26113.73886261132, 26134.0, 26167.869160654074, 26530.204093877215, 2705.9729402705916, 2808.9016884408948, 2814.6340975673033, 2816.662000559925, 2821.2382656682785, 14729.410823567045, 15043.924780376028, 15169.393224271016, 15822.841771582367, 15871.28579213938, 1762.4624489530688, 1788.6243888783372, 1798.5144011116925, 1810.36637176987, 1811.1759149586906, 122330.38834805858, 124357.0, 125118.0, 126940.0, 129862.0, 11191.32852028881, 11641.243319184226, 11693.473793679304, 11707.473163707653, 11854.525818967317, 14280.428782848778, 14726.779098313535, 14750.188739619423, 14758.704825903422, 14834.62913427173, 8449.74650760466, 8514.446560973642, 8721.215090641872, 8790.384673072824, 8883.955580222058, 8669.479831210148, 8682.262007729287, 8689.913100869036, 8855.096154326851, 8864.113588641214, 7118.074650295532, 7239.8552028960175, 7251.0, 7254.347108760131, 7266.309700578542, 1909.312647446918, 1928.8746231494908, 1939.3890924358782, 1944.9708254376196, 1945.2608008956506, 679.4360680635061, 846.1834329871704, 868.4702331577859, 875.1161327059716, 883.4787475389551, 22326.88836555807, 23019.654705179102, 23274.883625581762, 23341.53316933652, 23439.531209375717, 940.3464592108555, 949.7578117580111, 950.7052813627797, 951.177231694593, 966.1546147121269, 11281.984621384116, 12055.336956467303, 12244.326562039174, 12287.447064882102, 12325.322107284006, 677097.0, 730784.0, 748044.2597786976, 750841.0, 778760.0, 134283.0, 135471.0, 138781.0, 150010.0, 153934.0, 1012.7113772574928, 1054.5718705060974, 1067.5729708116814, 1073.8174510333263, 1075.876274228458, 15861.762073568674, 19600.803991960467, 20346.08442620056, 20359.287424940056, 20364.79635203629, 57541.13688294763, 57819.0, 60676.08985865127, 60993.695031524556, 62932.48270069146, 78522.0, 80834.0, 80954.0, 81854.18145818466, 83220.0, 8000.039990202437, 8049.637766300648, 8170.3055240302865, 8649.351298652751, 8709.259712924473, 13153.473861045833, 13193.538226162038, 13457.125286856322, 13606.183628982293, 13719.657008574866, 8209.79475513117, 11605.941970290094, 11716.531338746354, 11834.763304733684, 11867.643970680894, 11138.053265472525, 11310.604128855779, 11328.093752499944, 11680.0, 11830.0, 11205.775884482102, 11392.316461012366, 11513.481893314653, 11761.705957351134, 11902.166848320534, 8182.877256841271, 8305.0, 8424.705135320235, 8456.95771521163, 8670.219680228809, 10839.403832789272, 11012.724681883017, 11182.0, 11295.887041129812, 11435.542578297107], "value": 10138.793153150542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.1150696570621, 1431.1985288238586, 1446.9131852088876, 1455.1196526101708, 1458.9197594132324, 7998.240167184115, 8439.185575101352, 8449.57752112395, 8458.238758511732, 8461.661533538667, 7241.312075352833, 7475.738349157767, 7480.700771969115, 7954.125046244909, 8146.959265203681, 2292.805111565515, 2332.988335058331, 2334.1947028275217, 2338.7193536775526, 2341.379534423379, 2321.6169332060276, 2364.1725396111397, 2366.881655917206, 2377.714674239085, 2379.6311571706415, 2048.0988365119374, 2294.4149241943364, 2317.4669825940045, 2349.0603758496654, 2353.8116950643994, 2277.0664027748626, 2290.461741490765, 2297.437127903666, 2311.3528212100637, 2318.652202169688, 2335.894884730174, 2365.077619728307, 2365.0894405653776, 2366.183666635008, 2368.39605900496, 8214.794630134234, 8271.834563308761, 8299.585020748998, 8300.916990830136, 8309.418340716153, 4999.4250661174065, 5156.407013193456, 5159.968006398698, 5165.302684137669, 5172.094883395391, 3254.7070763631386, 3273.623533293678, 3452.792832430037, 3523.40102182627, 3530.135116896377, 1139.2765593847882, 1163.5694792926672, 1207.3178654060428, 1208.576998050684, 1213.9635810925597, 10688.412137332443, 10768.407737574431, 10773.138148947986, 10786.352818830896, 10787.67636970892, 4353.194658988034, 4591.517890621503, 4606.401167848158, 4634.930476042795, 4685.695429797052, 9387.57755900986, 9455.338126331091, 9468.57391417388, 9477.28920330978, 9483.66807161746, 5226.059309324358, 5232.529072383504, 5238.083335416287, 5239.633225674243, 5241.554467870197, 4247.872563823028, 4369.563043695605, 4596.770161491912, 4682.81268749253, 4756.548127927841, 3819.618038196158, 3847.211321679049, 3944.9211015779524, 3951.881443556698, 3957.940630890539, 1114.0586204657052, 1252.6054292897709, 1271.8219449276924, 1275.3930048139412, 1293.8835504804613, 780.8070660552868, 862.4480332587149, 902.7291812456368, 906.4425378392241, 925.1396201532505, 5518.089515230023, 5537.335519737577, 5621.7189140542805, 5751.298953855997, 5813.157092221689, 900.3697411811758, 965.7633879699519, 974.6150270643057, 976.4873441443299, 1008.3748076192808, 3130.7495400367916, 3713.9257214856093, 3808.447775072599, 3909.3354129798004, 3937.1928754605237, 9751.512424378752, 9937.900620993842, 9987.101160895554, 9996.400215987063, 10048.246381521416, 9322.906770932339, 9777.266704997153, 9946.801063978824, 9951.701448956543, 9961.203103751683, 7681.846363072707, 7892.250236227549, 7897.24976127267, 7897.802554936173, 7911.604419778988, 4500.5274446182675, 5556.16657501378, 5573.27547418833, 5813.505852002627, 5846.239988801599, 8204.179582041748, 8910.777230569287, 8963.59663815143, 8980.281577473917, 9275.2579793615, 8330.708425205088, 9146.222571081267, 9255.167034966886, 9435.009324020879, 9512.571934262836, 6570.375814297634, 6717.16035495563, 7157.85684286301, 7287.890681639674, 7294.671739771617, 7515.39876809843, 7839.05931288249, 7936.246056624612, 8059.798505037421, 8061.4760040597175, 6972.686229119803, 7050.858982820418, 7092.716291348288, 7119.501634885508, 7220.566765994057, 6883.27725588806, 6906.516543841883, 6931.549449285781, 6944.756933507303, 6979.127609048869, 6238.0, 6332.398422149889, 6427.807165784847, 6433.967830160819, 6440.484761218998, 4925.21196608541, 4931.926021109758, 4961.0, 4971.254311853251, 5010.674306170087, 4873.707577545359, 4917.188663870421, 4921.926171107508, 5007.69953802773, 5050.191969284897], "value": 4400.355907060017, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.51001108459246, 357.2640360856636, 362.3749032918216, 373.71037445979346, 374.5728773373447, 5071.619628527857, 5277.604179686525, 5293.497117773805, 5383.380911195214, 5410.996896722318, 4302.440682711251, 4750.192467280562, 4842.878928026801, 5349.255521135202, 5362.785488580462, 3834.4440056191834, 4001.3797861331395, 4102.302608556538, 4168.270167880326, 4193.391958166064, 3313.1385839681616, 3676.1728611062563, 3749.700023998087, 4194.643455306303, 4240.427542281799, 3244.8377581120967, 3536.3104194682046, 4138.8965275868195, 4151.2112698587325, 4176.143890502455, 3734.3838266685966, 3745.0, 3876.6898648108086, 4029.174019326031, 4127.731697439672, 3701.8524257480267, 3709.517762690833, 3717.290046578577, 3727.329080765461, 3742.559114740817, 4298.742075475481, 5035.597152227813, 5172.66377685453, 5181.222816577506, 5224.8650809514365, 4294.785260736982, 4514.706544074625, 4788.449328327218, 4813.711177329372, 4829.855104346875, 5581.8457729323945, 5595.972020139914, 5600.8319750407145, 5643.322801263834, 5647.209390685307, 3181.347823696137, 3448.327576122657, 3597.8380972856285, 4012.3981402789523, 4082.9183416331803, 4330.956690433087, 4999.250112483121, 5839.7664093436215, 5853.312413179669, 5879.353271140214, 4135.56576559463, 4153.584641535822, 4156.56356082613, 4159.334506478949, 4170.791460426966, 3916.823742931575, 4156.875293741193, 4189.685773566995, 4208.695304455568, 4229.365595160751, 4699.741514216751, 4726.983698504838, 4731.2903064539905, 4745.83389581363, 4755.405574303212, 4690.929636055462, 5571.470710282517, 5615.8596035098635, 5624.100143977026, 5653.547716182696, 1111.7554138089608, 1199.196538319328, 1200.6338066889507, 1316.5457917018805, 1349.6773162300804, 826.6734639817358, 956.8661136553206, 960.4573416019927, 971.3491960386558, 983.593461350276, 4502.932456013163, 4648.790804413809, 4768.666193366431, 4768.7601223681395, 5029.2958985742025, 4731.090379416634, 5348.144296912553, 5508.338999320107, 5528.778848846082, 5549.67019788132, 4536.274196128604, 4806.831760888422, 4944.2288191894995, 4954.826581069645, 4994.400671919393, 2578.4456341886207, 2810.723314115573, 2866.4091429256964, 2873.84193869335, 2883.3944871577205, 4484.2376795944765, 4737.620990320766, 5363.490468405495, 5514.338279406497, 5637.774489020393, 5007.474215207423, 5543.891221755665, 5610.691411972381, 5640.435956404327, 5680.6307590007345, 4885.60915126789, 5633.887322253532, 5713.771449141987, 5717.942820571741, 5734.598578099576, 4448.966562924032, 5406.648567843235, 5417.539509141767, 5447.809326673548, 5449.329828384142, 4529.569690879362, 4650.906981860411, 5420.723296215678, 5451.727413629382, 5503.834884953458, 5560.860978475571, 5597.972010139923, 5698.088305871041, 5699.458551437607, 5718.971405142947, 3767.868124615625, 3841.654251117413, 3860.80695965195, 3872.7482713623526, 3878.398848178537, 5083.364579427572, 5292.41783403833, 5434.483724046209, 5669.659820410789, 5814.854628634149, 4670.131947221139, 5148.021875843578, 5627.915581266366, 5628.915566266427, 5660.320761508646, 5588.295569851234, 5664.235328230636, 5669.291338582677, 5674.375818660027, 5676.375598684059, 4739.549742774431, 4869.31829543857, 4907.337509436323, 5374.516293533445, 5420.728963551728, 4907.386576677915, 5350.8127215547265, 5536.695481748542, 5541.916871246854, 5583.497485226349, 4992.80028798844, 5405.864853378697, 5475.397706252389, 5491.670499770026, 5506.339239291311], "value": 4062.2970654662777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4761428928304, 743.7025189924029, 744.05505008639, 809.1867672988648, 825.9917400825993, 12060.216085954407, 15318.617034574141, 15532.922335388335, 16248.51254462368, 17234.0, 15764.921175394107, 15787.0, 16247.918760406212, 16395.098269595168, 16525.33898644053, 838.4466252273501, 839.1356902390517, 839.1859895900966, 842.1031601344548, 842.6250318608222, 668.1814776898285, 688.102026854954, 691.9411849992757, 832.0057531250159, 832.4797001873828, 744.5011842065802, 909.417972497602, 914.3782228084899, 916.9266458683289, 919.2508105893709, 872.2106493623281, 905.4748246017294, 906.6962567539882, 907.3059109781022, 907.564369102831, 514.6423235851084, 527.6570229350914, 674.6727836999052, 676.5669971218424, 677.8915373540259, 14629.6342591435, 15188.392464301414, 15250.771238431433, 15518.922405388013, 15546.61133471661, 13712.862871371359, 13826.792598111037, 13874.722505549933, 13936.094153880067, 13998.300084995812, 11219.495122719498, 11239.494222759913, 11266.605668801634, 11810.645680629508, 11908.106891983136, 3553.4492153716214, 3565.5721313442295, 3620.837062332201, 3683.447482877563, 3746.83139258734, 102141.4892925538, 108704.91295087028, 111338.0, 111917.32124018147, 113233.43383283031, 10150.949245253727, 10449.373037617766, 10539.473026348653, 11119.610813621646, 11250.887491124984, 22141.89290535499, 22401.327960161223, 22495.550088998454, 22497.775022249567, 22546.323610291718, 7680.846383072308, 7697.153313135551, 7742.7677169685, 7839.529628222325, 8005.359571234288, 3982.820773065219, 4108.856190033334, 4181.91270269726, 4405.3612226227015, 4483.529229430863, 3521.9119522012156, 3600.171960449059, 3623.166671665532, 3633.94549081764, 3646.0, 643.8486955565438, 649.04590252329, 653.6927644007309, 656.9835754106185, 660.8876490996446, 644.6390021587832, 664.707528687376, 676.3811112831802, 681.4718593090296, 704.0987535953988, 9418.90581094194, 9658.806823863484, 9948.08703957558, 10135.76010741462, 10263.58945642166, 655.5476721062452, 659.788867562385, 670.2426258328059, 672.3444641474523, 680.0, 4361.869143925687, 4850.5149485051215, 4855.6115510759055, 4863.4650188479945, 4890.388701412324, 96046.51976740212, 96268.55597166048, 97161.0, 99088.50455747676, 99217.50391247998, 90262.54868725745, 91383.08616913746, 93656.0, 94448.0, 94996.0, 61369.386306136366, 79511.0, 82319.0, 83302.5834870834, 86196.56901715451, 9363.250939924654, 9520.761980950532, 9525.904740952501, 9538.570764315484, 9545.904540954501, 50910.490895090574, 51155.0, 51740.48259517357, 53215.0, 53233.46766532285, 67600.94394336356, 68454.0, 70653.94019089614, 71096.64451677709, 71313.0, 11564.537418503165, 11605.245659032136, 11694.415279236175, 11937.403129843648, 12017.459214335551, 11959.641210763692, 12277.0, 12574.497020119094, 12715.237085774514, 12922.612321630366, 9701.611935522782, 11524.654260372203, 11557.653270401901, 11887.108466865193, 12258.877411225774, 11591.884081159418, 11837.289762614271, 12061.336626485627, 12102.515899363927, 12181.14731968789, 10973.945130274298, 11306.94346528262, 11413.486393112164, 11620.360880151673, 11732.86278262965, 9385.671501497414, 9416.210919925192, 9757.902420975699, 9814.901850981685, 9885.258605604464, 9677.129058384779, 9681.128698417177, 9719.9028009719, 9740.853887191555, 9791.755206119618], "value": 7293.008114758751, "unit": "score"}], "name": "dromaeo_css", "value": 7297.619089395029, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 112.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 107.0, 108.0, 145.0, 111.0, 110.0, 111.0, 107.0, 130.0, 109.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 260.0, 204.0, 183.0, 184.0, 186.0, 183.0, 184.0, 185.0, 183.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 89.0, 75.0, 81.0, 81.0, 80.0, 74.0, 58.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 118.0, 83.0, 68.0, 68.0, 81.0, 68.0, 68.0, 84.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 93.0, 131.0, 134.0, 86.0, 90.0, 88.0, 89.0, 87.0], "value": 97.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 139.0, 87.0, 86.0, 87.0, 87.0, 85.0, 86.0, 88.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 53.0, 54.0, 54.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 79.0, 75.0, 72.0, 67.0, 67.0, 67.0, 68.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 105.0, 104.0, 83.0, 82.0, 84.0, 85.0, 85.0, 89.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 156.0, 147.0, 123.0, 146.0, 147.0, 156.0, 138.0, 185.0, 141.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 166.0, 176.0, 228.0, 197.0, 169.0, 166.0, 166.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 65.0, 65.0, 63.0, 65.0, 64.0, 66.0, 65.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1476.8999999999999, "alertThreshold": 2.0}]} 15:49:44 INFO - Return code: 0 15:49:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:49:45 ERROR - # TBPL SUCCESS # 15:49:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:49:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:49:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:49:45 INFO - 2017-03-03 15:49:45.034 screenresolution[1654:9765] starting screenresolution argv=screenresolution get 15:49:45 INFO - 2017-03-03 15:49:45.037 screenresolution[1654:9765] Display 0: 1600x1200x32@60 15:49:45 INFO - 2017-03-03 15:49:45.043 screenresolution[1655:9768] starting screenresolution argv=screenresolution list 15:49:45 INFO - Available Modes on Display 0 15:49:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:49:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:49:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:49:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:49:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:49:45 INFO - Intel Iris: 15:49:45 INFO - Chipset Model: Intel Iris 15:49:45 INFO - Type: GPU 15:49:45 INFO - Bus: Built-In 15:49:45 INFO - VRAM (Dynamic, Max): 1536 MB 15:49:45 INFO - Vendor: Intel (0x8086) 15:49:45 INFO - Device ID: 0x0a2e 15:49:45 INFO - Revision ID: 0x0009 15:49:45 INFO - Displays: 15:49:45 INFO - Display: 15:49:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:49:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:49:45 INFO - Display Serial Number: 1600x1200 60 15:49:45 INFO - Main Display: Yes 15:49:45 INFO - Mirror: Off 15:49:45 INFO - Online: Yes 15:49:45 INFO - Rotation: Supported 15:49:45 INFO - Return code: 0 15:49:45 INFO - Running post-action listener: _resource_record_post_action 15:49:45 INFO - [mozharness: 2017-03-03 23:49:45.287000Z] Finished run-tests step (success) 15:49:45 INFO - Running post-run listener: _resource_record_post_run 15:49:45 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 37929984; Write bytes: 510252032; Read time: 241; Write time: 1594 15:49:45 INFO - TinderboxPrint: CPU usage
53.7% 15:49:45 INFO - TinderboxPrint: I/O read bytes / time
37,929,984 / 241 15:49:45 INFO - TinderboxPrint: I/O write bytes / time
510,252,032 / 1,594 15:49:45 INFO - TinderboxPrint: CPU idle
2,223.3 (46.3%) 15:49:45 INFO - TinderboxPrint: CPU system
958.9 (20.0%) 15:49:45 INFO - TinderboxPrint: CPU user
1,615.4 (33.7%) 15:49:45 INFO - TinderboxPrint: Swap in / out
245,514,240 / 0 15:49:45 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205748736; Write bytes: 203544576; Read time: 15654; Write time: 439 15:49:45 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35804160; Write bytes: 295730176; Read time: 220; Write time: 1123 15:49:45 INFO - Running post-run listener: _upload_blobber_files 15:49:45 INFO - Blob upload gear active. 15:49:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:49:45 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 15:49:45 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:49:45 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:49:46 INFO - (blobuploader) - INFO - Open directory for files ... 15:49:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:49:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:49:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:47 INFO - (blobuploader) - INFO - Done attempting. 15:49:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:49:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:48 INFO - (blobuploader) - INFO - Done attempting. 15:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:49:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:49 INFO - (blobuploader) - INFO - Done attempting. 15:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:51 INFO - (blobuploader) - INFO - Done attempting. 15:49:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:49:51 INFO - Return code: 0 15:49:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:49:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:49:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4e0be79a5fb4e25dc973da9abc03b9c65b606baeda00bbc8754cf9ec3369ea22bfe1c47fc4ef3fd040fdabffe8bb65f3b4e62c36bad240c1e1cfe80288f54c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72318a13db2ba672c7ad017518a3094833d51e32305250b37d3a3f0e83bf51b2dda44537aabf60a2470e9f00b2eb6bb6717904c0f9c4c99ac26841bfe7bcb59c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/691619e6ad203e4fe7c1ebb39311289657ebc1288d0d3faad0acf0aa5d2afb0a91faf484914b425be6ee3158ce8ce738bd3a7a483bbc9aff67906e4a8bd4ff44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b15e8e97e5247838bccb19f01ccaf45a2bc862d3e35b95dfee2a5b8b68c1b17a16256e83808deb1baabbe4baed3276ce979e93690af6d6208ea523cf2dc939"} 15:49:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:49:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:49:51 INFO - Contents: 15:49:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4e0be79a5fb4e25dc973da9abc03b9c65b606baeda00bbc8754cf9ec3369ea22bfe1c47fc4ef3fd040fdabffe8bb65f3b4e62c36bad240c1e1cfe80288f54c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72318a13db2ba672c7ad017518a3094833d51e32305250b37d3a3f0e83bf51b2dda44537aabf60a2470e9f00b2eb6bb6717904c0f9c4c99ac26841bfe7bcb59c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/691619e6ad203e4fe7c1ebb39311289657ebc1288d0d3faad0acf0aa5d2afb0a91faf484914b425be6ee3158ce8ce738bd3a7a483bbc9aff67906e4a8bd4ff44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b15e8e97e5247838bccb19f01ccaf45a2bc862d3e35b95dfee2a5b8b68c1b17a16256e83808deb1baabbe4baed3276ce979e93690af6d6208ea523cf2dc939"} 15:49:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:49:51 INFO - Copying logs to upload dir... 15:49:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:49:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.651872 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-03 15:49:51.401274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 15:49:51.406201) ========= 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.yblOCwIWCT/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.InWLIiwRvC/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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-Aurora/sha512/f4e0be79a5fb4e25dc973da9abc03b9c65b606baeda00bbc8754cf9ec3369ea22bfe1c47fc4ef3fd040fdabffe8bb65f3b4e62c36bad240c1e1cfe80288f54c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72318a13db2ba672c7ad017518a3094833d51e32305250b37d3a3f0e83bf51b2dda44537aabf60a2470e9f00b2eb6bb6717904c0f9c4c99ac26841bfe7bcb59c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/691619e6ad203e4fe7c1ebb39311289657ebc1288d0d3faad0acf0aa5d2afb0a91faf484914b425be6ee3158ce8ce738bd3a7a483bbc9aff67906e4a8bd4ff44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b15e8e97e5247838bccb19f01ccaf45a2bc862d3e35b95dfee2a5b8b68c1b17a16256e83808deb1baabbe4baed3276ce979e93690af6d6208ea523cf2dc939"} build_url:https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010950 build_url: 'https://queue.taskcluster.net/v1/task/PSCKgMySQACXKag2nh-0OQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4e0be79a5fb4e25dc973da9abc03b9c65b606baeda00bbc8754cf9ec3369ea22bfe1c47fc4ef3fd040fdabffe8bb65f3b4e62c36bad240c1e1cfe80288f54c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72318a13db2ba672c7ad017518a3094833d51e32305250b37d3a3f0e83bf51b2dda44537aabf60a2470e9f00b2eb6bb6717904c0f9c4c99ac26841bfe7bcb59c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/691619e6ad203e4fe7c1ebb39311289657ebc1288d0d3faad0acf0aa5d2afb0a91faf484914b425be6ee3158ce8ce738bd3a7a483bbc9aff67906e4a8bd4ff44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b15e8e97e5247838bccb19f01ccaf45a2bc862d3e35b95dfee2a5b8b68c1b17a16256e83808deb1baabbe4baed3276ce979e93690af6d6208ea523cf2dc939"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 15:49:51.442503) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 15:49:51.442913) ========= 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.yblOCwIWCT/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.InWLIiwRvC/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.005174 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 15:49:51.494138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 15:49:51.494655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 15:49:51.495170) ========= ========= Total master_lag: 0.19 =========