builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0197 starttime: 1476708276.25 results: success (0) buildid: 20161017034035 builduid: ef37dcdf5da84fe092e85ac7a81f7dd1 revision: 589d7c55859b45ab1d4f17ec40db411876c883a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.254604) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.255074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.255370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.283348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.283739) ========= 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.V62CgobyaR/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.b53GXiLyLg/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-17 05:44:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 32.8M=0s 2016-10-17 05:44:36 (32.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.452915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.453231) ========= 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.V62CgobyaR/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.b53GXiLyLg/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.026192 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:36.502469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:44:36.505886) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 589d7c55859b45ab1d4f17ec40db411876c883a8 --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 589d7c55859b45ab1d4f17ec40db411876c883a8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V62CgobyaR/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.b53GXiLyLg/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-17 05:44:36,581 truncating revision to first 12 chars 2016-10-17 05:44:36,581 Setting DEBUG logging. 2016-10-17 05:44:36,581 attempt 1/10 2016-10-17 05:44:36,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/589d7c55859b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 05:44:37,926 unpacking tar archive at: mozilla-aurora-589d7c55859b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626331 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:44:38.154215) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:38.154535) ========= script_repo_revision: 589d7c55859b45ab1d4f17ec40db411876c883a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:38.154938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:38.155257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:44:38.173490) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-17 05:44:38.173925) ========= /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.V62CgobyaR/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.b53GXiLyLg/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:44:38 INFO - MultiFileLogger online at 20161017 05:44:38 in /builds/slave/test 05:44:38 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 05:44:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:38 INFO - {'append_to_log': False, 05:44:38 INFO - 'base_work_dir': '/builds/slave/test', 05:44:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:44:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:38 INFO - 'branch': 'Mozilla-Aurora', 05:44:38 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:38 INFO - 'config_files': ('talos/mac_config.py',), 05:44:38 INFO - 'default_actions': ('clobber', 05:44:38 INFO - 'read-buildbot-config', 05:44:38 INFO - 'download-and-extract', 05:44:38 INFO - 'populate-webroot', 05:44:38 INFO - 'create-virtualenv', 05:44:38 INFO - 'install', 05:44:38 INFO - 'run-tests'), 05:44:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:38 INFO - 'download_minidump_stackwalk': True, 05:44:38 INFO - 'download_symbols': 'ondemand', 05:44:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:38 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:38 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:38 INFO - 'installer_path': 'installer.exe', 05:44:38 INFO - 'log_level': 'info', 05:44:38 INFO - 'log_name': 'talos', 05:44:38 INFO - 'log_to_console': True, 05:44:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:44:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:44:38 INFO - 'opt_config_files': (), 05:44:38 INFO - 'pip_index': False, 05:44:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:38 INFO - 'cmd': ('bash', 05:44:38 INFO - '-c', 05:44:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:38 INFO - 'enabled': True, 05:44:38 INFO - 'halt_on_failure': False, 05:44:38 INFO - 'name': 'check_screen_resolution'},), 05:44:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:38 INFO - 'cmd': ('bash', 05:44:38 INFO - '-c', 05:44:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:38 INFO - 'enabled': True, 05:44:38 INFO - 'halt_on_failure': False, 05:44:38 INFO - 'name': 'check_screen_resolution'},), 05:44:38 INFO - 'run_cmd_checks_enabled': True, 05:44:38 INFO - 'sps_profile': False, 05:44:38 INFO - 'sps_profile_interval': 0, 05:44:38 INFO - 'suite': 'dromaeojs', 05:44:38 INFO - 'system_bits': '32', 05:44:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:38 INFO - 'title': 't-yosemite-r7-0197', 05:44:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:38 INFO - 'use_talos_json': True, 05:44:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:38 INFO - 'work_dir': 'build'} 05:44:38 INFO - [mozharness: 2016-10-17 12:44:38.373298Z] Running clobber step. 05:44:38 INFO - Running pre-action listener: _resource_record_pre_action 05:44:38 INFO - Running main action method: clobber 05:44:38 INFO - rmtree: /builds/slave/test/build 05:44:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:40 INFO - Running post-action listener: _resource_record_post_action 05:44:40 INFO - [mozharness: 2016-10-17 12:44:40.521675Z] Finished clobber step (success) 05:44:40 INFO - [mozharness: 2016-10-17 12:44:40.521828Z] Running read-buildbot-config step. 05:44:40 INFO - Running pre-action listener: _resource_record_pre_action 05:44:40 INFO - Running main action method: read_buildbot_config 05:44:40 INFO - Using buildbot properties: 05:44:40 INFO - { 05:44:40 INFO - "project": "", 05:44:40 INFO - "product": "firefox", 05:44:40 INFO - "script_repo_revision": "production", 05:44:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:44:40 INFO - "repository": "", 05:44:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:44:40 INFO - "buildid": "20161017034035", 05:44:40 INFO - "pgo_build": "False", 05:44:40 INFO - "basedir": "/builds/slave/test", 05:44:40 INFO - "buildnumber": 1, 05:44:40 INFO - "slavename": "t-yosemite-r7-0197", 05:44:40 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:44:40 INFO - "platform": "yosemite_r7", 05:44:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:44:40 INFO - "branch": "mozilla-aurora", 05:44:40 INFO - "repo_path": "releases/mozilla-aurora", 05:44:40 INFO - "revision": "589d7c55859b45ab1d4f17ec40db411876c883a8", 05:44:40 INFO - "stage_platform": "macosx64", 05:44:40 INFO - "builduid": "ef37dcdf5da84fe092e85ac7a81f7dd1", 05:44:40 INFO - "slavebuilddir": "test" 05:44:40 INFO - } 05:44:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:44:40 INFO - Running post-action listener: _resource_record_post_action 05:44:40 INFO - [mozharness: 2016-10-17 12:44:40.524842Z] Finished read-buildbot-config step (success) 05:44:40 INFO - [mozharness: 2016-10-17 12:44:40.524992Z] Running download-and-extract step. 05:44:40 INFO - Running pre-action listener: _resource_record_pre_action 05:44:40 INFO - Running main action method: download_and_extract 05:44:40 INFO - mkdir: /builds/slave/test/build/tests 05:44:40 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')]} 05:44:40 INFO - trying https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:44:40 INFO - Downloading https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 05:44:41 INFO - Downloaded 1199 bytes. 05:44:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:44:41 INFO - Using the following test package requirements: 05:44:41 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:44:41 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:44:41 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:44:41 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'jsshell-mac.zip'], 05:44:41 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:44:41 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:44:41 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:44:41 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:44:41 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:44:41 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:44:41 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:44:41 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:44:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:44:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:44:41 INFO - Fetch https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:44:42 INFO - Expected file size: 16435270 05:44:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:44:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:44:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:44:49 INFO - Fetch https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:44:50 INFO - Expected file size: 16435270 05:44:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:44:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:44:56 INFO - Fetch https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:44:57 INFO - Expected file size: 14414081 05:44:58 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')]} 05:44:58 INFO - trying https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:44:58 INFO - Downloading https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 05:45:00 INFO - Downloaded 115424160 bytes. 05:45:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:45:00 INFO - mkdir: /builds/slave/test/properties 05:45:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:00 INFO - Contents: 05:45:00 INFO - build_url:https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:45:01 INFO - Running post-action listener: _resource_record_post_action 05:45:01 INFO - Running post-action listener: set_extra_try_arguments 05:45:01 INFO - [mozharness: 2016-10-17 12:45:01.639808Z] Finished download-and-extract step (success) 05:45:01 INFO - [mozharness: 2016-10-17 12:45:01.639929Z] Running populate-webroot step. 05:45:01 INFO - Running pre-action listener: _resource_record_pre_action 05:45:01 INFO - Running main action method: populate_webroot 05:45:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:01 INFO - '--tppagecycles', 05:45:01 INFO - '7'], 05:45:01 INFO - 'tests': ['tsvgm']}}, 05:45:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['damp', 'tps']}, 05:45:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'tests': ['damp', 'tps']}, 05:45:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['dromaeo_dom']}, 05:45:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['basic_compositor_video']}, 05:45:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['a11yr', 05:45:01 INFO - 'ts_paint', 05:45:01 INFO - 'tpaint', 05:45:01 INFO - 'sessionrestore', 05:45:01 INFO - 'sessionrestore_no_auto_restore', 05:45:01 INFO - 'tabpaint']}, 05:45:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:01 INFO - 'ts_paint', 05:45:01 INFO - 'tpaint', 05:45:01 INFO - 'sessionrestore', 05:45:01 INFO - 'sessionrestore_no_auto_restore', 05:45:01 INFO - 'tabpaint']}, 05:45:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:01 INFO - 'ts_paint', 05:45:01 INFO - 'tpaint', 05:45:01 INFO - 'sessionrestore', 05:45:01 INFO - 'sessionrestore_no_auto_restore', 05:45:01 INFO - 'tabpaint']}, 05:45:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:01 INFO - 'ts_paint', 05:45:01 INFO - 'tpaint', 05:45:01 INFO - 'sessionrestore', 05:45:01 INFO - 'sessionrestore_no_auto_restore', 05:45:01 INFO - 'tabpaint']}, 05:45:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['a11yr', 05:45:01 INFO - 'ts_paint', 05:45:01 INFO - 'tpaint', 05:45:01 INFO - 'sessionrestore', 05:45:01 INFO - 'sessionrestore_no_auto_restore', 05:45:01 INFO - 'tabpaint']}, 05:45:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['a11yr', 05:45:01 INFO - 'ts_paint', 05:45:01 INFO - 'tpaint', 05:45:01 INFO - 'sessionrestore', 05:45:01 INFO - 'sessionrestore_no_auto_restore', 05:45:01 INFO - 'tabpaint']}, 05:45:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['tsvgx', 05:45:01 INFO - 'tsvgr_opacity', 05:45:01 INFO - 'tart', 05:45:01 INFO - 'tscrollx', 05:45:01 INFO - 'cart']}, 05:45:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:01 INFO - 'tsvgr_opacity', 05:45:01 INFO - 'tart', 05:45:01 INFO - 'tscrollx', 05:45:01 INFO - 'cart']}, 05:45:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'talos_options': ['--disable-e10s'], 05:45:01 INFO - 'tests': ['tp5o']}, 05:45:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'tests': ['tp5o']}, 05:45:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'talos_options': ['--disable-e10s', 05:45:01 INFO - '--xperf_path', 05:45:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:01 INFO - 'tests': ['tp5n']}, 05:45:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:01 INFO - 'talos_options': ['--xperf_path', 05:45:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:01 INFO - 'tests': ['tp5n']}}, 05:45:01 INFO - 'talos.zip': {'path': '', 05:45:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:01 INFO - Running post-action listener: _resource_record_post_action 05:45:01 INFO - [mozharness: 2016-10-17 12:45:01.658884Z] Finished populate-webroot step (success) 05:45:01 INFO - [mozharness: 2016-10-17 12:45:01.659022Z] Running create-virtualenv step. 05:45:01 INFO - Running pre-action listener: _resource_record_pre_action 05:45:01 INFO - Running main action method: create_virtualenv 05:45:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:01 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 05:45:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:01 INFO - Using real prefix '/tools/python27' 05:45:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:05 INFO - Installing pip.................done. 05:45:05 INFO - Return code: 0 05:45:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:05 INFO - 'HOME': '/Users/cltbld', 05:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:05 INFO - 'LOGNAME': 'cltbld', 05:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:05 INFO - 'MOZ_NO_REMOTE': '1', 05:45:05 INFO - 'NO_EM_RESTART': '1', 05:45:05 INFO - 'PAGER': '/bin/cat', 05:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:05 INFO - 'PWD': '/builds/slave/test', 05:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:05 INFO - 'SHELL': '/bin/bash', 05:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:05 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:05 INFO - 'USER': 'cltbld', 05:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:05 INFO - 'XPC_FLAGS': '0x0', 05:45:05 INFO - 'XPC_SERVICE_NAME': '0', 05:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:05 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 05:45:05 INFO - Cleaning up... 05:45:05 INFO - Return code: 0 05:45:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:05 INFO - 'HOME': '/Users/cltbld', 05:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:05 INFO - 'LOGNAME': 'cltbld', 05:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:05 INFO - 'MOZ_NO_REMOTE': '1', 05:45:05 INFO - 'NO_EM_RESTART': '1', 05:45:05 INFO - 'PAGER': '/bin/cat', 05:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:05 INFO - 'PWD': '/builds/slave/test', 05:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:05 INFO - 'SHELL': '/bin/bash', 05:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:05 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:05 INFO - 'USER': 'cltbld', 05:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:05 INFO - 'XPC_FLAGS': '0x0', 05:45:05 INFO - 'XPC_SERVICE_NAME': '0', 05:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:05 INFO - Downloading/unpacking psutil>=3.1.1 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:08 INFO - Installing collected packages: psutil 05:45:08 INFO - Running setup.py install for psutil 05:45:08 INFO - building 'psutil._psutil_osx' extension 05:45:08 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 05:45:09 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 05:45:09 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 05:45:09 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 05:45:09 INFO - building 'psutil._psutil_posix' extension 05:45:09 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 05:45:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:45:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:45:09 INFO - ^ 05:45:09 INFO - 1 warning generated. 05:45:09 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 05:45:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:09 INFO - Successfully installed psutil 05:45:09 INFO - Cleaning up... 05:45:09 INFO - Return code: 0 05:45:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:45:09 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')]} 05:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:09 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')]} 05:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:09 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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:09 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 05:45:09 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 05:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:09 INFO - 'HOME': '/Users/cltbld', 05:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:09 INFO - 'LOGNAME': 'cltbld', 05:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:09 INFO - 'MOZ_NO_REMOTE': '1', 05:45:09 INFO - 'NO_EM_RESTART': '1', 05:45:09 INFO - 'PAGER': '/bin/cat', 05:45:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:09 INFO - 'PWD': '/builds/slave/test', 05:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:09 INFO - 'SHELL': '/bin/bash', 05:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:09 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:09 INFO - 'USER': 'cltbld', 05:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:09 INFO - 'XPC_FLAGS': '0x0', 05:45:09 INFO - 'XPC_SERVICE_NAME': '0', 05:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:12 INFO - Installing collected packages: mozsystemmonitor 05:45:12 INFO - Running setup.py install for mozsystemmonitor 05:45:12 INFO - Successfully installed mozsystemmonitor 05:45:12 INFO - Cleaning up... 05:45:12 INFO - Return code: 0 05:45:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:45:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:12 INFO - 'HOME': '/Users/cltbld', 05:45:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:12 INFO - 'LOGNAME': 'cltbld', 05:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:12 INFO - 'MOZ_NO_REMOTE': '1', 05:45:12 INFO - 'NO_EM_RESTART': '1', 05:45:12 INFO - 'PAGER': '/bin/cat', 05:45:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:12 INFO - 'PWD': '/builds/slave/test', 05:45:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:12 INFO - 'SHELL': '/bin/bash', 05:45:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:12 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:12 INFO - 'USER': 'cltbld', 05:45:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:12 INFO - 'XPC_FLAGS': '0x0', 05:45:12 INFO - 'XPC_SERVICE_NAME': '0', 05:45:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:13 INFO - Downloading/unpacking jsonschema==2.5.1 05:45:13 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 05:45:13 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 05:45:13 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 05:45:13 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 05:45:13 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 05:45:13 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 05:45:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:16 INFO - warning: no files found matching '*.txt' 05:45:16 INFO - no previously-included directories found matching 'build' 05:45:16 INFO - no previously-included directories found matching 'dist' 05:45:16 INFO - no previously-included directories found matching '.git*' 05:45:16 INFO - Installing collected packages: jsonschema, functools32 05:45:16 INFO - Running setup.py install for functools32 05:45:16 INFO - warning: no files found matching '*.txt' 05:45:16 INFO - no previously-included directories found matching 'build' 05:45:16 INFO - no previously-included directories found matching 'dist' 05:45:16 INFO - no previously-included directories found matching '.git*' 05:45:16 INFO - Successfully installed jsonschema functools32 05:45:16 INFO - Cleaning up... 05:45:16 INFO - Return code: 0 05:45:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:45:16 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')]} 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:16 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')]} 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:16 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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:16 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 05:45:16 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 05:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:16 INFO - 'HOME': '/Users/cltbld', 05:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:16 INFO - 'LOGNAME': 'cltbld', 05:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:16 INFO - 'MOZ_NO_REMOTE': '1', 05:45:16 INFO - 'NO_EM_RESTART': '1', 05:45:16 INFO - 'PAGER': '/bin/cat', 05:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:16 INFO - 'PWD': '/builds/slave/test', 05:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:16 INFO - 'SHELL': '/bin/bash', 05:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:16 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:16 INFO - 'USER': 'cltbld', 05:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:16 INFO - 'XPC_FLAGS': '0x0', 05:45:16 INFO - 'XPC_SERVICE_NAME': '0', 05:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:45:16 INFO - Cleaning up... 05:45:16 INFO - Return code: 0 05:45:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:16 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')]} 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:16 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')]} 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:16 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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:16 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 05:45:16 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 05:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:16 INFO - 'HOME': '/Users/cltbld', 05:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:16 INFO - 'LOGNAME': 'cltbld', 05:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:16 INFO - 'MOZ_NO_REMOTE': '1', 05:45:16 INFO - 'NO_EM_RESTART': '1', 05:45:16 INFO - 'PAGER': '/bin/cat', 05:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:16 INFO - 'PWD': '/builds/slave/test', 05:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:16 INFO - 'SHELL': '/bin/bash', 05:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:16 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:16 INFO - 'USER': 'cltbld', 05:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:16 INFO - 'XPC_FLAGS': '0x0', 05:45:16 INFO - 'XPC_SERVICE_NAME': '0', 05:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:17 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:17 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 05:45:17 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 05:45:17 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 05:45:17 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 05:45:17 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 05:45:17 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 05:45:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 INFO - Downloading docopt-0.6.1.tar.gz 05:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:20 INFO - Running setup.py install for blobuploader 05:45:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:21 INFO - Running setup.py install for requests 05:45:21 INFO - Running setup.py install for docopt 05:45:21 INFO - Successfully installed blobuploader requests docopt 05:45:21 INFO - Cleaning up... 05:45:21 INFO - Return code: 0 05:45:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:21 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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:21 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 05:45:21 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 05:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:21 INFO - 'HOME': '/Users/cltbld', 05:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:21 INFO - 'LOGNAME': 'cltbld', 05:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:21 INFO - 'MOZ_NO_REMOTE': '1', 05:45:21 INFO - 'NO_EM_RESTART': '1', 05:45:21 INFO - 'PAGER': '/bin/cat', 05:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:21 INFO - 'PWD': '/builds/slave/test', 05:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:21 INFO - 'SHELL': '/bin/bash', 05:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:21 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:21 INFO - 'USER': 'cltbld', 05:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:21 INFO - 'XPC_FLAGS': '0x0', 05:45:21 INFO - 'XPC_SERVICE_NAME': '0', 05:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-A5iSDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-N4buvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-bJQwJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-V8pxgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-EEAUbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-1NunVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-6rLPHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Xlqn9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:22 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-GbzsR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-wi3k5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-tScYZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Knfdj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-5Ac5zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-tGuq7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-8Ohkyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-f5NY9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:23 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-tPsHkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:23 INFO - Running setup.py install for manifestparser 05:45:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:23 INFO - Running setup.py install for mozcrash 05:45:24 INFO - Running setup.py install for mozdebug 05:45:24 INFO - Running setup.py install for mozdevice 05:45:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:24 INFO - Running setup.py install for mozfile 05:45:24 INFO - Running setup.py install for mozhttpd 05:45:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:24 INFO - Running setup.py install for mozinfo 05:45:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:24 INFO - Running setup.py install for mozInstall 05:45:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:25 INFO - Running setup.py install for mozleak 05:45:25 INFO - Running setup.py install for mozlog 05:45:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:25 INFO - Running setup.py install for moznetwork 05:45:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:25 INFO - Running setup.py install for mozprocess 05:45:25 INFO - Running setup.py install for mozprofile 05:45:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:25 INFO - Running setup.py install for mozrunner 05:45:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:25 INFO - Running setup.py install for mozscreenshot 05:45:26 INFO - Running setup.py install for moztest 05:45:26 INFO - Running setup.py install for mozversion 05:45:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:26 INFO - Cleaning up... 05:45:26 INFO - Return code: 0 05:45:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:26 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 05:45:26 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 05:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:26 INFO - 'HOME': '/Users/cltbld', 05:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:26 INFO - 'LOGNAME': 'cltbld', 05:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:26 INFO - 'MOZ_NO_REMOTE': '1', 05:45:26 INFO - 'NO_EM_RESTART': '1', 05:45:26 INFO - 'PAGER': '/bin/cat', 05:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:26 INFO - 'PWD': '/builds/slave/test', 05:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:26 INFO - 'SHELL': '/bin/bash', 05:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:26 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:26 INFO - 'USER': 'cltbld', 05:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:26 INFO - 'XPC_FLAGS': '0x0', 05:45:26 INFO - 'XPC_SERVICE_NAME': '0', 05:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:26 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-JxTUPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:26 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)) 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:26 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-YSt4s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:26 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-XP7vKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-IJNN7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-ySoQDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-lXfZ54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-VK0STJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-2XWNWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-dp2kEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-YYxmfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-cnUvM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:27 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)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-sltYII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:27 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Vpc0Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:28 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)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:28 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-wHNfXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:28 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-ks9CdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:28 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)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:28 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-g0Sm8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:28 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-OalI2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:28 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)) 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:28 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)) 05:45:28 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:28 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:31 INFO - Downloading blessings-1.6.tar.gz 05:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:31 INFO - Installing collected packages: blessings 05:45:31 INFO - Running setup.py install for blessings 05:45:31 INFO - Successfully installed blessings 05:45:31 INFO - Cleaning up... 05:45:31 INFO - Return code: 0 05:45:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:32 INFO - Reading from file tmpfile_stdout 05:45:32 INFO - Current package versions: 05:45:32 INFO - blessings == 1.6 05:45:32 INFO - blobuploader == 1.2.4 05:45:32 INFO - docopt == 0.6.1 05:45:32 INFO - functools32 == 3.2.3-2 05:45:32 INFO - jsonschema == 2.5.1 05:45:32 INFO - manifestparser == 1.1 05:45:32 INFO - mozInstall == 1.12 05:45:32 INFO - mozcrash == 0.17 05:45:32 INFO - mozdebug == 0.1 05:45:32 INFO - mozdevice == 0.48 05:45:32 INFO - mozfile == 1.2 05:45:32 INFO - mozhttpd == 0.7 05:45:32 INFO - mozinfo == 0.9 05:45:32 INFO - mozleak == 0.1 05:45:32 INFO - mozlog == 3.4 05:45:32 INFO - moznetwork == 0.27 05:45:32 INFO - mozprocess == 0.23 05:45:32 INFO - mozprofile == 0.28 05:45:32 INFO - mozrunner == 6.12 05:45:32 INFO - mozscreenshot == 0.1 05:45:32 INFO - mozsystemmonitor == 0.3 05:45:32 INFO - moztest == 0.7 05:45:32 INFO - mozversion == 1.4 05:45:32 INFO - psutil == 3.1.1 05:45:32 INFO - requests == 1.2.3 05:45:32 INFO - wsgiref == 0.1.2 05:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:32 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')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:32 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 05:45:32 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 05:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:32 INFO - 'HOME': '/Users/cltbld', 05:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PAGER': '/bin/cat', 05:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:32 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - 'XPC_FLAGS': '0x0', 05:45:32 INFO - 'XPC_SERVICE_NAME': '0', 05:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 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)) 05:45:32 INFO - Cleaning up... 05:45:32 INFO - Return code: 0 05:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:45:32 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')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x109c61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8c14805f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, '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.V62CgobyaR/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.b53GXiLyLg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 05:45:32 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 05:45:32 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 05:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:32 INFO - 'HOME': '/Users/cltbld', 05:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PAGER': '/bin/cat', 05:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:45:32 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - 'XPC_FLAGS': '0x0', 05:45:32 INFO - 'XPC_SERVICE_NAME': '0', 05:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:45:32 INFO - Cleaning up... 05:45:32 INFO - Return code: 0 05:45:32 INFO - Running post-action listener: _resource_record_post_action 05:45:32 INFO - Running post-action listener: _start_resource_monitoring 05:45:33 INFO - Starting resource monitoring. 05:45:33 INFO - [mozharness: 2016-10-17 12:45:33.018582Z] Finished create-virtualenv step (success) 05:45:33 INFO - [mozharness: 2016-10-17 12:45:33.019552Z] Running install step. 05:45:33 INFO - Running pre-action listener: _resource_record_pre_action 05:45:33 INFO - Running main action method: install 05:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:33 INFO - Reading from file tmpfile_stdout 05:45:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:45:33 INFO - Reading from file tmpfile_stdout 05:45:33 INFO - Output received: 05:45:33 INFO - Usage: mozinstall [options] installer 05:45:33 INFO - Options: 05:45:33 INFO - -h, --help show this help message and exit 05:45:33 INFO - -d DEST, --destination=DEST 05:45:33 INFO - Directory to install application into. [default: 05:45:33 INFO - "/builds/slave/test"] 05:45:33 INFO - --app=APP Application being installed. [default: firefox] 05:45:33 INFO - mkdir: /builds/slave/test/build/application 05:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:46:05 INFO - Reading from file tmpfile_stdout 05:46:05 INFO - Output received: 05:46:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:46:05 INFO - Running post-action listener: _resource_record_post_action 05:46:05 INFO - [mozharness: 2016-10-17 12:46:05.615956Z] Finished install step (success) 05:46:05 INFO - [mozharness: 2016-10-17 12:46:05.616105Z] Running run-tests step. 05:46:05 INFO - Running pre-action listener: _resource_record_pre_action 05:46:05 INFO - Running main action method: run_tests 05:46:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:05 INFO - 2016-10-17 05:46:05.630 screenresolution[1643:7466] starting screenresolution argv=screenresolution get 05:46:05 INFO - 2016-10-17 05:46:05.633 screenresolution[1643:7466] Display 0: 1600x1200x32@60 05:46:05 INFO - 2016-10-17 05:46:05.638 screenresolution[1644:7468] starting screenresolution argv=screenresolution list 05:46:05 INFO - Available Modes on Display 0 05:46:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:05 INFO - Intel Iris: 05:46:05 INFO - Chipset Model: Intel Iris 05:46:05 INFO - Type: GPU 05:46:05 INFO - Bus: Built-In 05:46:05 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:05 INFO - Vendor: Intel (0x8086) 05:46:05 INFO - Device ID: 0x0a2e 05:46:05 INFO - Revision ID: 0x0009 05:46:05 INFO - Displays: 05:46:05 INFO - Display: 05:46:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:05 INFO - Display Serial Number: 1600x1200 60 05:46:05 INFO - Main Display: Yes 05:46:05 INFO - Mirror: Off 05:46:05 INFO - Online: Yes 05:46:05 INFO - Rotation: Supported 05:46:05 INFO - Return code: 0 05:46:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:05 INFO - Python 2.7.3 05:46:05 INFO - Return code: 0 05:46:05 INFO - grabbing minidump binary from tooltool 05:46: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')]} 05:46: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 0x109a75d30>, '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 0x1098dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a6db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46: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 05:46: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 05:46: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 05:46:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:05 INFO - Return code: 0 05:46:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:46:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:46:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46: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/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0197', '--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 05:46: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/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0197 --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 05:46:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V62CgobyaR/Render', 05:46:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:06 INFO - 'HOME': '/Users/cltbld', 05:46:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:06 INFO - 'LOGNAME': 'cltbld', 05:46:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:06 INFO - 'MOZ_NO_REMOTE': '1', 05:46:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:06 INFO - 'NO_EM_RESTART': '1', 05:46:06 INFO - 'PAGER': '/bin/cat', 05:46:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:06 INFO - 'PWD': '/builds/slave/test', 05:46:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:06 INFO - 'SHELL': '/bin/bash', 05:46:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b53GXiLyLg/Listeners', 05:46:06 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:46:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:06 INFO - 'USER': 'cltbld', 05:46:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:06 INFO - 'XPC_FLAGS': '0x0', 05:46:06 INFO - 'XPC_SERVICE_NAME': '0', 05:46:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:06 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/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0197', '--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 05:46:06 INFO - mozversion application_buildid: 20161017034035 05:46:06 INFO - mozversion application_changeset: 589d7c55859b45ab1d4f17ec40db411876c883a8 05:46:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:46:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:06 INFO - mozversion application_name: Firefox 05:46:06 INFO - mozversion application_remotingname: firefox-dev 05:46:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:46:06 INFO - mozversion application_vendor: Mozilla 05:46:06 INFO - mozversion application_version: 51.0a2 05:46:06 INFO - mozversion platform_buildid: 20161017034035 05:46:06 INFO - mozversion platform_changeset: 589d7c55859b45ab1d4f17ec40db411876c883a8 05:46:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:46:06 INFO - mozversion platform_version: 51.0a2 05:46:06 INFO - using testdate: 1476708366 05:46:06 INFO - actual date: 1476708366 05:46:06 INFO - starting webserver on 'localhost:49274' 05:46:06 INFO - SUITE-START | Running 2 tests 05:46:06 INFO - TEST-START | dromaeo_css 05:46:06 INFO - operating with platform_type : mac_ 05:46:06 INFO - Initialising browser for dromaeo_css test... 05:46:06 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpzZMRzs/profile http://localhost:49274/getInfo.html) 05:46:08 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 05:46:08 INFO - PROCESS | 1654 | colorDepth:24 05:46:08 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 05:46:08 INFO - PROCESS | 1654 | __metrics 05:46:08 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:46:08 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:09 INFO - TEST-INFO | 1654: exit 0 05:46:09 INFO - Browser initialized. 05:46:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:09 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpzZMRzs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:21 INFO - PROCESS | 1656 | RSS: Main: 219901952 05:46:21 INFO - PROCESS | 1656 | 05:47:13 INFO - PROCESS | 1656 | 1476708433279 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:49:26 INFO - PROCESS | 1656 | RSS: Main: 360456192 05:49:26 INFO - PROCESS | 1656 | 05:52:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:52:29 INFO - PROCESS | 1656 | RSS: Main: 352391168 05:52:29 INFO - PROCESS | 1656 | 05:55:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:55:32 INFO - PROCESS | 1656 | RSS: Main: 338522112 05:55:32 INFO - PROCESS | 1656 | 05:58:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:58:35 INFO - PROCESS | 1656 | RSS: Main: 322277376 05:58:35 INFO - PROCESS | 1656 | 06:01:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 06:01:39 INFO - PROCESS | 1656 | RSS: Main: 311181312 06:01:39 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 06:04:42 INFO - PROCESS | 1656 | RSS: Main: 437018624 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | __start_tp_report 06:04:42 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 06:04:42 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 06:04:42 INFO - PROCESS | 1656 | |i|pagename|runs| 06:04:42 INFO - PROCESS | 1656 | |0;dojo.html;3328.151321413039;3328.334333133374;3360.2943381889786;3366.2594229269553;3400.931981360373;5757.7121143942795;5869.706514674271;5887.175795388649;5890.64656120633;5893.823185304437;5834.679092649913;5935.821925342247;5935.940640593592;5936.703164841762;5950.851228719273;5282.788688452457;5303.893922121555;5369.060414427479;5375.892482150354;5396.298481197439;5265.131253343194;5269.1832765921345;5300.575953923677;5425.810096646618;5443.129099344106;5361.651492652984;5373.032854086263;5375.650582712131;5384.703841288728;5392.56859451245;5379.112446446332;5386.084365657828;5388.003219404403;5396.78412863485;5402.108652072403;4884.5848102911295;5269.894602107936;5329.333833270841;5341.145416733343;5366.221897824833;5947.375525569796;5969.522438204933;5972.9701351493395;5992.760289588411;6050.273967123973;6180.381961803829;6187;6198.101275315054;6204.317525072239;6228.470580000705;6079.05774604937;6142.232220972379;6155.846103847395;6259.843503912393;6260;5834.533237341003;5835.328937172237;5875.676837773964;5901;5905.202797622352;6245.156903818017;6292.276388215322;6341.302456729756;6348.523860710465;6358.332375100548;6027;6138.143176733788;6193.783217587363;6252.812415627538;6255.468285195719;6211.720472578745;6258.906116408258;6275;6315.652639104894;6324.08300796382;4956.281339205795;5328.49379308965;6275.1199273953835;6300.2754683212015;6310.5267104967315;6106.358832322542;6137.171481849982;6279.372062793684;6305.369463053658;6324.620522768649;4985.825496107619;4995.475475075064;5004.874878128003;5008.298838162587;5013.573846223039;4460.977695111568;4474.0604473060375;4480.238359478896;4494.52807455219;4512.142692888341;5833.358330583633;5850.8537286567325;5850.970745146247;5893.616914900518;5924.229850119457;6268.49852011838;6276.340984196685;6280.842978925563;6289;6289.245290565162;5896.882062358729;5921.703914804242;5929.110633405024;5936.9610318194145;5962.880742385128;5350;5407;5411.053065713484;5419.539339156137;5498.642588231752;6284.842878927972;6354.682265886595;6357.078223657544;6360.586561873463;6367.904481432783;6256.31180570146;6262.68686565679;6268.780592679234;6278.968605156945;6291.213598300213;6208.441240288395;6337.65142917144;6347.079673447417;6364.363563643598;6374.458171055512;6109.404666050238;6145.832291864532;6188.938110618837;6213.409726076015;6289.685515724104;5152.639315248047;6242.188515492957;6289.371062893674;6296;6298.559100862895;6199.349068347939;6212.658303793335;6213.1922850029205;6227.782027629011;6262.091996660368;6096.542759292982;6112.74665817949;6114.419025732044;6134.202553667995;6186.810776317612;6088.969555152196;6096.631307267998;6100.450959413674;6105.550726437353;6142.692865356625;6230.096635987847;6250.4374606285655;6255.874882502233;6261.186045814015;6263.091851681572;5866;5928.851778705567;5956.970215148896;6020.247469066367;6022.187004754477 06:04:42 INFO - PROCESS | 1656 | |1;ext.html;459.5450504001039;486.60828033433097;489.71107046842354;505.8946202547433;526.1003683700872;31553.368932621335;41168.58831411685;42756.358654620126;42841.78579107108;44909.77545112278;43411.78294108533;43818.342724859074;43869;43933.7803310983;43998.560014399845;8801.823963520726;9898.455584942825;10080.193584513258;10087.445190514518;10091.798164036714;8962.551872406386;9177.54112294386;9190.678326258583;9204.815903681922;12201.633950981484;12221.511139554406;12404.069694772883;12459.501619935192;12476.438560264765;12480.563180288691;12303.200291981037;12352.691182720415;12367.505299788088;12394.31831249281;12398.194117382342;12135.150539462242;12226.694332641666;12234.265944043296;12235.32705701186;12238.265704057785;40489.59510404888;41089.79455102735;41405.37891931624;41592;41712.374314385306;3650.908727281813;3657.4696668982847;3820.1388509808385;4011.197760447922;4049.6152865477734;29793.851030744707;30183.095433824168;31568.895088671787;32231.6776832231;32650.67349326524;3156.5111722838174;3196.8721251149927;3202.727768139711;3289.9835500822583;3327.3012667339885;527721;530175;531074;531457;531698.9999999962;33574.32851343008;34165.316693666486;61130.083048754306;61299;61645.691771540856;34955.82522087373;35532.46701299431;35563.11092222663;35566;35576.82211588977;15233;15402.845971540366;15406.614834629225;15413;15434.691306173814;12911.935440322739;13039.804402933964;13042.347882605833;13084.869151308556;13095.410706518229;7289.052423185058;7400.074990626172;7411.962940185264;7521.435892308099;7886.645100970355;3123.6095488063993;3177.53925680775;3238.077148012805;3335.366280406715;3345.4480010798434;941.1247539787926;951.362587066667;994.8159590475785;1002.9097381235724;1017.5675337981328;30199.396012079636;30334.54498182529;30586.69413305883;30899.382012359627;30918.53622195669;1047.8061558611528;1067.5996501312009;1082.5128692088592;1098.4123493930708;1173.0439691651277;15776.842231577766;15784.526464206092;15814.209289535707;15867.285972131282;16143.757843632355;702225;706971;707001;709753;710491;49997;50955.74522127365;56874.7156264216;57287;57421.42578574161;1179.6991767099507;1382.8755412012968;1418.2412409361148;1422.6870088580495;1423.3239211374514;30281;30907.536386954664;31348.529772053895;31567.84216078905;32068.51897221497;51079.744601276754;51588.71028224324;51656.483435165166;51687.48312516827;51852.222216667535;581975;587094;827311;845863;847960;35014;41735.373969389875;42487.30050797934;42495.362569560864;42693.35959960541;45027.77486112549;46089;46931.296030560254;47349.763251183525;47430.52569474261;38969;39702.60297396989;39823.00442488845;39855.601443985186;41390.37914431346;39274.2145157101;39552.80223598864;40384.79807600943;40702.79648601738;41054.79472602618;37568.62431375761;38228.617713823616;38619.22761544697;38828.80585597054;39061.63284285036;33377.332453351286;34594.65405345914;35501.644983549835;35554;35579.46630800592;25625.487490249718;25655.615165772157;25785.871070645277;25940;26272.474550509265 06:04:42 INFO - PROCESS | 1656 | |2;jquery.html;358.6091160634907;376.1930658737009;378.78787878787864;389.6551551876589;411.9526254480734;15235.238238088094;15351.69296614067;18085.909570452146;20334.881581513047;20621.690674639893;20119.396418107444;20412.387628371136;20674.17303307866;20682.793172068275;21185;4766.070616229837;5957.344692083878;6040.184575082351;6236.314005459396;6243.531735119862;6000.879982400349;6156.445919867211;6160.291566469846;6181.227346581677;6185.87628247437;5782.3639399666;5971.790987315445;6117.143599896018;6151.87696246077;6159.476444502223;6000.33996260411;6012.338642749294;6052.092186172065;6059.091136329542;6067.453929146398;5028.949710502921;5219;5284.550813180885;5289.920651190235;5292.338457692788;25823.74176258251;26490.735092649018;26585.601215981776;26667.733322666718;26909;2140.6253905566464;2215.102883332253;2317.466982593996;2426.065964603623;2553.4893021395796;14681.706365872622;15919.442819501377;16052.11713355765;16197.595060123473;16597.087160206185;1688.9324427022905;1851.1577232359243;1859.3585213101458;1889.3670620342064;1923.1730355946938;117972;119183;119807.4009629955;120388;121686.99999999911;10893.128549716163;11308.943455282671;11375.886241137649;11447.942760286145;11627.767444651228;14419.134851908919;14434.350454229585;14437.639059023399;14446.277686115653;14453.566393008226;7513.4740568159705;8601.139886011473;8864.872430616606;8909.55452227386;8973.012968573452;8872.64509419616;8905.831057826663;8955.955220223857;9124;9155.633774648939;5770.336411312669;6781.6270105144695;6880.552764070319;6888.827779305458;6895.5173137879865;1811.4203454894307;1842.2999260281276;1846.5660569766094;1848.4639454558028;1849.398945342742;951.5052172870069;1005.3766664667953;1013.6502906497246;1031.169908223887;1042.4006196436928;21618.89190554037;22487.21294754676;22966.966486508147;23072.077116915472;23221.76778232196;942.6370847223731;958.3148049144895;976.1751320134475;1012.5747186181821;1014.264658122855;9009.774755631031;11797.351145686898;11834.289942603471;12075.818862717066;12088.153829232046;588043;592844;605394;614014.9299253476;614077;91733;117294;118481.81518184708;123608.38195808964;126150.36924815501;1002.3534820040887;1006.2905651515664;1030.4332617060586;1044.5456226541478;1046.0951277145214;19574.238318551397;20247.79752202459;20379.184832607123;20482.283120090724;20542.07560659744;40255;45285;51617.741911291705;52627.21059184192;53031.939361211786;63833.04250436154;70798;73357;74169.88745168719;74265.62867185629;6827.249002609609;6991;7854.2145785421;8028.4781489203015;8408.159184081544;13034.739305214032;13139.34303284851;13290.269035203157;13459.596212113653;13511.391987360395;9464.668736594185;11246.943765281121;11523.078153747512;11590.826137607773;11735.23720958135;5146.305248791515;9155.221806146552;11449.141314401286;11639.359835209145;11781.469833857669;11257.831132532854;11582.826257606312;11620.186586939171;11639.53441862316;11681.182317237712;7963.362930965624;8002.3198028165925;8133.918660813316;8386.496810191407;8416.747497575083;11224.15818813576;11231.213815033196;11560.017398520884;11604.94197529007;11605.593804216813 06:04:42 INFO - PROCESS | 1656 | |3;mootools.html;1361.945522179113;1488.2856229010074;1498.4680438444348;1531.5635044012456;1909.9713504297429;7867.370610351172;8331.166883311666;8698.043215246325;8952.283817294618;8984.101589841013;8781.91218087819;8863.734087977355;8873.778155546115;8877.911220887789;8883.15610017049;2397.4126339046916;2432.8540287582714;2433.610622300432;2436.378723425524;2440.987795061031;2392.138830021191;2420.419099416145;2431.671724317212;2434.817388695855;2436.9634455483183;2403.9639405408843;2409.674678926592;2420.6248031555137;2422.34596658902;2423.09134074722;2374.5250949810106;2400.12395475651;2400.459896523268;2401.4836810085826;2416.5046165536023;2368.7275963264274;2394.820388470872;2399.928002159938;2400.603900356439;2402.1112188490197;7756.457048006641;8615.267702245317;8860.24687901529;8953.194212520904;8959.955200223958;5239.187925871458;5463.043967305745;5468.316460442445;5476.945230547683;5480.095784195603;3626.0934766308424;3642.581103173116;3701.759385639925;3720.1629633332554;3741.289155060557;1095.8246680531156;1104.5913012185542;1106.618216715232;1115.782422427627;1121.6966035026849;11685.006774424184;11767.23512971654;11788.410579471078;11798.764024719458;11808.169733691291;4500.5274446182675;4540.6821522493765;4727.810887564459;4733.952660473351;4749.311349854252;9244.722658320261;9252.53737313145;9253.768655783524;9258.444493330422;9271.397359171633;5319.547838433777;5328.040952628487;5328.094223981932;5332.200169974457;5335.733213339317;4184.853530126431;4428.202923473741;4581.610563102174;4590.334401511762;4946.307516947631;3832.48261484696;3887.74729642578;3933.645971862546;3957.050307926077;3960.584138665456;1008.9949550252202;1175.1538891997748;1177.6879127031343;1192.4574318684977;1193.1349771415828;818.55388813097;913.9763464919333;922.6217250927087;929.8884133903974;937.803061357109;5795.7971470999155;5943.64338139713;5982.341942386334;6144.139820425144;6165.0444181152;939.9765005874771;945.5272363818091;991.2317953586029;994.174834887042;1016.5069941078718;3661.5972243053243;3689.6863766579604;3835.5972622874756;3901.9464744519387;4050.8379664813665;10605.151587872951;10884.238103332691;10969.945150274358;10989.06592939593;10990;10316.277860549839;10620.20348473852;10636.202284828669;10640.68077957647;11016.17378696601;8261.793455163548;8460.746177614681;8478.02502712196;8480.915190848013;8484.915150848412;5619.578531610064;5658.405867383865;5980.970095149496;6004.369541198112;6077.5745697802495;9782;10112.140468060297;10193.337433066827;10198.031187037219;10276.332038417479;9064.637414503346;9488.95255523718;10312.432816195182;10475.842862357224;10489;7091.042709234187;7351.264873512606;7492.812679683051;7601.125870524739;7743.264389882952;8389.664413423394;8410;8430.578471076544;8470.49177049379;8512.659493620185;7593.924060759543;7604.809879752829;7610.543367397974;7643.808904777425;7657.1959944205055;7454.589997550187;7503.9249607503225;7526.435517336112;7528.887066693895;7656.846863062596;7123.430125589836;7136.7145314186855;7140.285971402818;7221.350078492961;7236.276372362721;4953.628477864103;5003.524665156804;5004.449510553909;5019.247112933089;5102.617303702312;4809.831655892167;4953.950460495349;4977.402711674622;5135.38375394955;5162.993216322931 06:04:42 INFO - PROCESS | 1656 | |4;prototype.html;297.14718757166935;297.396285540353;305.04216759375566;309.74291338189306;311.09316342860564;5080.0347933892535;5408.91886621701;5512.641678290918;5576.888462230758;5588.686658635217;5131.563817075544;5153.3558305211845;5312.654677445963;5441.863953401167;5455.345358556969;3853.901638033161;4145.2124096421585;4168.937465938014;4204.4653701399075;4210.599993000667;3723.7951912644794;4181.498220213579;4183.226103170923;4196.496420429553;4227.894302642428;3611.602723700404;3997.5003124609425;4135.855245066423;4175.248455278049;4199.790010499478;4134.958650413488;4148.336266197409;4150.813213405404;4152.439420678215;4169.061961058768;3061.6326040875015;3562.5546806649168;3631.691306238973;3639.525122916416;3646.9241573735812;4649.837255696035;5390;5398.676079435247;5409.323834520685;5434.184872269152;4235.623422387705;4776.665633405663;4803.975980120112;4841.564259216688;4846.9579040506105;5754.280714910637;5759.366469688331;5775.711214439261;5777.653340799523;5788.218590490272;3824.2160357126722;3950.506186726659;4002.639762421396;4006.1787333596544;4023.617756313175;5999.770047140326;6065.0599157131155;6066.423689749467;6085.330613632497;6105.771393441362;3586.9282614347567;4034.152827906114;4048.473698419187;4048.8785336439955;4061.735987160825;3492.371373152806;3598.9742923266745;3932.8820135395986;4027.2549578328103;4109.97945010273;4066.4916885389325;4741.715497070187;4782.799912040431;4790.952090479051;4835.887745818482;5171.4828517148735;5247.2129180623215;5425.701586412706;5511.53151982078;5859.451138754655;1311.8229039079793;1384.6776328606156;1388.6530065836123;1396.2948710901132;1420.2898550724638;824.8638974569249;840.995795021021;871.8404521985743;873.1312344217545;884.8628462588309;4404.010545657903;4524.796384162721;4557.951671115662;4589.816407343669;4598.068811099346;4348.760818155032;4730.881727956828;4947.678400904002;4960.975195124073;5108.489151084862;4038.7172897896867;4507.977460112678;5066.316047333637;5155.948440515622;5442.945570544323;3124.8281344525813;3142.701443362877;3144.4654408750566;3147.685231476834;3150.2281940924163;5956.374580669054;6060.818175454743;6187.48406640376;6213.260287119614;6227.626342419469;5181.922271165936;5451.618386712971;6104.877902441926;6126.387361263838;6143.938560614337;5679.949209396275;6150.692465376714;6171.179502046907;6225.408586184305;6238.315654773277;5048.949510504848;5063.468335824833;5847.590668653153;5918.615290006136;5997.361161089107;5024.819167495562;5865.618734782225;5876.559258055578;5887.20522729426;5904.9704751475965;5240.868978275574;5428.864278392914;6100.755969761338;6188.752449901954;6224.4561470127965;3924.823382947717;3944.013996500875;4020.819063142224;4031.798410079543;4043.4137050128156;4981.726005069756;5225.32789507354;5429.592780541396;6163.537734669828;6166.810782172264;5617.887642247214;5752.741126649227;5824.446677565625;5992.490638295793;6011;4940.9505904941925;5155.510226528474;5858.150568167506;5904.498117659875;5977.5217982560425;5549.334079910436;5739.598228123991;5773.4803867650435;5792.362840087671;5861.710423706778;5442.401335853132;5790.610253539205;5844.649321040752;5851;5894.583220879419;4780.593649539689;5725.742341594555;5729.2265544151005;5729.455701708331;5733.598648094593 06:04:42 INFO - PROCESS | 1656 | |5;yui.html;680.6902859199065;690.8272931767058;714.5819695478149;778.2528772378516;814.7026335387584;15055.62360940977;16239;16325.591860203502;16330.428435004776;16376.017438953657;14687.045342052787;14819.481318153867;14835.961482696215;14837.25813709313;14879.553613391588;687.9312068793106;708.4474110194056;716.9928300717004;839.4375768235267;843.8523258429766;861.9396642235046;865.2904618213067;874.3005595523588;875.0505701314082;875.8773771671939;931.753085432361;932.69687351611;934.6401635370397;934.6822080492631;934.8223837470858;709.4253654539839;733.431590517348;924.1313165624292;924.7225832250332;927.7958849053231;650.4991156809231;672.146374104889;674.4806498995795;674.5143496682381;677.1806114601338;15264;15277.236138193046;15289.082655040622;15298.617534561614;15312.234388280542;13184.34078296091;13903.165810051329;14355.354009069617;14397.568072957723;14479.565613031626;12008.759824803543;12298.200616959959;12323.568675096418;12674.176178548365;12723.363831808372;4609.769511524444;4619.5611416915335;4733.5503127202865;4761.2143996240575;4812.013537224861;110954;112939.87060129376;115920;117842;119522;11151.553937842558;11210.551577936954;11221.60724374643;11234.887651123385;11276.605318813803;22259.666105008437;22439.887800560893;22456.775432245468;22458.887705561367;22463.101475941105;7705.691772329044;7715.961420192863;7976.162502937224;8143.633536490872;8145.470544414594;4333.1766964276685;4415.6909016368545;4431.911361772746;4442.955570444319;4614.284785858197;3515.7538972271695;3618.7647802893252;3618.9638103619154;3626.7642603230706;3635.2729454109285;661.5402295404743;672.9427998620172;678.5792808458689;687.2817905288985;689.290031267795;551.7461967494917;634.9206349206349;638.3180319857117;640.6732566391081;647.0814036382055;8529.360472358629;9108.635654573744;9293.953530232306;9306.441613503077;9362.95318523403;623.370395900135;625.0717684238901;639.4341008207676;645.554567348528;655.7934250711011;4254.574542545721;4531.093781243764;4559.6124329431705;4571.1543364477675;4572.175048987561;101567.93728250788;121572;134295;137131;143989;100606.49090263652;116483.670326593;118951.40524297323;126557.73442265643;127445;75612.62193688996;113654;114441;115448;115712.42143789228;9786.1192492676;9819.263555233529;9951.113849089012;9986.950065249628;10095.091441770275;66966;67592.98610520945;67630.66184669045;67748.32251677617;69704.34057424111;89298;98518;102303;104261;106819;12796.936015319863;13022.47910083586;13132.34338283063;13159.53941612039;13537.526186583817;14453.349599267847;14481.565553033426;14564.85435145635;14734.926325368304;15017.924910375377;13378.9331053348;14056.156630602196;14087.366068526735;14374;14431.85568144347;12054.698632534257;12055.51777928908;12059.81910271329;12117.575884843987;13272.535461258809;12015;12042.518299267931;12300.569480068154;13374.264415457243;13510.324483775576;9738.269629777653;10747.408892510986;10802.72993175177;11217.66347009591;11827.586034488751;10652;11698;11732.765344693229;11831.290122592673;12023.27860328383 06:04:42 INFO - PROCESS | 1656 | __end_tp_report 06:04:42 INFO - PROCESS | 1656 | __start_cc_report 06:04:42 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1228 06:04:42 INFO - PROCESS | 1656 | __end_cc_report 06:04:42 INFO - PROCESS | 1656 | __startTimestamp1476709482796__endTimestamp 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | ------- Summary: start ------- 06:04:42 INFO - PROCESS | 1656 | Number of tests: 6 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5810.26 Median:6027.00 stddev:635.51 (10.5%) stddev-sans-first:606.89 06:04:42 INFO - PROCESS | 1656 | Values: 3328.2 3328.3 3360.3 3366.3 3400.9 5757.7 5869.7 5887.2 5890.6 5893.8 5834.7 5935.8 5935.9 5936.7 5950.9 5282.8 5303.9 5369.1 5375.9 5396.3 5265.1 5269.2 5300.6 5425.8 5443.1 5361.7 5373.0 5375.7 5384.7 5392.6 5379.1 5386.1 5388.0 5396.8 5402.1 4884.6 5269.9 5329.3 5341.1 5366.2 5947.4 5969.5 5973.0 5992.8 6050.3 6180.4 6187.0 6198.1 6204.3 6228.5 6079.1 6142.2 6155.8 6259.8 6260.0 5834.5 5835.3 5875.7 5901.0 5905.2 6245.2 6292.3 6341.3 6348.5 6358.3 6027.0 6138.1 6193.8 6252.8 6255.5 6211.7 6258.9 6275.0 6315.7 6324.1 4956.3 5328.5 6275.1 6300.3 6310.5 6106.4 6137.2 6279.4 6305.4 6324.6 4985.8 4995.5 5004.9 5008.3 5013.6 4461.0 4474.1 4480.2 4494.5 4512.1 5833.4 5850.9 5851.0 5893.6 5924.2 6268.5 6276.3 6280.8 6289.0 6289.2 5896.9 5921.7 5929.1 5937.0 5962.9 5350.0 5407.0 5411.1 5419.5 5498.6 6284.8 6354.7 6357.1 6360.6 6367.9 6256.3 6262.7 6268.8 6279.0 6291.2 6208.4 6337.7 6347.1 6364.4 6374.5 6109.4 6145.8 6188.9 6213.4 6289.7 5152.6 6242.2 6289.4 6296.0 6298.6 6199.3 6212.7 6213.2 6227.8 6262.1 6096.5 6112.7 6114.4 6134.2 6186.8 6089.0 6096.6 6100.5 6105.6 6142.7 6230.1 6250.4 6255.9 6261.2 6263.1 5866.0 5928.9 5957.0 6020.2 6022.2 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:77107.04 Median:3654.19 stddev:179826.47 (4921.1%) stddev-sans-first:180238.85 06:04:42 INFO - PROCESS | 1656 | Values: 459.5 486.6 489.7 505.9 526.1 31553.4 41168.6 42756.4 42841.8 44909.8 43411.8 43818.3 43869.0 43933.8 43998.6 8801.8 9898.5 10080.2 10087.4 10091.8 8962.6 9177.5 9190.7 9204.8 12201.6 12221.5 12404.1 12459.5 12476.4 12480.6 12303.2 12352.7 12367.5 12394.3 12398.2 12135.2 12226.7 12234.3 12235.3 12238.3 40489.6 41089.8 41405.4 41592.0 41712.4 3650.9 3657.5 3820.1 4011.2 4049.6 29793.9 30183.1 31568.9 32231.7 32650.7 3156.5 3196.9 3202.7 3290.0 3327.3 527721.0 530175.0 531074.0 531457.0 531699.0 33574.3 34165.3 61130.1 61299.0 61645.7 34955.8 35532.5 35563.1 35566.0 35576.8 15233.0 15402.8 15406.6 15413.0 15434.7 12911.9 13039.8 13042.3 13084.9 13095.4 7289.1 7400.1 7412.0 7521.4 7886.6 3123.6 3177.5 3238.1 3335.4 3345.4 941.1 951.4 994.8 1002.9 1017.6 30199.4 30334.5 30586.7 30899.4 30918.5 1047.8 1067.6 1082.5 1098.4 1173.0 15776.8 15784.5 15814.2 15867.3 16143.8 702225.0 706971.0 707001.0 709753.0 710491.0 49997.0 50955.7 56874.7 57287.0 57421.4 1179.7 1382.9 1418.2 1422.7 1423.3 30281.0 30907.5 31348.5 31567.8 32068.5 51079.7 51588.7 51656.5 51687.5 51852.2 581975.0 587094.0 827311.0 845863.0 847960.0 35014.0 41735.4 42487.3 42495.4 42693.4 45027.8 46089.0 46931.3 47349.8 47430.5 38969.0 39702.6 39823.0 39855.6 41390.4 39274.2 39552.8 40384.8 40702.8 41054.8 37568.6 38228.6 38619.2 38828.8 39061.6 33377.3 34594.7 35501.6 35554.0 35579.5 25625.5 25655.6 25785.9 25940.0 26272.5 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34858.56 Median:23019.52 stddev:100198.81 (435.3%) stddev-sans-first:100446.41 06:04:42 INFO - PROCESS | 1656 | Values: 358.6 376.2 378.8 389.7 412.0 15235.2 15351.7 18085.9 20334.9 20621.7 20119.4 20412.4 20674.2 20682.8 21185.0 4766.1 5957.3 6040.2 6236.3 6243.5 6000.9 6156.4 6160.3 6181.2 6185.9 5782.4 5971.8 6117.1 6151.9 6159.5 6000.3 6012.3 6052.1 6059.1 6067.5 5028.9 5219.0 5284.6 5289.9 5292.3 25823.7 26490.7 26585.6 26667.7 26909.0 2140.6 2215.1 2317.5 2426.1 2553.5 14681.7 15919.4 16052.1 16197.6 16597.1 1688.9 1851.2 1859.4 1889.4 1923.2 117972.0 119183.0 119807.4 120388.0 121687.0 10893.1 11308.9 11375.9 11447.9 11627.8 14419.1 14434.4 14437.6 14446.3 14453.6 7513.5 8601.1 8864.9 8909.6 8973.0 8872.6 8905.8 8956.0 9124.0 9155.6 5770.3 6781.6 6880.6 6888.8 6895.5 1811.4 1842.3 1846.6 1848.5 1849.4 951.5 1005.4 1013.7 1031.2 1042.4 21618.9 22487.2 22967.0 23072.1 23221.8 942.6 958.3 976.2 1012.6 1014.3 9009.8 11797.4 11834.3 12075.8 12088.2 588043.0 592844.0 605394.0 614014.9 614077.0 91733.0 117294.0 118481.8 123608.4 126150.4 1002.4 1006.3 1030.4 1044.5 1046.1 19574.2 20247.8 20379.2 20482.3 20542.1 40255.0 45285.0 51617.7 52627.2 53031.9 63833.0 70798.0 73357.0 74169.9 74265.6 6827.2 6991.0 7854.2 8028.5 8408.2 13034.7 13139.3 13290.3 13459.6 13511.4 9464.7 11246.9 11523.1 11590.8 11735.2 5146.3 9155.2 11449.1 11639.4 11781.5 11257.8 11582.8 11620.2 11639.5 11681.2 7963.4 8002.3 8133.9 8386.5 8416.7 11224.2 11231.2 11560.0 11604.9 11605.6 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5732.93 Median:4965.68 stddev:3199.27 (64.4%) stddev-sans-first:3191.38 06:04:42 INFO - PROCESS | 1656 | Values: 1361.9 1488.3 1498.5 1531.6 1910.0 7867.4 8331.2 8698.0 8952.3 8984.1 8781.9 8863.7 8873.8 8877.9 8883.2 2397.4 2432.9 2433.6 2436.4 2441.0 2392.1 2420.4 2431.7 2434.8 2437.0 2404.0 2409.7 2420.6 2422.3 2423.1 2374.5 2400.1 2400.5 2401.5 2416.5 2368.7 2394.8 2399.9 2400.6 2402.1 7756.5 8615.3 8860.2 8953.2 8960.0 5239.2 5463.0 5468.3 5476.9 5480.1 3626.1 3642.6 3701.8 3720.2 3741.3 1095.8 1104.6 1106.6 1115.8 1121.7 11685.0 11767.2 11788.4 11798.8 11808.2 4500.5 4540.7 4727.8 4734.0 4749.3 9244.7 9252.5 9253.8 9258.4 9271.4 5319.5 5328.0 5328.1 5332.2 5335.7 4184.9 4428.2 4581.6 4590.3 4946.3 3832.5 3887.7 3933.6 3957.1 3960.6 1009.0 1175.2 1177.7 1192.5 1193.1 818.6 914.0 922.6 929.9 937.8 5795.8 5943.6 5982.3 6144.1 6165.0 940.0 945.5 991.2 994.2 1016.5 3661.6 3689.7 3835.6 3901.9 4050.8 10605.2 10884.2 10969.9 10989.1 10990.0 10316.3 10620.2 10636.2 10640.7 11016.2 8261.8 8460.7 8478.0 8480.9 8484.9 5619.6 5658.4 5981.0 6004.4 6077.6 9782.0 10112.1 10193.3 10198.0 10276.3 9064.6 9489.0 10312.4 10475.8 10489.0 7091.0 7351.3 7492.8 7601.1 7743.3 8389.7 8410.0 8430.6 8470.5 8512.7 7593.9 7604.8 7610.5 7643.8 7657.2 7454.6 7503.9 7526.4 7528.9 7656.8 7123.4 7136.7 7140.3 7221.4 7236.3 4953.6 5003.5 5004.4 5019.2 5102.6 4809.8 4954.0 4977.4 5135.4 5163.0 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4648.21 Median:5120.03 stddev:1435.68 (28.0%) stddev-sans-first:1402.07 06:04:42 INFO - PROCESS | 1656 | Values: 297.1 297.4 305.0 309.7 311.1 5080.0 5408.9 5512.6 5576.9 5588.7 5131.6 5153.4 5312.7 5441.9 5455.3 3853.9 4145.2 4168.9 4204.5 4210.6 3723.8 4181.5 4183.2 4196.5 4227.9 3611.6 3997.5 4135.9 4175.2 4199.8 4135.0 4148.3 4150.8 4152.4 4169.1 3061.6 3562.6 3631.7 3639.5 3646.9 4649.8 5390.0 5398.7 5409.3 5434.2 4235.6 4776.7 4804.0 4841.6 4847.0 5754.3 5759.4 5775.7 5777.7 5788.2 3824.2 3950.5 4002.6 4006.2 4023.6 5999.8 6065.1 6066.4 6085.3 6105.8 3586.9 4034.2 4048.5 4048.9 4061.7 3492.4 3599.0 3932.9 4027.3 4110.0 4066.5 4741.7 4782.8 4791.0 4835.9 5171.5 5247.2 5425.7 5511.5 5859.5 1311.8 1384.7 1388.7 1396.3 1420.3 824.9 841.0 871.8 873.1 884.9 4404.0 4524.8 4558.0 4589.8 4598.1 4348.8 4730.9 4947.7 4961.0 5108.5 4038.7 4508.0 5066.3 5155.9 5442.9 3124.8 3142.7 3144.5 3147.7 3150.2 5956.4 6060.8 6187.5 6213.3 6227.6 5181.9 5451.6 6104.9 6126.4 6143.9 5679.9 6150.7 6171.2 6225.4 6238.3 5048.9 5063.5 5847.6 5918.6 5997.4 5024.8 5865.6 5876.6 5887.2 5905.0 5240.9 5428.9 6100.8 6188.8 6224.5 3924.8 3944.0 4020.8 4031.8 4043.4 4981.7 5225.3 5429.6 6163.5 6166.8 5617.9 5752.7 5824.4 5992.5 6011.0 4941.0 5155.5 5858.2 5904.5 5977.5 5549.3 5739.6 5773.5 5792.4 5861.7 5442.4 5790.6 5844.6 5851.0 5894.6 4780.6 5725.7 5729.2 5729.5 5733.6 06:04:42 INFO - PROCESS | 1656 | 06:04:42 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24522.78 Median:22460.99 stddev:38037.44 (169.3%) stddev-sans-first:38102.02 06:04:42 INFO - PROCESS | 1656 | Values: 680.7 690.8 714.6 778.3 814.7 15055.6 16239.0 16325.6 16330.4 16376.0 14687.0 14819.5 14836.0 14837.3 14879.6 687.9 708.4 717.0 839.4 843.9 861.9 865.3 874.3 875.1 875.9 931.8 932.7 934.6 934.7 934.8 709.4 733.4 924.1 924.7 927.8 650.5 672.1 674.5 674.5 677.2 15264.0 15277.2 15289.1 15298.6 15312.2 13184.3 13903.2 14355.4 14397.6 14479.6 12008.8 12298.2 12323.6 12674.2 12723.4 4609.8 4619.6 4733.6 4761.2 4812.0 110954.0 112939.9 115920.0 117842.0 119522.0 11151.6 11210.6 11221.6 11234.9 11276.6 22259.7 22439.9 22456.8 22458.9 22463.1 7705.7 7716.0 7976.2 8143.6 8145.5 4333.2 4415.7 4431.9 4443.0 4614.3 3515.8 3618.8 3619.0 3626.8 3635.3 661.5 672.9 678.6 687.3 689.3 551.7 634.9 638.3 640.7 647.1 8529.4 9108.6 9294.0 9306.4 9363.0 623.4 625.1 639.4 645.6 655.8 4254.6 4531.1 4559.6 4571.2 4572.2 101567.9 121572.0 134295.0 137131.0 143989.0 100606.5 116483.7 118951.4 126557.7 127445.0 75612.6 113654.0 114441.0 115448.0 115712.4 9786.1 9819.3 9951.1 9987.0 10095.1 66966.0 67593.0 67630.7 67748.3 69704.3 89298.0 98518.0 102303.0 104261.0 106819.0 12796.9 13022.5 13132.3 13159.5 13537.5 14453.3 14481.6 14564.9 14734.9 15017.9 13378.9 14056.2 14087.4 14374.0 14431.9 12054.7 12055.5 12059.8 12117.6 13272.5 12015.0 12042.5 12300.6 13374.3 13510.3 9738.3 10747.4 10802.7 11217.7 11827.6 10652.0 11698.0 11732.8 11831.3 12023.3 06:04:42 INFO - PROCESS | 1656 | -------- Summary: end -------- 06:04:42 INFO - PROCESS | 1656 | 06:04:43 INFO - TEST-INFO | 1656: exit 0 06:04:43 INFO - TEST-OK | dromaeo_css | took 1117301ms 06:04:43 INFO - TEST-START | kraken 06:04:43 INFO - operating with platform_type : mac_ 06:04:43 INFO - Initialising browser for kraken test... 06:04:43 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpOlqEF3/profile http://localhost:49274/getInfo.html) 06:04:45 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 06:04:45 INFO - PROCESS | 1666 | colorDepth:24 06:04:45 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 06:04:45 INFO - PROCESS | 1666 | __metrics 06:04:45 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:04:45 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:04:46 INFO - TEST-INFO | 1666: exit 0 06:04:46 INFO - Browser initialized. 06:04:46 INFO - Running cycle 1/1 for kraken test... 06:04:46 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpOlqEF3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:58 INFO - PROCESS | 1667 | RSS: Main: 220168192 06:04:58 INFO - PROCESS | 1667 | 06:05:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:02 INFO - PROCESS | 1667 | RSS: Main: 269672448 06:05:02 INFO - PROCESS | 1667 | 06:05:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 06:05:05 INFO - PROCESS | 1667 | RSS: Main: 280715264 06:05:05 INFO - PROCESS | 1667 | 06:05:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 06:05:09 INFO - PROCESS | 1667 | RSS: Main: 379572224 06:05:09 INFO - PROCESS | 1667 | 06:05:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 06:05:11 INFO - PROCESS | 1667 | RSS: Main: 279433216 06:05:11 INFO - PROCESS | 1667 | 06:05:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:14 INFO - PROCESS | 1667 | RSS: Main: 280301568 06:05:14 INFO - PROCESS | 1667 | 06:05:17 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:18 INFO - PROCESS | 1667 | RSS: Main: 319246336 06:05:18 INFO - PROCESS | 1667 | 06:05:21 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:21 INFO - PROCESS | 1667 | RSS: Main: 318951424 06:05:21 INFO - PROCESS | 1667 | 06:05:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 06:05:25 INFO - PROCESS | 1667 | RSS: Main: 315404288 06:05:25 INFO - PROCESS | 1667 | 06:05:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:27 INFO - PROCESS | 1667 | RSS: Main: 290021376 06:05:27 INFO - PROCESS | 1667 | 06:05:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:29 INFO - PROCESS | 1667 | RSS: Main: 294236160 06:05:29 INFO - PROCESS | 1667 | 06:05:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:32 INFO - PROCESS | 1667 | RSS: Main: 302501888 06:05:32 INFO - PROCESS | 1667 | 06:05:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:36 INFO - PROCESS | 1667 | RSS: Main: 309579776 06:05:36 INFO - PROCESS | 1667 | 06:05:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:39 INFO - PROCESS | 1667 | RSS: Main: 308981760 06:05:39 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 06:05:41 INFO - PROCESS | 1667 | RSS: Main: 353120256 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | __start_tp_report 06:05:41 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 06:05:41 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 06:05:41 INFO - PROCESS | 1667 | |i|pagename|runs| 06:05:41 INFO - PROCESS | 1667 | |0;ai-astar;115;115;115;114;113;114;114;114;114;114 06:05:41 INFO - PROCESS | 1667 | |1;audio-beat-detection;141;108;111;142;122;111;108;107;140;119 06:05:41 INFO - PROCESS | 1667 | |2;audio-dft;184;184;183;182;183;183;183;184;184;186 06:05:41 INFO - PROCESS | 1667 | |3;audio-fft;80;60;79;113;85;82;50;73;99;80 06:05:41 INFO - PROCESS | 1667 | |4;audio-oscillator;87;70;94;68;69;71;91;65;67;87 06:05:41 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;88;128;132;85;87;83;87;116;87;83 06:05:41 INFO - PROCESS | 1667 | |6;imaging-darkroom;98;96;96;105;96;95;97;123;157;100 06:05:41 INFO - PROCESS | 1667 | |7;imaging-desaturate;85;85;84;84;86;84;85;84;86;107 06:05:41 INFO - PROCESS | 1667 | |8;json-parse-financial;56;53;53;54;56;58;56;57;56;57 06:05:41 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;65;76;77;72;72;70;69;71;70;71 06:05:41 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;83;85;83;83;80;80;82;81;92;87 06:05:41 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;138;137;137;134;139;145;146;158;168;135 06:05:41 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;164;165;169;159;165;164;174;220;183;160 06:05:41 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;67;63;70;84;79;67;67;66;65 06:05:41 INFO - PROCESS | 1667 | __end_tp_report 06:05:41 INFO - PROCESS | 1667 | __start_cc_report 06:05:41 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1979 06:05:41 INFO - PROCESS | 1667 | __end_cc_report 06:05:41 INFO - PROCESS | 1667 | __startTimestamp1476709541735__endTimestamp 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | ------- Summary: start ------- 06:05:41 INFO - PROCESS | 1667 | Number of tests: 14 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 06:05:41 INFO - PROCESS | 1667 | Values: 115.0 115.0 115.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:120.50 stddev:14.69 (12.2%) stddev-sans-first:13.66 06:05:41 INFO - PROCESS | 1667 | Values: 141.0 108.0 111.0 142.0 122.0 111.0 108.0 107.0 140.0 119.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.07 (0.6%) stddev-sans-first:1.13 06:05:41 INFO - PROCESS | 1667 | Values: 184.0 184.0 183.0 182.0 183.0 183.0 183.0 184.0 184.0 186.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:80.10 Median:80.00 stddev:17.73 (22.2%) stddev-sans-first:18.80 06:05:41 INFO - PROCESS | 1667 | Values: 80.0 60.0 79.0 113.0 85.0 82.0 50.0 73.0 99.0 80.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:79.00 stddev:11.35 (14.4%) stddev-sans-first:11.43 06:05:41 INFO - PROCESS | 1667 | Values: 87.0 70.0 94.0 68.0 69.0 71.0 91.0 65.0 67.0 87.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:97.60 Median:86.00 stddev:19.61 (22.8%) stddev-sans-first:20.49 06:05:41 INFO - PROCESS | 1667 | Values: 88.0 128.0 132.0 85.0 87.0 83.0 87.0 116.0 87.0 83.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:96.00 stddev:19.70 (20.5%) stddev-sans-first:20.66 06:05:41 INFO - PROCESS | 1667 | Values: 98.0 96.0 96.0 105.0 96.0 95.0 97.0 123.0 157.0 100.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:85.00 stddev:7.07 (8.3%) stddev-sans-first:7.46 06:05:41 INFO - PROCESS | 1667 | Values: 85.0 85.0 84.0 84.0 86.0 84.0 85.0 84.0 86.0 107.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.71 (3.1%) stddev-sans-first:1.81 06:05:41 INFO - PROCESS | 1667 | Values: 56.0 53.0 53.0 54.0 56.0 58.0 56.0 57.0 56.0 57.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.40 (4.8%) stddev-sans-first:2.74 06:05:41 INFO - PROCESS | 1667 | Values: 65.0 76.0 77.0 72.0 72.0 70.0 69.0 71.0 70.0 71.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:3.66 (4.4%) stddev-sans-first:3.87 06:05:41 INFO - PROCESS | 1667 | Values: 83.0 85.0 83.0 83.0 80.0 80.0 82.0 81.0 92.0 87.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:142.00 stddev:11.14 (7.8%) stddev-sans-first:11.62 06:05:41 INFO - PROCESS | 1667 | Values: 138.0 137.0 137.0 134.0 139.0 145.0 146.0 158.0 168.0 135.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:167.00 stddev:18.18 (10.9%) stddev-sans-first:19.04 06:05:41 INFO - PROCESS | 1667 | Values: 164.0 165.0 169.0 159.0 165.0 164.0 174.0 220.0 183.0 160.0 06:05:41 INFO - PROCESS | 1667 | 06:05:41 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:68.00 stddev:6.62 (9.7%) stddev-sans-first:7.01 06:05:41 INFO - PROCESS | 1667 | Values: 69.0 67.0 63.0 70.0 84.0 79.0 67.0 67.0 66.0 65.0 06:05:41 INFO - PROCESS | 1667 | -------- Summary: end -------- 06:05:41 INFO - PROCESS | 1667 | 06:05:42 INFO - TEST-INFO | 1667: exit 0 06:05:42 INFO - TEST-OK | kraken | took 59054ms 06:05:42 INFO - SUITE-END | took 1176s 06:05:42 INFO - Completed test suite (00:19:36) 06:05:42 INFO - javascript benchmark 06:05:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.151321413039, 3328.334333133374, 3360.2943381889786, 3366.2594229269553, 3400.931981360373, 5757.7121143942795, 5869.706514674271, 5887.175795388649, 5890.64656120633, 5893.823185304437, 5834.679092649913, 5935.821925342247, 5935.940640593592, 5936.703164841762, 5950.851228719273, 5282.788688452457, 5303.893922121555, 5369.060414427479, 5375.892482150354, 5396.298481197439, 5265.131253343194, 5269.1832765921345, 5300.575953923677, 5425.810096646618, 5443.129099344106, 5361.651492652984, 5373.032854086263, 5375.650582712131, 5384.703841288728, 5392.56859451245, 5379.112446446332, 5386.084365657828, 5388.003219404403, 5396.78412863485, 5402.108652072403, 4884.5848102911295, 5269.894602107936, 5329.333833270841, 5341.145416733343, 5366.221897824833, 5947.375525569796, 5969.522438204933, 5972.9701351493395, 5992.760289588411, 6050.273967123973, 6180.381961803829, 6187.0, 6198.101275315054, 6204.317525072239, 6228.470580000705, 6079.05774604937, 6142.232220972379, 6155.846103847395, 6259.843503912393, 6260.0, 5834.533237341003, 5835.328937172237, 5875.676837773964, 5901.0, 5905.202797622352, 6245.156903818017, 6292.276388215322, 6341.302456729756, 6348.523860710465, 6358.332375100548, 6027.0, 6138.143176733788, 6193.783217587363, 6252.812415627538, 6255.468285195719, 6211.720472578745, 6258.906116408258, 6275.0, 6315.652639104894, 6324.08300796382, 4956.281339205795, 5328.49379308965, 6275.1199273953835, 6300.2754683212015, 6310.5267104967315, 6106.358832322542, 6137.171481849982, 6279.372062793684, 6305.369463053658, 6324.620522768649, 4985.825496107619, 4995.475475075064, 5004.874878128003, 5008.298838162587, 5013.573846223039, 4460.977695111568, 4474.0604473060375, 4480.238359478896, 4494.52807455219, 4512.142692888341, 5833.358330583633, 5850.8537286567325, 5850.970745146247, 5893.616914900518, 5924.229850119457, 6268.49852011838, 6276.340984196685, 6280.842978925563, 6289.0, 6289.245290565162, 5896.882062358729, 5921.703914804242, 5929.110633405024, 5936.9610318194145, 5962.880742385128, 5350.0, 5407.0, 5411.053065713484, 5419.539339156137, 5498.642588231752, 6284.842878927972, 6354.682265886595, 6357.078223657544, 6360.586561873463, 6367.904481432783, 6256.31180570146, 6262.68686565679, 6268.780592679234, 6278.968605156945, 6291.213598300213, 6208.441240288395, 6337.65142917144, 6347.079673447417, 6364.363563643598, 6374.458171055512, 6109.404666050238, 6145.832291864532, 6188.938110618837, 6213.409726076015, 6289.685515724104, 5152.639315248047, 6242.188515492957, 6289.371062893674, 6296.0, 6298.559100862895, 6199.349068347939, 6212.658303793335, 6213.1922850029205, 6227.782027629011, 6262.091996660368, 6096.542759292982, 6112.74665817949, 6114.419025732044, 6134.202553667995, 6186.810776317612, 6088.969555152196, 6096.631307267998, 6100.450959413674, 6105.550726437353, 6142.692865356625, 6230.096635987847, 6250.4374606285655, 6255.874882502233, 6261.186045814015, 6263.091851681572, 5866.0, 5928.851778705567, 5956.970215148896, 6020.247469066367, 6022.187004754477], "value": 5770.08289307883, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.5450504001039, 486.60828033433097, 489.71107046842354, 505.8946202547433, 526.1003683700872, 31553.368932621335, 41168.58831411685, 42756.358654620126, 42841.78579107108, 44909.77545112278, 43411.78294108533, 43818.342724859074, 43869.0, 43933.7803310983, 43998.560014399845, 8801.823963520726, 9898.455584942825, 10080.193584513258, 10087.445190514518, 10091.798164036714, 8962.551872406386, 9177.54112294386, 9190.678326258583, 9204.815903681922, 12201.633950981484, 12221.511139554406, 12404.069694772883, 12459.501619935192, 12476.438560264765, 12480.563180288691, 12303.200291981037, 12352.691182720415, 12367.505299788088, 12394.31831249281, 12398.194117382342, 12135.150539462242, 12226.694332641666, 12234.265944043296, 12235.32705701186, 12238.265704057785, 40489.59510404888, 41089.79455102735, 41405.37891931624, 41592.0, 41712.374314385306, 3650.908727281813, 3657.4696668982847, 3820.1388509808385, 4011.197760447922, 4049.6152865477734, 29793.851030744707, 30183.095433824168, 31568.895088671787, 32231.6776832231, 32650.67349326524, 3156.5111722838174, 3196.8721251149927, 3202.727768139711, 3289.9835500822583, 3327.3012667339885, 527721.0, 530175.0, 531074.0, 531457.0, 531698.9999999962, 33574.32851343008, 34165.316693666486, 61130.083048754306, 61299.0, 61645.691771540856, 34955.82522087373, 35532.46701299431, 35563.11092222663, 35566.0, 35576.82211588977, 15233.0, 15402.845971540366, 15406.614834629225, 15413.0, 15434.691306173814, 12911.935440322739, 13039.804402933964, 13042.347882605833, 13084.869151308556, 13095.410706518229, 7289.052423185058, 7400.074990626172, 7411.962940185264, 7521.435892308099, 7886.645100970355, 3123.6095488063993, 3177.53925680775, 3238.077148012805, 3335.366280406715, 3345.4480010798434, 941.1247539787926, 951.362587066667, 994.8159590475785, 1002.9097381235724, 1017.5675337981328, 30199.396012079636, 30334.54498182529, 30586.69413305883, 30899.382012359627, 30918.53622195669, 1047.8061558611528, 1067.5996501312009, 1082.5128692088592, 1098.4123493930708, 1173.0439691651277, 15776.842231577766, 15784.526464206092, 15814.209289535707, 15867.285972131282, 16143.757843632355, 702225.0, 706971.0, 707001.0, 709753.0, 710491.0, 49997.0, 50955.74522127365, 56874.7156264216, 57287.0, 57421.42578574161, 1179.6991767099507, 1382.8755412012968, 1418.2412409361148, 1422.6870088580495, 1423.3239211374514, 30281.0, 30907.536386954664, 31348.529772053895, 31567.84216078905, 32068.51897221497, 51079.744601276754, 51588.71028224324, 51656.483435165166, 51687.48312516827, 51852.222216667535, 581975.0, 587094.0, 827311.0, 845863.0, 847960.0, 35014.0, 41735.373969389875, 42487.30050797934, 42495.362569560864, 42693.35959960541, 45027.77486112549, 46089.0, 46931.296030560254, 47349.763251183525, 47430.52569474261, 38969.0, 39702.60297396989, 39823.00442488845, 39855.601443985186, 41390.37914431346, 39274.2145157101, 39552.80223598864, 40384.79807600943, 40702.79648601738, 41054.79472602618, 37568.62431375761, 38228.617713823616, 38619.22761544697, 38828.80585597054, 39061.63284285036, 33377.332453351286, 34594.65405345914, 35501.644983549835, 35554.0, 35579.46630800592, 25625.487490249718, 25655.615165772157, 25785.871070645277, 25940.0, 26272.474550509265], "value": 19708.31102066128, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.6091160634907, 376.1930658737009, 378.78787878787864, 389.6551551876589, 411.9526254480734, 15235.238238088094, 15351.69296614067, 18085.909570452146, 20334.881581513047, 20621.690674639893, 20119.396418107444, 20412.387628371136, 20674.17303307866, 20682.793172068275, 21185.0, 4766.070616229837, 5957.344692083878, 6040.184575082351, 6236.314005459396, 6243.531735119862, 6000.879982400349, 6156.445919867211, 6160.291566469846, 6181.227346581677, 6185.87628247437, 5782.3639399666, 5971.790987315445, 6117.143599896018, 6151.87696246077, 6159.476444502223, 6000.33996260411, 6012.338642749294, 6052.092186172065, 6059.091136329542, 6067.453929146398, 5028.949710502921, 5219.0, 5284.550813180885, 5289.920651190235, 5292.338457692788, 25823.74176258251, 26490.735092649018, 26585.601215981776, 26667.733322666718, 26909.0, 2140.6253905566464, 2215.102883332253, 2317.466982593996, 2426.065964603623, 2553.4893021395796, 14681.706365872622, 15919.442819501377, 16052.11713355765, 16197.595060123473, 16597.087160206185, 1688.9324427022905, 1851.1577232359243, 1859.3585213101458, 1889.3670620342064, 1923.1730355946938, 117972.0, 119183.0, 119807.4009629955, 120388.0, 121686.99999999911, 10893.128549716163, 11308.943455282671, 11375.886241137649, 11447.942760286145, 11627.767444651228, 14419.134851908919, 14434.350454229585, 14437.639059023399, 14446.277686115653, 14453.566393008226, 7513.4740568159705, 8601.139886011473, 8864.872430616606, 8909.55452227386, 8973.012968573452, 8872.64509419616, 8905.831057826663, 8955.955220223857, 9124.0, 9155.633774648939, 5770.336411312669, 6781.6270105144695, 6880.552764070319, 6888.827779305458, 6895.5173137879865, 1811.4203454894307, 1842.2999260281276, 1846.5660569766094, 1848.4639454558028, 1849.398945342742, 951.5052172870069, 1005.3766664667953, 1013.6502906497246, 1031.169908223887, 1042.4006196436928, 21618.89190554037, 22487.21294754676, 22966.966486508147, 23072.077116915472, 23221.76778232196, 942.6370847223731, 958.3148049144895, 976.1751320134475, 1012.5747186181821, 1014.264658122855, 9009.774755631031, 11797.351145686898, 11834.289942603471, 12075.818862717066, 12088.153829232046, 588043.0, 592844.0, 605394.0, 614014.9299253476, 614077.0, 91733.0, 117294.0, 118481.81518184708, 123608.38195808964, 126150.36924815501, 1002.3534820040887, 1006.2905651515664, 1030.4332617060586, 1044.5456226541478, 1046.0951277145214, 19574.238318551397, 20247.79752202459, 20379.184832607123, 20482.283120090724, 20542.07560659744, 40255.0, 45285.0, 51617.741911291705, 52627.21059184192, 53031.939361211786, 63833.04250436154, 70798.0, 73357.0, 74169.88745168719, 74265.62867185629, 6827.249002609609, 6991.0, 7854.2145785421, 8028.4781489203015, 8408.159184081544, 13034.739305214032, 13139.34303284851, 13290.269035203157, 13459.596212113653, 13511.391987360395, 9464.668736594185, 11246.943765281121, 11523.078153747512, 11590.826137607773, 11735.23720958135, 5146.305248791515, 9155.221806146552, 11449.141314401286, 11639.359835209145, 11781.469833857669, 11257.831132532854, 11582.826257606312, 11620.186586939171, 11639.53441862316, 11681.182317237712, 7963.362930965624, 8002.3198028165925, 8133.918660813316, 8386.496810191407, 8416.747497575083, 11224.15818813576, 11231.213815033196, 11560.017398520884, 11604.94197529007, 11605.593804216813], "value": 9807.47698831709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.945522179113, 1488.2856229010074, 1498.4680438444348, 1531.5635044012456, 1909.9713504297429, 7867.370610351172, 8331.166883311666, 8698.043215246325, 8952.283817294618, 8984.101589841013, 8781.91218087819, 8863.734087977355, 8873.778155546115, 8877.911220887789, 8883.15610017049, 2397.4126339046916, 2432.8540287582714, 2433.610622300432, 2436.378723425524, 2440.987795061031, 2392.138830021191, 2420.419099416145, 2431.671724317212, 2434.817388695855, 2436.9634455483183, 2403.9639405408843, 2409.674678926592, 2420.6248031555137, 2422.34596658902, 2423.09134074722, 2374.5250949810106, 2400.12395475651, 2400.459896523268, 2401.4836810085826, 2416.5046165536023, 2368.7275963264274, 2394.820388470872, 2399.928002159938, 2400.603900356439, 2402.1112188490197, 7756.457048006641, 8615.267702245317, 8860.24687901529, 8953.194212520904, 8959.955200223958, 5239.187925871458, 5463.043967305745, 5468.316460442445, 5476.945230547683, 5480.095784195603, 3626.0934766308424, 3642.581103173116, 3701.759385639925, 3720.1629633332554, 3741.289155060557, 1095.8246680531156, 1104.5913012185542, 1106.618216715232, 1115.782422427627, 1121.6966035026849, 11685.006774424184, 11767.23512971654, 11788.410579471078, 11798.764024719458, 11808.169733691291, 4500.5274446182675, 4540.6821522493765, 4727.810887564459, 4733.952660473351, 4749.311349854252, 9244.722658320261, 9252.53737313145, 9253.768655783524, 9258.444493330422, 9271.397359171633, 5319.547838433777, 5328.040952628487, 5328.094223981932, 5332.200169974457, 5335.733213339317, 4184.853530126431, 4428.202923473741, 4581.610563102174, 4590.334401511762, 4946.307516947631, 3832.48261484696, 3887.74729642578, 3933.645971862546, 3957.050307926077, 3960.584138665456, 1008.9949550252202, 1175.1538891997748, 1177.6879127031343, 1192.4574318684977, 1193.1349771415828, 818.55388813097, 913.9763464919333, 922.6217250927087, 929.8884133903974, 937.803061357109, 5795.7971470999155, 5943.64338139713, 5982.341942386334, 6144.139820425144, 6165.0444181152, 939.9765005874771, 945.5272363818091, 991.2317953586029, 994.174834887042, 1016.5069941078718, 3661.5972243053243, 3689.6863766579604, 3835.5972622874756, 3901.9464744519387, 4050.8379664813665, 10605.151587872951, 10884.238103332691, 10969.945150274358, 10989.06592939593, 10990.0, 10316.277860549839, 10620.20348473852, 10636.202284828669, 10640.68077957647, 11016.17378696601, 8261.793455163548, 8460.746177614681, 8478.02502712196, 8480.915190848013, 8484.915150848412, 5619.578531610064, 5658.405867383865, 5980.970095149496, 6004.369541198112, 6077.5745697802495, 9782.0, 10112.140468060297, 10193.337433066827, 10198.031187037219, 10276.332038417479, 9064.637414503346, 9488.95255523718, 10312.432816195182, 10475.842862357224, 10489.0, 7091.042709234187, 7351.264873512606, 7492.812679683051, 7601.125870524739, 7743.264389882952, 8389.664413423394, 8410.0, 8430.578471076544, 8470.49177049379, 8512.659493620185, 7593.924060759543, 7604.809879752829, 7610.543367397974, 7643.808904777425, 7657.1959944205055, 7454.589997550187, 7503.9249607503225, 7526.435517336112, 7528.887066693895, 7656.846863062596, 7123.430125589836, 7136.7145314186855, 7140.285971402818, 7221.350078492961, 7236.276372362721, 4953.628477864103, 5003.524665156804, 5004.449510553909, 5019.247112933089, 5102.617303702312, 4809.831655892167, 4953.950460495349, 4977.402711674622, 5135.38375394955, 5162.993216322931], "value": 4610.074568133892, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.14718757166935, 297.396285540353, 305.04216759375566, 309.74291338189306, 311.09316342860564, 5080.0347933892535, 5408.91886621701, 5512.641678290918, 5576.888462230758, 5588.686658635217, 5131.563817075544, 5153.3558305211845, 5312.654677445963, 5441.863953401167, 5455.345358556969, 3853.901638033161, 4145.2124096421585, 4168.937465938014, 4204.4653701399075, 4210.599993000667, 3723.7951912644794, 4181.498220213579, 4183.226103170923, 4196.496420429553, 4227.894302642428, 3611.602723700404, 3997.5003124609425, 4135.855245066423, 4175.248455278049, 4199.790010499478, 4134.958650413488, 4148.336266197409, 4150.813213405404, 4152.439420678215, 4169.061961058768, 3061.6326040875015, 3562.5546806649168, 3631.691306238973, 3639.525122916416, 3646.9241573735812, 4649.837255696035, 5390.0, 5398.676079435247, 5409.323834520685, 5434.184872269152, 4235.623422387705, 4776.665633405663, 4803.975980120112, 4841.564259216688, 4846.9579040506105, 5754.280714910637, 5759.366469688331, 5775.711214439261, 5777.653340799523, 5788.218590490272, 3824.2160357126722, 3950.506186726659, 4002.639762421396, 4006.1787333596544, 4023.617756313175, 5999.770047140326, 6065.0599157131155, 6066.423689749467, 6085.330613632497, 6105.771393441362, 3586.9282614347567, 4034.152827906114, 4048.473698419187, 4048.8785336439955, 4061.735987160825, 3492.371373152806, 3598.9742923266745, 3932.8820135395986, 4027.2549578328103, 4109.97945010273, 4066.4916885389325, 4741.715497070187, 4782.799912040431, 4790.952090479051, 4835.887745818482, 5171.4828517148735, 5247.2129180623215, 5425.701586412706, 5511.53151982078, 5859.451138754655, 1311.8229039079793, 1384.6776328606156, 1388.6530065836123, 1396.2948710901132, 1420.2898550724638, 824.8638974569249, 840.995795021021, 871.8404521985743, 873.1312344217545, 884.8628462588309, 4404.010545657903, 4524.796384162721, 4557.951671115662, 4589.816407343669, 4598.068811099346, 4348.760818155032, 4730.881727956828, 4947.678400904002, 4960.975195124073, 5108.489151084862, 4038.7172897896867, 4507.977460112678, 5066.316047333637, 5155.948440515622, 5442.945570544323, 3124.8281344525813, 3142.701443362877, 3144.4654408750566, 3147.685231476834, 3150.2281940924163, 5956.374580669054, 6060.818175454743, 6187.48406640376, 6213.260287119614, 6227.626342419469, 5181.922271165936, 5451.618386712971, 6104.877902441926, 6126.387361263838, 6143.938560614337, 5679.949209396275, 6150.692465376714, 6171.179502046907, 6225.408586184305, 6238.315654773277, 5048.949510504848, 5063.468335824833, 5847.590668653153, 5918.615290006136, 5997.361161089107, 5024.819167495562, 5865.618734782225, 5876.559258055578, 5887.20522729426, 5904.9704751475965, 5240.868978275574, 5428.864278392914, 6100.755969761338, 6188.752449901954, 6224.4561470127965, 3924.823382947717, 3944.013996500875, 4020.819063142224, 4031.798410079543, 4043.4137050128156, 4981.726005069756, 5225.32789507354, 5429.592780541396, 6163.537734669828, 6166.810782172264, 5617.887642247214, 5752.741126649227, 5824.446677565625, 5992.490638295793, 6011.0, 4940.9505904941925, 5155.510226528474, 5858.150568167506, 5904.498117659875, 5977.5217982560425, 5549.334079910436, 5739.598228123991, 5773.4803867650435, 5792.362840087671, 5861.710423706778, 5442.401335853132, 5790.610253539205, 5844.649321040752, 5851.0, 5894.583220879419, 4780.593649539689, 5725.742341594555, 5729.2265544151005, 5729.455701708331, 5733.598648094593], "value": 4185.464246209588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.6902859199065, 690.8272931767058, 714.5819695478149, 778.2528772378516, 814.7026335387584, 15055.62360940977, 16239.0, 16325.591860203502, 16330.428435004776, 16376.017438953657, 14687.045342052787, 14819.481318153867, 14835.961482696215, 14837.25813709313, 14879.553613391588, 687.9312068793106, 708.4474110194056, 716.9928300717004, 839.4375768235267, 843.8523258429766, 861.9396642235046, 865.2904618213067, 874.3005595523588, 875.0505701314082, 875.8773771671939, 931.753085432361, 932.69687351611, 934.6401635370397, 934.6822080492631, 934.8223837470858, 709.4253654539839, 733.431590517348, 924.1313165624292, 924.7225832250332, 927.7958849053231, 650.4991156809231, 672.146374104889, 674.4806498995795, 674.5143496682381, 677.1806114601338, 15264.0, 15277.236138193046, 15289.082655040622, 15298.617534561614, 15312.234388280542, 13184.34078296091, 13903.165810051329, 14355.354009069617, 14397.568072957723, 14479.565613031626, 12008.759824803543, 12298.200616959959, 12323.568675096418, 12674.176178548365, 12723.363831808372, 4609.769511524444, 4619.5611416915335, 4733.5503127202865, 4761.2143996240575, 4812.013537224861, 110954.0, 112939.87060129376, 115920.0, 117842.0, 119522.0, 11151.553937842558, 11210.551577936954, 11221.60724374643, 11234.887651123385, 11276.605318813803, 22259.666105008437, 22439.887800560893, 22456.775432245468, 22458.887705561367, 22463.101475941105, 7705.691772329044, 7715.961420192863, 7976.162502937224, 8143.633536490872, 8145.470544414594, 4333.1766964276685, 4415.6909016368545, 4431.911361772746, 4442.955570444319, 4614.284785858197, 3515.7538972271695, 3618.7647802893252, 3618.9638103619154, 3626.7642603230706, 3635.2729454109285, 661.5402295404743, 672.9427998620172, 678.5792808458689, 687.2817905288985, 689.290031267795, 551.7461967494917, 634.9206349206349, 638.3180319857117, 640.6732566391081, 647.0814036382055, 8529.360472358629, 9108.635654573744, 9293.953530232306, 9306.441613503077, 9362.95318523403, 623.370395900135, 625.0717684238901, 639.4341008207676, 645.554567348528, 655.7934250711011, 4254.574542545721, 4531.093781243764, 4559.6124329431705, 4571.1543364477675, 4572.175048987561, 101567.93728250788, 121572.0, 134295.0, 137131.0, 143989.0, 100606.49090263652, 116483.670326593, 118951.40524297323, 126557.73442265643, 127445.0, 75612.62193688996, 113654.0, 114441.0, 115448.0, 115712.42143789228, 9786.1192492676, 9819.263555233529, 9951.113849089012, 9986.950065249628, 10095.091441770275, 66966.0, 67592.98610520945, 67630.66184669045, 67748.32251677617, 69704.34057424111, 89298.0, 98518.0, 102303.0, 104261.0, 106819.0, 12796.936015319863, 13022.47910083586, 13132.34338283063, 13159.53941612039, 13537.526186583817, 14453.349599267847, 14481.565553033426, 14564.85435145635, 14734.926325368304, 15017.924910375377, 13378.9331053348, 14056.156630602196, 14087.366068526735, 14374.0, 14431.85568144347, 12054.698632534257, 12055.51777928908, 12059.81910271329, 12117.575884843987, 13272.535461258809, 12015.0, 12042.518299267931, 12300.569480068154, 13374.264415457243, 13510.324483775576, 9738.269629777653, 10747.408892510986, 10802.72993175177, 11217.66347009591, 11827.586034488751, 10652.0, 11698.0, 11732.765344693229, 11831.290122592673, 12023.27860328383], "value": 7873.2645040973985, "unit": "score"}], "name": "dromaeo_css", "value": 7438.863666843814, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 111.0, 142.0, 122.0, 111.0, 108.0, 107.0, 140.0, 119.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 182.0, 183.0, 183.0, 183.0, 184.0, 184.0, 186.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 79.0, 113.0, 85.0, 82.0, 50.0, 73.0, 99.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 68.0, 69.0, 71.0, 91.0, 65.0, 67.0, 87.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 128.0, 132.0, 85.0, 87.0, 83.0, 87.0, 116.0, 87.0, 83.0], "value": 97.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 105.0, 96.0, 95.0, 97.0, 123.0, 157.0, 100.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 86.0, 84.0, 85.0, 84.0, 86.0, 107.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 56.0, 58.0, 56.0, 57.0, 56.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 77.0, 72.0, 72.0, 70.0, 69.0, 71.0, 70.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 83.0, 80.0, 80.0, 82.0, 81.0, 92.0, 87.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 137.0, 134.0, 139.0, 145.0, 146.0, 158.0, 168.0, 135.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 169.0, 159.0, 165.0, 164.0, 174.0, 220.0, 183.0, 160.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 63.0, 70.0, 84.0, 79.0, 67.0, 67.0, 66.0, 65.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1462.8, "alertThreshold": 2.0}]} 06:05:42 INFO - Return code: 0 06:05:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:05:43 INFO - # TBPL SUCCESS # 06:05:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:05:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:05:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:05:43 INFO - 2016-10-17 06:05:43.031 screenresolution[1671:9881] starting screenresolution argv=screenresolution get 06:05:43 INFO - 2016-10-17 06:05:43.033 screenresolution[1671:9881] Display 0: 1600x1200x32@60 06:05:43 INFO - 2016-10-17 06:05:43.039 screenresolution[1672:9884] starting screenresolution argv=screenresolution list 06:05:43 INFO - Available Modes on Display 0 06:05:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:05:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:05:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:05:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:05:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:05:43 INFO - Intel Iris: 06:05:43 INFO - Chipset Model: Intel Iris 06:05:43 INFO - Type: GPU 06:05:43 INFO - Bus: Built-In 06:05:43 INFO - VRAM (Dynamic, Max): 1536 MB 06:05:43 INFO - Vendor: Intel (0x8086) 06:05:43 INFO - Device ID: 0x0a2e 06:05:43 INFO - Revision ID: 0x0009 06:05:43 INFO - Displays: 06:05:43 INFO - Display: 06:05:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:05:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:05:43 INFO - Display Serial Number: 1600x1200 60 06:05:43 INFO - Main Display: Yes 06:05:43 INFO - Mirror: Off 06:05:43 INFO - Online: Yes 06:05:43 INFO - Rotation: Supported 06:05:43 INFO - Return code: 0 06:05:43 INFO - Running post-action listener: _resource_record_post_action 06:05:43 INFO - [mozharness: 2016-10-17 13:05:43.281637Z] Finished run-tests step (success) 06:05:43 INFO - Running post-run listener: _resource_record_post_run 06:05:43 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38007808; Write bytes: 663239680; Read time: 374; Write time: 1827 06:05:43 INFO - TinderboxPrint: CPU usage
53.5% 06:05:43 INFO - TinderboxPrint: I/O read bytes / time
38,007,808 / 374 06:05:43 INFO - TinderboxPrint: I/O write bytes / time
663,239,680 / 1,827 06:05:43 INFO - TinderboxPrint: CPU idle
2,248.9 (46.5%) 06:05:43 INFO - TinderboxPrint: CPU system
965.8 (20.0%) 06:05:43 INFO - TinderboxPrint: CPU user
1,623.0 (33.5%) 06:05:43 INFO - TinderboxPrint: Swap in / out
401,731,584 / 0 06:05:43 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356536832; Write bytes: 357509120; Read time: 27517; Write time: 700 06:05:43 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36205568; Write bytes: 294708224; Read time: 355; Write time: 1091 06:05:43 INFO - Running post-run listener: _upload_blobber_files 06:05:43 INFO - Blob upload gear active. 06:05:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:05:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:05:44 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:45 INFO - (blobuploader) - INFO - Done attempting. 06:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:46 INFO - (blobuploader) - INFO - Done attempting. 06:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:05:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:48 INFO - (blobuploader) - INFO - Done attempting. 06:05:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:05:48 INFO - Return code: 0 06:05:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:05:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:05:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b34cdeb26289a6ff0602e8042eaeec1bb50e16d74f0f4c87228c8c232f3adaecc3726e86b491c540b77d9e4b62ca49ff71c26829522d64bcfd7a5635495ad6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfc114ec8f9938ee282d6147fbca62147320532a249f33e04360d3f7958678906be7e65a69872e477c791bee52fca8701d13d6008b2ebcaf6877179ffc88a628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaec6756651172cd070de175100e61571b4638d55bdc44c3f9539f14813c62036596f78ad63d2fb87e0ba4f7fad76b36a336ac1e1860d248446eef64b3c6ce31"} 06:05:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:05:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:05:48 INFO - Contents: 06:05:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b34cdeb26289a6ff0602e8042eaeec1bb50e16d74f0f4c87228c8c232f3adaecc3726e86b491c540b77d9e4b62ca49ff71c26829522d64bcfd7a5635495ad6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfc114ec8f9938ee282d6147fbca62147320532a249f33e04360d3f7958678906be7e65a69872e477c791bee52fca8701d13d6008b2ebcaf6877179ffc88a628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaec6756651172cd070de175100e61571b4638d55bdc44c3f9539f14813c62036596f78ad63d2fb87e0ba4f7fad76b36a336ac1e1860d248446eef64b3c6ce31"} 06:05:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:05:48 INFO - Copying logs to upload dir... 06:05:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:05:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.454738 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-17 06:05:48.670880) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:05:48.674054) ========= 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.V62CgobyaR/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.b53GXiLyLg/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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/30b34cdeb26289a6ff0602e8042eaeec1bb50e16d74f0f4c87228c8c232f3adaecc3726e86b491c540b77d9e4b62ca49ff71c26829522d64bcfd7a5635495ad6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfc114ec8f9938ee282d6147fbca62147320532a249f33e04360d3f7958678906be7e65a69872e477c791bee52fca8701d13d6008b2ebcaf6877179ffc88a628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaec6756651172cd070de175100e61571b4638d55bdc44c3f9539f14813c62036596f78ad63d2fb87e0ba4f7fad76b36a336ac1e1860d248446eef64b3c6ce31"} build_url:https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010688 build_url: 'https://queue.taskcluster.net/v1/task/A79l89TwSLi1F5ZUXwELdw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b34cdeb26289a6ff0602e8042eaeec1bb50e16d74f0f4c87228c8c232f3adaecc3726e86b491c540b77d9e4b62ca49ff71c26829522d64bcfd7a5635495ad6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfc114ec8f9938ee282d6147fbca62147320532a249f33e04360d3f7958678906be7e65a69872e477c791bee52fca8701d13d6008b2ebcaf6877179ffc88a628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaec6756651172cd070de175100e61571b4638d55bdc44c3f9539f14813c62036596f78ad63d2fb87e0ba4f7fad76b36a336ac1e1860d248446eef64b3c6ce31"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:05:48.705803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:05:48.706148) ========= 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.V62CgobyaR/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.b53GXiLyLg/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.005175 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:05:48.754475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:05:48.754802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:05:48.755134) ========= ========= Total master_lag: 0.17 =========