builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0113 starttime: 1490949623.79 results: success (0) buildid: 20170331004006 builduid: 801f8879104346a38f786015826fea51 revision: 7e44e11d00308e72547bfef822d91814c5b47634 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:23.792100) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:23.792495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:23.792783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:23.819105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:23.819437) ========= 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.tRuShoW5Pt/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.geHokTsSWV/Listeners TMPDIR=/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-31 01:40:23-- 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% 14.7M=0.001s 2017-03-31 01:40:23 (14.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131852 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:23.975518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:23.975855) ========= 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.tRuShoW5Pt/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.geHokTsSWV/Listeners TMPDIR=/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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.027884 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:24.025606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-03-31 01:40:24.025956) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e44e11d00308e72547bfef822d91814c5b47634 --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 7e44e11d00308e72547bfef822d91814c5b47634 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tRuShoW5Pt/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.geHokTsSWV/Listeners TMPDIR=/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-31 01:40:24,132 truncating revision to first 12 chars 2017-03-31 01:40:24,133 Setting DEBUG logging. 2017-03-31 01:40:24,133 attempt 1/10 2017-03-31 01:40:24,133 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e44e11d0030?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 01:40:26,082 unpacking tar archive at: mozilla-aurora-7e44e11d0030/testing/mozharness/ program finished with exit code 0 elapsedTime=2.228379 ========= master_lag: 2.83 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-03-31 01:40:29.085846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:29.086176) ========= script_repo_revision: 7e44e11d00308e72547bfef822d91814c5b47634 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:29.086557) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:29.086882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 01:40:29.109420) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-31 01:40:29.109731) ========= /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.tRuShoW5Pt/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.geHokTsSWV/Listeners TMPDIR=/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:40:29 INFO - MultiFileLogger online at 20170331 01:40:29 in /builds/slave/test 01:40:29 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 01:40:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:40:29 INFO - {'append_to_log': False, 01:40:29 INFO - 'base_work_dir': '/builds/slave/test', 01:40:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:40:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:40:29 INFO - 'branch': 'Mozilla-Aurora', 01:40:29 INFO - 'buildbot_json_path': 'buildprops.json', 01:40:29 INFO - 'config_files': ('talos/mac_config.py',), 01:40:29 INFO - 'default_actions': ('clobber', 01:40:29 INFO - 'read-buildbot-config', 01:40:29 INFO - 'download-and-extract', 01:40:29 INFO - 'populate-webroot', 01:40:29 INFO - 'create-virtualenv', 01:40:29 INFO - 'install', 01:40:29 INFO - 'run-tests'), 01:40:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:40:29 INFO - 'download_minidump_stackwalk': True, 01:40:29 INFO - 'download_symbols': 'ondemand', 01:40:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:40:29 INFO - 'tooltool.py': '/tools/tooltool.py', 01:40:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:40:29 INFO - '/tools/misc-python/virtualenv.py')}, 01:40:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:40:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:40:29 INFO - 'gecko_profile': False, 01:40:29 INFO - 'gecko_profile_interval': 0, 01:40:29 INFO - 'installer_path': 'installer.exe', 01:40:29 INFO - 'log_level': 'info', 01:40:29 INFO - 'log_name': 'talos', 01:40:29 INFO - 'log_to_console': True, 01:40:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:40:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:40:29 INFO - 'opt_config_files': (), 01:40:29 INFO - 'pip_index': False, 01:40:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:40:29 INFO - 'cmd': ('bash', 01:40:29 INFO - '-c', 01:40:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:40:29 INFO - 'enabled': True, 01:40:29 INFO - 'halt_on_failure': False, 01:40:29 INFO - 'name': 'check_screen_resolution'},), 01:40:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:40:29 INFO - 'cmd': ('bash', 01:40:29 INFO - '-c', 01:40:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:40:29 INFO - 'enabled': True, 01:40:29 INFO - 'halt_on_failure': False, 01:40:29 INFO - 'name': 'check_screen_resolution'},), 01:40:29 INFO - 'run_cmd_checks_enabled': True, 01:40:29 INFO - 'suite': 'dromaeojs', 01:40:29 INFO - 'system_bits': '32', 01:40:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:40:29 INFO - 'title': 't-yosemite-r7-0113', 01:40:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:40:29 INFO - 'use_talos_json': True, 01:40:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:40:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:40:29 INFO - 'work_dir': 'build'} 01:40:29 INFO - [mozharness: 2017-03-31 08:40:29.320322Z] Running clobber step. 01:40:29 INFO - Running pre-action listener: _resource_record_pre_action 01:40:29 INFO - Running main action method: clobber 01:40:29 INFO - rmtree: /builds/slave/test/build 01:40:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:40:31 INFO - Running post-action listener: _resource_record_post_action 01:40:31 INFO - [mozharness: 2017-03-31 08:40:31.764510Z] Finished clobber step (success) 01:40:31 INFO - [mozharness: 2017-03-31 08:40:31.764801Z] Running read-buildbot-config step. 01:40:31 INFO - Running pre-action listener: _resource_record_pre_action 01:40:31 INFO - Running main action method: read_buildbot_config 01:40:31 INFO - Using buildbot properties: 01:40:31 INFO - { 01:40:31 INFO - "project": "", 01:40:31 INFO - "product": "firefox", 01:40:31 INFO - "script_repo_revision": "production", 01:40:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:40:31 INFO - "repository": "", 01:40:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:40:31 INFO - "buildid": "20170331004006", 01:40:31 INFO - "stage_platform": "macosx64", 01:40:31 INFO - "basedir": "/builds/slave/test", 01:40:31 INFO - "nightly_build": "True", 01:40:31 INFO - "buildnumber": 38, 01:40:31 INFO - "slavename": "t-yosemite-r7-0113", 01:40:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:40:31 INFO - "platform": "yosemite_r7", 01:40:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:40:31 INFO - "branch": "mozilla-aurora", 01:40:31 INFO - "repo_path": "releases/mozilla-aurora", 01:40:31 INFO - "revision": "7e44e11d00308e72547bfef822d91814c5b47634", 01:40:31 INFO - "pgo_build": "False", 01:40:31 INFO - "builduid": "801f8879104346a38f786015826fea51", 01:40:31 INFO - "slavebuilddir": "test" 01:40:31 INFO - } 01:40:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:40:31 INFO - Running post-action listener: _resource_record_post_action 01:40:31 INFO - [mozharness: 2017-03-31 08:40:31.770409Z] Finished read-buildbot-config step (success) 01:40:31 INFO - [mozharness: 2017-03-31 08:40:31.770590Z] Running download-and-extract step. 01:40:31 INFO - Running pre-action listener: _resource_record_pre_action 01:40:31 INFO - Running main action method: download_and_extract 01:40:31 INFO - mkdir: /builds/slave/test/build/tests 01:40:31 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')]} 01:40:31 INFO - trying https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:40:31 INFO - Downloading https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:40:33 INFO - Downloaded 1199 bytes. 01:40:33 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:40:33 INFO - Using the following test package requirements: 01:40:33 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:40:33 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:40:33 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:40:33 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'jsshell-mac.zip'], 01:40:33 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:40:33 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:40:33 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:40:33 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:40:33 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:40:33 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:40:33 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:40:33 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:40:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:40:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:40:33 INFO - Fetch https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:40:34 INFO - Expected file size: 51790656 01:40:34 INFO - Obtained file size: 51790656 01:40:50 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:40:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:40:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:40:50 INFO - Fetch https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:40:52 INFO - Expected file size: 51790656 01:40:52 INFO - Obtained file size: 51790656 01:41:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:41:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:41:07 INFO - Fetch https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:41:08 INFO - Expected file size: 14404438 01:41:08 INFO - Obtained file size: 14404438 01:41: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')]} 01:41:09 INFO - trying https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:41:09 INFO - Downloading https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:41:11 INFO - Downloaded 74752709 bytes. 01:41:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:41:11 INFO - mkdir: /builds/slave/test/properties 01:41:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:41:11 INFO - Writing to file /builds/slave/test/properties/build_url 01:41:11 INFO - Contents: 01:41:11 INFO - build_url:https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:41:12 INFO - Running post-action listener: _resource_record_post_action 01:41:12 INFO - Running post-action listener: set_extra_try_arguments 01:41:12 INFO - [mozharness: 2017-03-31 08:41:12.011031Z] Finished download-and-extract step (success) 01:41:12 INFO - [mozharness: 2017-03-31 08:41:12.011176Z] Running populate-webroot step. 01:41:12 INFO - Running pre-action listener: _resource_record_pre_action 01:41:12 INFO - Running main action method: populate_webroot 01:41:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:41:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:41:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:41:12 INFO - '--tppagecycles', 01:41:12 INFO - '7'], 01:41:12 INFO - 'tests': ['tsvgm']}}, 01:41:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:41:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:41:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:41:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:41:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:41:12 INFO - 'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:41:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:41:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:41:12 INFO - 'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['damp', 'tps']}, 01:41:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:41:12 INFO - 'tests': ['damp', 'tps']}, 01:41:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['dromaeo_dom']}, 01:41:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:41:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['basic_compositor_video']}, 01:41:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:41:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['a11yr', 01:41:12 INFO - 'ts_paint', 01:41:12 INFO - 'tpaint', 01:41:12 INFO - 'sessionrestore', 01:41:12 INFO - 'sessionrestore_no_auto_restore', 01:41:12 INFO - 'tabpaint']}, 01:41:12 INFO - 'other-e10s': {'tests': ['a11yr', 01:41:12 INFO - 'ts_paint', 01:41:12 INFO - 'tpaint', 01:41:12 INFO - 'sessionrestore', 01:41:12 INFO - 'sessionrestore_no_auto_restore', 01:41:12 INFO - 'tabpaint']}, 01:41:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:41:12 INFO - 'ts_paint', 01:41:12 INFO - 'tpaint', 01:41:12 INFO - 'sessionrestore', 01:41:12 INFO - 'sessionrestore_no_auto_restore', 01:41:12 INFO - 'tabpaint']}, 01:41:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:41:12 INFO - 'ts_paint', 01:41:12 INFO - 'tpaint', 01:41:12 INFO - 'sessionrestore', 01:41:12 INFO - 'sessionrestore_no_auto_restore', 01:41:12 INFO - 'tabpaint']}, 01:41:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['a11yr', 01:41:12 INFO - 'ts_paint', 01:41:12 INFO - 'tpaint', 01:41:12 INFO - 'sessionrestore', 01:41:12 INFO - 'sessionrestore_no_auto_restore', 01:41:12 INFO - 'tabpaint']}, 01:41:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['a11yr', 01:41:12 INFO - 'ts_paint', 01:41:12 INFO - 'tpaint', 01:41:12 INFO - 'sessionrestore', 01:41:12 INFO - 'sessionrestore_no_auto_restore', 01:41:12 INFO - 'tabpaint']}, 01:41:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['tsvgx', 01:41:12 INFO - 'tsvgr_opacity', 01:41:12 INFO - 'tart', 01:41:12 INFO - 'tscrollx', 01:41:12 INFO - 'cart', 01:41:12 INFO - 'tsvg_static']}, 01:41:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:41:12 INFO - 'tsvgr_opacity', 01:41:12 INFO - 'tart', 01:41:12 INFO - 'tscrollx', 01:41:12 INFO - 'cart', 01:41:12 INFO - 'tsvg_static']}, 01:41:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:41:12 INFO - 'talos_options': ['--disable-e10s'], 01:41:12 INFO - 'tests': ['tp5o']}, 01:41:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:41:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:41:12 INFO - 'talos_options': ['--disable-e10s', 01:41:12 INFO - '--xperf_path', 01:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:41:12 INFO - 'tests': ['tp5n']}, 01:41:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:41:12 INFO - 'talos_options': ['--xperf_path', 01:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:41:12 INFO - 'tests': ['tp5n']}}, 01:41:12 INFO - 'talos.zip': {'path': '', 01:41:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:41:12 INFO - Running post-action listener: _resource_record_post_action 01:41:12 INFO - [mozharness: 2017-03-31 08:41:12.029199Z] Finished populate-webroot step (success) 01:41:12 INFO - [mozharness: 2017-03-31 08:41:12.029339Z] Running create-virtualenv step. 01:41:12 INFO - Running pre-action listener: _resource_record_pre_action 01:41:12 INFO - Running main action method: create_virtualenv 01:41:12 INFO - Creating virtualenv /builds/slave/test/build/venv 01:41:12 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 01:41:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:41:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:41:12 INFO - Using real prefix '/tools/python27' 01:41:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:41:12 INFO - Installing distribute.............................................................................................................................................................................................done. 01:41:15 INFO - Installing pip.................done. 01:41:15 INFO - Return code: 0 01:41:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:41:16 INFO - Reading from file tmpfile_stdout 01:41:16 INFO - Output received: 01:41:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:41:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41: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', 'pip>=1.5'] in /builds/slave/test/build 01:41: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 pip>=1.5 01:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:16 INFO - 'HOME': '/Users/cltbld', 01:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:16 INFO - 'LOGNAME': 'cltbld', 01:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:16 INFO - 'MOZ_NO_REMOTE': '1', 01:41:16 INFO - 'NO_EM_RESTART': '1', 01:41:16 INFO - 'PAGER': '/bin/cat', 01:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:16 INFO - 'PWD': '/builds/slave/test', 01:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:16 INFO - 'SHELL': '/bin/bash', 01:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:16 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:16 INFO - 'USER': 'cltbld', 01:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:16 INFO - 'XPC_FLAGS': '0x0', 01:41:16 INFO - 'XPC_SERVICE_NAME': '0', 01:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:16 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 01:41:16 INFO - Cleaning up... 01:41:16 INFO - Return code: 0 01:41:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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', '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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:41: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 psutil>=3.1.1 01:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:16 INFO - 'HOME': '/Users/cltbld', 01:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:16 INFO - 'LOGNAME': 'cltbld', 01:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:16 INFO - 'MOZ_NO_REMOTE': '1', 01:41:16 INFO - 'NO_EM_RESTART': '1', 01:41:16 INFO - 'PAGER': '/bin/cat', 01:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:16 INFO - 'PWD': '/builds/slave/test', 01:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:16 INFO - 'SHELL': '/bin/bash', 01:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:16 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:16 INFO - 'USER': 'cltbld', 01:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:16 INFO - 'XPC_FLAGS': '0x0', 01:41:16 INFO - 'XPC_SERVICE_NAME': '0', 01:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:16 INFO - Downloading/unpacking psutil>=3.1.1 01:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:41:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:20 INFO - Installing collected packages: psutil 01:41:20 INFO - Running setup.py install for psutil 01:41:20 INFO - building 'psutil._psutil_osx' extension 01:41:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:41:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:41:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:41:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:41:21 INFO - building 'psutil._psutil_posix' extension 01:41:21 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 01:41:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:41:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:41:21 INFO - ^ 01:41:21 INFO - 1 warning generated. 01:41:21 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 01:41:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:21 INFO - Successfully installed psutil 01:41:21 INFO - Cleaning up... 01:41:21 INFO - Return code: 0 01:41:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:22 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:22 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 01:41:22 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 01:41:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:22 INFO - 'HOME': '/Users/cltbld', 01:41:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:22 INFO - 'LOGNAME': 'cltbld', 01:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:22 INFO - 'MOZ_NO_REMOTE': '1', 01:41:22 INFO - 'NO_EM_RESTART': '1', 01:41:22 INFO - 'PAGER': '/bin/cat', 01:41:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:22 INFO - 'PWD': '/builds/slave/test', 01:41:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:22 INFO - 'SHELL': '/bin/bash', 01:41:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:22 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:22 INFO - 'USER': 'cltbld', 01:41:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:22 INFO - 'XPC_FLAGS': '0x0', 01:41:22 INFO - 'XPC_SERVICE_NAME': '0', 01:41:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:41:22 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 01:41:22 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 01:41:22 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 01:41:22 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 01:41:22 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 01:41:22 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 01:41:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:41:25 INFO - Installing collected packages: mozsystemmonitor 01:41:25 INFO - Running setup.py install for mozsystemmonitor 01:41:25 INFO - Successfully installed mozsystemmonitor 01:41:25 INFO - Cleaning up... 01:41:25 INFO - Return code: 0 01:41:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:41:25 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')]} 01:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:25 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')]} 01:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:25 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:25 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 01:41:25 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 01:41:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:25 INFO - 'HOME': '/Users/cltbld', 01:41:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:25 INFO - 'LOGNAME': 'cltbld', 01:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:25 INFO - 'MOZ_NO_REMOTE': '1', 01:41:25 INFO - 'NO_EM_RESTART': '1', 01:41:25 INFO - 'PAGER': '/bin/cat', 01:41:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:25 INFO - 'PWD': '/builds/slave/test', 01:41:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:25 INFO - 'SHELL': '/bin/bash', 01:41:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:25 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:25 INFO - 'USER': 'cltbld', 01:41:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:25 INFO - 'XPC_FLAGS': '0x0', 01:41:25 INFO - 'XPC_SERVICE_NAME': '0', 01:41:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:25 INFO - Downloading/unpacking jsonschema==2.5.1 01:41:25 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 01:41:25 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 01:41:25 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 01:41:25 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 01:41:25 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 01:41:25 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 01:41:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:41:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41:29 INFO - Downloading functools32-3.2.3-2.tar.gz 01:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:41:29 INFO - warning: no files found matching '*.txt' 01:41:29 INFO - no previously-included directories found matching 'build' 01:41:29 INFO - no previously-included directories found matching 'dist' 01:41:29 INFO - no previously-included directories found matching '.git*' 01:41:29 INFO - Installing collected packages: jsonschema, functools32 01:41:29 INFO - Running setup.py install for functools32 01:41:29 INFO - warning: no files found matching '*.txt' 01:41:29 INFO - no previously-included directories found matching 'build' 01:41:29 INFO - no previously-included directories found matching 'dist' 01:41:29 INFO - no previously-included directories found matching '.git*' 01:41:29 INFO - Successfully installed jsonschema functools32 01:41:29 INFO - Cleaning up... 01:41:29 INFO - Return code: 0 01:41:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:29 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:29 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 01:41:29 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 01:41:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:29 INFO - 'HOME': '/Users/cltbld', 01:41:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:29 INFO - 'LOGNAME': 'cltbld', 01:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:29 INFO - 'MOZ_NO_REMOTE': '1', 01:41:29 INFO - 'NO_EM_RESTART': '1', 01:41:29 INFO - 'PAGER': '/bin/cat', 01:41:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:29 INFO - 'PWD': '/builds/slave/test', 01:41:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:29 INFO - 'SHELL': '/bin/bash', 01:41:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:29 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:29 INFO - 'USER': 'cltbld', 01:41:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:29 INFO - 'XPC_FLAGS': '0x0', 01:41:29 INFO - 'XPC_SERVICE_NAME': '0', 01:41:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:41:29 INFO - Cleaning up... 01:41:29 INFO - Return code: 0 01:41:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:29 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:29 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 01:41:29 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 01:41:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:29 INFO - 'HOME': '/Users/cltbld', 01:41:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:29 INFO - 'LOGNAME': 'cltbld', 01:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:29 INFO - 'MOZ_NO_REMOTE': '1', 01:41:29 INFO - 'NO_EM_RESTART': '1', 01:41:29 INFO - 'PAGER': '/bin/cat', 01:41:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:29 INFO - 'PWD': '/builds/slave/test', 01:41:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:29 INFO - 'SHELL': '/bin/bash', 01:41:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:29 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:29 INFO - 'USER': 'cltbld', 01:41:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:29 INFO - 'XPC_FLAGS': '0x0', 01:41:29 INFO - 'XPC_SERVICE_NAME': '0', 01:41:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:29 INFO - Downloading/unpacking blobuploader==1.2.4 01:41:29 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 01:41:29 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 01:41:29 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 01:41:29 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 01:41:29 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 01:41:29 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 01:41:33 INFO - Downloading blobuploader-1.2.4.tar.gz 01:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:41:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:41:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:34 INFO - Downloading docopt-0.6.1.tar.gz 01:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:41:34 INFO - Installing collected packages: blobuploader, requests, docopt 01:41:34 INFO - Running setup.py install for blobuploader 01:41:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:41:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:41:35 INFO - Running setup.py install for requests 01:41:35 INFO - Running setup.py install for docopt 01:41:35 INFO - Successfully installed blobuploader requests docopt 01:41:35 INFO - Cleaning up... 01:41:35 INFO - Return code: 0 01:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:35 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:35 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 01:41:35 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 01:41:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:35 INFO - 'HOME': '/Users/cltbld', 01:41:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:35 INFO - 'LOGNAME': 'cltbld', 01:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:35 INFO - 'MOZ_NO_REMOTE': '1', 01:41:35 INFO - 'NO_EM_RESTART': '1', 01:41:35 INFO - 'PAGER': '/bin/cat', 01:41:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:35 INFO - 'PWD': '/builds/slave/test', 01:41:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:35 INFO - 'SHELL': '/bin/bash', 01:41:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:35 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:35 INFO - 'USER': 'cltbld', 01:41:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:35 INFO - 'XPC_FLAGS': '0x0', 01:41:35 INFO - 'XPC_SERVICE_NAME': '0', 01:41:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-8dIz0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-gh3e4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-BQNHxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-r2xOaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-YCOyPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-5GD57R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-ERh68N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-EC5an3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:36 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-kMblh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-rfw179-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-eSZGEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-r_YIlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-4XYeoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-y8ttPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-ERw6ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-6vaOPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:37 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-6CV14n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:41:37 INFO - Running setup.py install for manifestparser 01:41:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:41:37 INFO - Running setup.py install for mozcrash 01:41:38 INFO - Running setup.py install for mozdebug 01:41:38 INFO - Running setup.py install for mozdevice 01:41:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:41:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:41:38 INFO - Running setup.py install for mozfile 01:41:38 INFO - Running setup.py install for mozhttpd 01:41:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:41:38 INFO - Running setup.py install for mozinfo 01:41:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:41:38 INFO - Running setup.py install for mozInstall 01:41:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Running setup.py install for mozleak 01:41:39 INFO - Running setup.py install for mozlog 01:41:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Running setup.py install for moznetwork 01:41:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Running setup.py install for mozprocess 01:41:39 INFO - Running setup.py install for mozprofile 01:41:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Running setup.py install for mozrunner 01:41:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:41:39 INFO - Running setup.py install for mozscreenshot 01:41:40 INFO - Running setup.py install for moztest 01:41:40 INFO - Running setup.py install for mozversion 01:41:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:41:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:41:40 INFO - Cleaning up... 01:41:40 INFO - Return code: 0 01:41:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:40 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:40 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 01:41:40 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 01:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:40 INFO - 'HOME': '/Users/cltbld', 01:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:40 INFO - 'LOGNAME': 'cltbld', 01:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:40 INFO - 'MOZ_NO_REMOTE': '1', 01:41:40 INFO - 'NO_EM_RESTART': '1', 01:41:40 INFO - 'PAGER': '/bin/cat', 01:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:40 INFO - 'PWD': '/builds/slave/test', 01:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:40 INFO - 'SHELL': '/bin/bash', 01:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:40 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:40 INFO - 'USER': 'cltbld', 01:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:40 INFO - 'XPC_FLAGS': '0x0', 01:41:40 INFO - 'XPC_SERVICE_NAME': '0', 01:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:40 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-K3jyB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:40 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)) 01:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:40 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-PhHJPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:40 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-9hy2Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-1mgNDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-8kV4Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-x9Zj6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-RxIglo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-HRHBGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-zlQ8Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-hesgOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-LZemws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:41 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)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-8MRq8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:41 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-b8fCAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:42 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)) 01:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:42 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-SdlVis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:42 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-YgdP0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:42 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)) 01:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:42 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-ROJOjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:42 INFO - Running setup.py (path:/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/pip-KdvDdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:42 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)) 01:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:41:42 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)) 01:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:45 INFO - Downloading blessings-1.6.tar.gz 01:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:41:45 INFO - Installing collected packages: blessings 01:41:45 INFO - Running setup.py install for blessings 01:41:45 INFO - Successfully installed blessings 01:41:45 INFO - Cleaning up... 01:41:45 INFO - Return code: 0 01:41:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:41:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:45 INFO - Reading from file tmpfile_stdout 01:41:45 INFO - Current package versions: 01:41:45 INFO - blessings == 1.6 01:41:45 INFO - blobuploader == 1.2.4 01:41:45 INFO - docopt == 0.6.1 01:41:45 INFO - functools32 == 3.2.3-2 01:41:45 INFO - jsonschema == 2.5.1 01:41:45 INFO - manifestparser == 1.1 01:41:45 INFO - mozInstall == 1.12 01:41:45 INFO - mozcrash == 1.0 01:41:45 INFO - mozdebug == 0.1 01:41:45 INFO - mozdevice == 0.49 01:41:45 INFO - mozfile == 1.2 01:41:45 INFO - mozhttpd == 0.7 01:41:45 INFO - mozinfo == 0.9 01:41:45 INFO - mozleak == 0.1 01:41:45 INFO - mozlog == 3.4 01:41:45 INFO - moznetwork == 0.27 01:41:45 INFO - mozprocess == 0.25 01:41:45 INFO - mozprofile == 0.28 01:41:45 INFO - mozrunner == 6.13 01:41:45 INFO - mozscreenshot == 0.1 01:41:45 INFO - mozsystemmonitor == 0.3 01:41:45 INFO - moztest == 0.8 01:41:45 INFO - mozversion == 1.4 01:41:45 INFO - psutil == 3.1.1 01:41:45 INFO - requests == 1.2.3 01:41:45 INFO - wsgiref == 0.1.2 01:41:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:45 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:45 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 01:41:45 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 01:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:45 INFO - 'HOME': '/Users/cltbld', 01:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:45 INFO - 'LOGNAME': 'cltbld', 01:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:45 INFO - 'MOZ_NO_REMOTE': '1', 01:41:45 INFO - 'NO_EM_RESTART': '1', 01:41:45 INFO - 'PAGER': '/bin/cat', 01:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:45 INFO - 'PWD': '/builds/slave/test', 01:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:45 INFO - 'SHELL': '/bin/bash', 01:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:45 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:45 INFO - 'USER': 'cltbld', 01:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:45 INFO - 'XPC_FLAGS': '0x0', 01:41:45 INFO - 'XPC_SERVICE_NAME': '0', 01:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 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)) 01:41:45 INFO - Cleaning up... 01:41:45 INFO - Return code: 0 01:41:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:46 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')]} 01:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:46 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 0x1089e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182cb3db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, '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.tRuShoW5Pt/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.geHokTsSWV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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 01:41:46 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 01:41:46 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 01:41:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:41:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:46 INFO - 'HOME': '/Users/cltbld', 01:41:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:46 INFO - 'LOGNAME': 'cltbld', 01:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:46 INFO - 'MOZ_NO_REMOTE': '1', 01:41:46 INFO - 'NO_EM_RESTART': '1', 01:41:46 INFO - 'PAGER': '/bin/cat', 01:41:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:46 INFO - 'PWD': '/builds/slave/test', 01:41:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:46 INFO - 'SHELL': '/bin/bash', 01:41:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:41:46 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:41:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:46 INFO - 'USER': 'cltbld', 01:41:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:46 INFO - 'XPC_FLAGS': '0x0', 01:41:46 INFO - 'XPC_SERVICE_NAME': '0', 01:41:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:41:46 INFO - Cleaning up... 01:41:46 INFO - Return code: 0 01:41:46 INFO - Running post-action listener: _resource_record_post_action 01:41:46 INFO - Running post-action listener: _start_resource_monitoring 01:41:46 INFO - Starting resource monitoring. 01:41:46 INFO - [mozharness: 2017-03-31 08:41:46.291887Z] Finished create-virtualenv step (success) 01:41:46 INFO - [mozharness: 2017-03-31 08:41:46.292880Z] Running install step. 01:41:46 INFO - Running pre-action listener: _resource_record_pre_action 01:41:46 INFO - Running main action method: install 01:41:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:46 INFO - Reading from file tmpfile_stdout 01:41:46 INFO - Detecting whether we're running mozinstall >=1.0... 01:41:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:41:46 INFO - Reading from file tmpfile_stdout 01:41:46 INFO - Output received: 01:41:46 INFO - Usage: mozinstall [options] installer 01:41:46 INFO - Options: 01:41:46 INFO - -h, --help show this help message and exit 01:41:46 INFO - -d DEST, --destination=DEST 01:41:46 INFO - Directory to install application into. [default: 01:41:46 INFO - "/builds/slave/test"] 01:41:46 INFO - --app=APP Application being installed. [default: firefox] 01:41:46 INFO - mkdir: /builds/slave/test/build/application 01:41:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:42:06 INFO - Reading from file tmpfile_stdout 01:42:06 INFO - Output received: 01:42:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:42:06 INFO - Running post-action listener: _resource_record_post_action 01:42:06 INFO - [mozharness: 2017-03-31 08:42:06.625988Z] Finished install step (success) 01:42:06 INFO - [mozharness: 2017-03-31 08:42:06.626131Z] Running run-tests step. 01:42:06 INFO - Running pre-action listener: _resource_record_pre_action 01:42:06 INFO - Running main action method: run_tests 01:42:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:42:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:42:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:42:06 INFO - 2017-03-31 01:42:06.640 screenresolution[1617:7302] starting screenresolution argv=screenresolution get 01:42:06 INFO - 2017-03-31 01:42:06.643 screenresolution[1617:7302] Display 0: 1600x1200x32@60 01:42:06 INFO - 2017-03-31 01:42:06.648 screenresolution[1618:7305] starting screenresolution argv=screenresolution list 01:42:06 INFO - Available Modes on Display 0 01:42:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:42:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:42:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:42:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:42:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:42:06 INFO - Intel Iris: 01:42:06 INFO - Chipset Model: Intel Iris 01:42:06 INFO - Type: GPU 01:42:06 INFO - Bus: Built-In 01:42:06 INFO - VRAM (Dynamic, Max): 1536 MB 01:42:06 INFO - Vendor: Intel (0x8086) 01:42:06 INFO - Device ID: 0x0a2e 01:42:06 INFO - Revision ID: 0x0009 01:42:06 INFO - Displays: 01:42:06 INFO - Display: 01:42:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:42:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:42:06 INFO - Display Serial Number: 1600x1200 60 01:42:06 INFO - Main Display: Yes 01:42:06 INFO - Mirror: Off 01:42:06 INFO - Online: Yes 01:42:06 INFO - Rotation: Supported 01:42:06 INFO - Return code: 0 01:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:42:06 INFO - Python 2.7.3 01:42:06 INFO - Return code: 0 01:42:06 INFO - grabbing minidump binary from tooltool 01:42:06 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')]} 01:42:06 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 0x1087c1d30>, '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 0x1086e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:42:06 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 01:42:06 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 01:42:06 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 01:42:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:42:07 INFO - Return code: 0 01:42:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:42:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:42:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:42:07 INFO - ENV: RUST_BACKTRACE is now 1 01:42:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:42:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:42:07 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/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 01:42:07 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/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0113 --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 01:42:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tRuShoW5Pt/Render', 01:42:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:07 INFO - 'HOME': '/Users/cltbld', 01:42:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:07 INFO - 'LOGNAME': 'cltbld', 01:42:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:42:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:07 INFO - 'MOZ_NO_REMOTE': '1', 01:42:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:42:07 INFO - 'NO_EM_RESTART': '1', 01:42:07 INFO - 'PAGER': '/bin/cat', 01:42:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:07 INFO - 'PWD': '/builds/slave/test', 01:42:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:42:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:07 INFO - 'RUST_BACKTRACE': '1', 01:42:07 INFO - 'SHELL': '/bin/bash', 01:42:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geHokTsSWV/Listeners', 01:42:07 INFO - 'TMPDIR': '/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/', 01:42:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:07 INFO - 'USER': 'cltbld', 01:42:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:07 INFO - 'XPC_FLAGS': '0x0', 01:42:07 INFO - 'XPC_SERVICE_NAME': '0', 01:42:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:07 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/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 01:42:07 INFO - mozversion application_buildid: 20170331004006 01:42:07 INFO - mozversion application_changeset: 7e44e11d00308e72547bfef822d91814c5b47634 01:42:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:42:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:42:07 INFO - mozversion application_name: Firefox 01:42:07 INFO - mozversion application_remotingname: firefox-dev 01:42:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:42:07 INFO - mozversion application_vendor: Mozilla 01:42:07 INFO - mozversion application_version: 54.0a2 01:42:07 INFO - mozversion platform_buildid: 20170331004006 01:42:07 INFO - mozversion platform_changeset: 7e44e11d00308e72547bfef822d91814c5b47634 01:42:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:42:07 INFO - mozversion platform_version: 54.0a2 01:42:07 INFO - using testdate: 1490949727 01:42:07 INFO - actual date: 1490949727 01:42:07 INFO - starting webserver on 'localhost:49240' 01:42:07 INFO - SUITE-START | Running 2 tests 01:42:07 INFO - TEST-START | dromaeo_css 01:42:07 INFO - operating with platform_type : mac_ 01:42:07 INFO - Initialising browser for dromaeo_css test... 01:42:07 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/tmpcSXJKz/profile http://localhost:49240/getInfo.html) 01:42:09 INFO - PROCESS | 1628 | __metrics Screen width/height:1600/1200 01:42:09 INFO - PROCESS | 1628 | colorDepth:24 01:42:09 INFO - PROCESS | 1628 | Browser inner width/height: 1024/689 01:42:09 INFO - PROCESS | 1628 | __metrics 01:42:09 INFO - PROCESS | 1628 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:42:09 INFO - PROCESS | 1628 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:42:10 INFO - TEST-INFO | 1628: exit 0 01:42:10 INFO - Browser initialized. 01:42:10 INFO - Running cycle 1/1 for dromaeo_css test... 01:42:10 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/tmpcSXJKz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:42:23 INFO - PROCESS | 1631 | RSS: Main: 214810624 01:42:23 INFO - PROCESS | 1631 | 01:45:27 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 01:45:29 INFO - PROCESS | 1631 | RSS: Main: 362237952 01:45:29 INFO - PROCESS | 1631 | 01:47:12 INFO - PROCESS | 1631 | ************************* 01:47:12 INFO - PROCESS | 1631 | A coding exception was thrown and uncaught in a Task. 01:47:12 INFO - PROCESS | 1631 | 01:47:12 ERROR - PROCESS | 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:47:12 INFO - PROCESS | 1631 | Full stack: 01:47:12 INFO - PROCESS | 1631 | ************************* 01:48:32 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 01:48:32 INFO - PROCESS | 1631 | RSS: Main: 349728768 01:48:32 INFO - PROCESS | 1631 | 01:51:35 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 01:51:35 INFO - PROCESS | 1631 | RSS: Main: 327491584 01:51:35 INFO - PROCESS | 1631 | 01:54:38 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 01:54:39 INFO - PROCESS | 1631 | RSS: Main: 345407488 01:54:39 INFO - PROCESS | 1631 | 01:57:42 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 01:57:43 INFO - PROCESS | 1631 | RSS: Main: 318873600 01:57:43 INFO - PROCESS | 1631 | 02:00:46 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 02:00:47 INFO - PROCESS | 1631 | RSS: Main: 379228160 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | __start_tp_report 02:00:47 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 02:00:47 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 02:00:47 INFO - PROCESS | 1631 | |i|pagename|runs| 02:00:47 INFO - PROCESS | 1631 | |0;dojo.html;3381.425157723187;3394.490826376043;3396.728261739061;3416.8120753358558;3439.363717712223;5945.940540594598;5969.701514924258;5984.581079324449;6001.849953751158;6029.608075475091;5933.376995415473;5994.430529099728;5994.940050599493;6021.006533921908;6028.577999540034;5334.786608535664;5357.973210133944;5390.9191362129595;5393.514583687467;5490.149026900836;5274.472552744734;5304.681719096847;5314.681119132845;5481.698506582136;5539.667619942817;4467.664925130612;5411.756470958797;5455.727213639302;5463.7814487420455;5474.42518535554;5460.6177567570285;5475.698836563987;5479.232907392969;5482.0406428874785;5483.341998960131;5249.186376111708;5388.892222155574;5393.622446428752;5395.568354531628;5421.603064039215;5826.766929322865;5838.241028666246;5856.238688970449;5877.588568800185;5916.585838991272;6383.521235907326;6407.903881441782;6436.131122298477;6450.935490645081;6454.774082907123;6425.261094974045;6490.967545162292;6495.642739649317;6497.057926600663;6511.706973186218;5887.911681324741;5925.585209035412;5990.161377407167;6108.480779133779;6128.686460748315;6047.455728984324;6069.332373438918;6600.339966003361;6603.438707709898;6626.503012274099;6410.743570257231;6417.679116044273;6425;6430.228372595225;6449.548531602836;5314.7608357624;6315.052742088632;6349.841253968688;6479.6760161991715;6489.5781774184525;5277;6244.094606282064;6355.586886852339;6426.389492998158;6441.935580644134;6316.652584107826;6373.74505019794;6383.776567820104;6385.425311721968;6390.648514331663;5114.232865070269;5142.382914050338;5153.175491921274;5171.069207542603;5190.195519694454;4596.034832685106;4602.585767280961;4660.53394660538;4667.509911459248;4688.062387522441;5765.567582431335;5800.216970708984;5858.53131749459;5967.5524335675;5977.850553736104;5322.33470816148;6362.172917520693;6368.745250190033;6446.7421303148285;6478.676066196671;6001;6010.939890601126;6015.699215039231;6020.277566692025;6056.606320589148;5631.943680563142;5641.746121424464;5655.123455864347;5664.376918538957;5682.829515114553;6345.777897773556;6411.166548348685;6531.836704082436;6563.573367731082;6635.601863888182;6458.806235812933;6476.417122459001;6477.060826180272;6478.773242936474;6486.6756662167645;6551.70517326731;6630.204375474974;6634.867302654016;6646.833829154117;6649.63427011519;6235.657038862906;6247.656378899204;6290.339514351111;6381.521385896169;6405.3594640535575;6368.949123394588;6438.806835794933;6459.709313081016;6470.320616335405;6484.675766211765;6273.780417685359;6366.5225108118;6398.680065996588;6399.328070552711;6406.5515413920575;6151.446369826737;6215.844603884939;6238.095476155841;6264.68676566179;6366.745330186741;6151.292601350723;6228.252609686867;6237.688115594293;6239.688015599293;6249.218847644044;6374.07575901501;6387.808365749035;6388.169537960035;6397.424231819158;6408.487321014214;6066.969665151646;6108.645631960441;6114.969425152845;6190.164327815687;6265.310815810349 02:00:47 INFO - PROCESS | 1631 | |1;ext.html;716.9318914703103;754.1704125461993;817.5748610722425;870.2385412763832;886.9068747781487;26371.340716482075;32567.837160814193;40057.3991390129;40109;40184.59815401845;41186.7940660297;41393.58606413935;41464;41468.37797433041;41558;7283.562986220843;9173.862392064124;9314;9325.440473571574;9347.906520934806;7345.338919497244;10965.013148816604;11216.158788090885;11262.380569068699;11326.886731132665;11124.276922000045;11150.275232109927;11168.274062185932;11183.32900026001;11188.440577971109;7280.344768970818;11109.777804443906;11158.888411115866;11169.553217871235;11204.775904481947;7340.4127669786285;10852.837207441895;11069.944650276777;11095.889041109567;11107.777844443066;38918.02704932371;39062.60937390618;39144.21711565781;39191.60808391908;39315.60684393177;3798.0694729791103;3814.6376094271;3824.9808750956345;3828.3028056331223;3905.258000979805;27589;27753.583696244572;27898.721012789814;28556;29211.269718257212;3053.4961731314306;3137.6037663239867;3169.793963392372;3175.25381535339;3193.3134376109015;347960;352313;352795;353951.46048539184;354883;53074.73462632662;53207;53359.666008349326;53450.46549534455;53460;55511.722441388345;55698;55704.442955569924;55708;55743;14751.852481475262;15105.47130850415;15128.848711512965;15135.924320378548;15142.772858407132;11336.43317834105;11535;12904.935475322563;12943.482260709467;12943.741125177632;9522.714318570454;10749.355038697548;12240.204386714835;12296;12426.378681065911;5363.517283444508;5378.13949768043;5408.729563521808;5409.161579955114;5412.756425960842;1079.1169409380682;1095.3373209208473;1100.6367898593444;1111.1777284809184;1190.0836356006;26488.470230595667;26686.733132668815;26947.787349569317;26966.460670786866;27061.594076088873;1214.9574764883187;1223.749131428055;1260.1871792693662;1265.9113862029753;1273.8789814967563;13385.531506397425;13753.881581242676;13835.930820346035;13869.791953120712;14031.929840350937;440674;441841;443233;446091.5390846115;446747;56350.71824640933;56392.43607563954;56502.71748641313;56721.71639141778;56833;1422.1893520693313;1446.8842492600568;1459.5329494561638;1465.8460861609378;1468.0237641967972;23916.04776249993;24906.626400603644;25355.112571059923;25590.647478423238;25905.74094259033;41429.58570414257;46222.61332160041;46261.53738462572;46270.30594541152;46383.76808115938;414398;417627;418036;418267;418374;27602.895884165213;34181.46183421802;34302.97091087271;34397.82801085978;35093.94718158459;38929.6107038926;44278;45601;45789.542104578526;46370.53629463662;29178.708212917598;30452.238694032825;30765.69234307718;31252;31303.84348078245;30892.374148197654;30938.845305774226;31128.844355778077;31399.84300078485;31549.8422507886;36014.8199259002;36123;36189.81905090563;36588.085297867765;36620.45069323909;30338.544921826633;30764.077077687703;30983.380332393677;31128;31626.893058743753;22537.887310563343;24408.51182976366;24450.51098978046;24576.376188848208;24729.882357644983 02:00:47 INFO - PROCESS | 1631 | |2;jquery.html;382.8679105708533;401.31575663493726;412.7729748638248;421.20602663978394;440.3131115459883;12905.2902090385;14422.711545769078;20524.794752052494;20574.69137962932;21077.262295819648;21219.469513262175;21345.25291614794;21704.782952170473;22470.325890223277;22730.090796368124;6327.114204011442;6383.7551677422925;6432.935670643304;6526.902096468557;6551.377619126175;3981.542122655903;6506.414422701956;6518.576292540994;6559.34406559345;6561.704723287464;4273.465816772903;4359.149965756678;7301.415886729049;7375.114986201664;7376.409887209011;7209.819754506153;7308.598027108507;7347.55914645123;7359.816004599901;7406.740764073285;7244.818879528001;7269.418446524265;7271.3455788979245;7276.381507571863;7284.9271507284775;21273.36179914605;22557.097716091335;25676.358091047685;26809;26997.92008319665;2850.7719382449563;2863.9284017899513;2872.482953068447;2877.84171870547;2894.1028281232884;15080;15706.214689265491;15754.763678544716;16555.337786488526;16665.916670416693;1765.4438851761654;1787.2046939112101;1965.6953172258322;2031.2179810772811;2078.7505499340023;111524.44237778841;120128.39935800264;153838;154205.22897385442;161975.3802461972;19671.803281966997;19674;19891.801081988993;20085.297014604417;20138.89930550338;31020.379592408026;31573.8421307892;31573.8421307892;31577.736890524582;31611.841940790608;10135.391876487287;10269.716285464317;10408.895911040943;10451.581936722447;10616.256862019585;8738.781530461789;8741.650333986569;8747;8883.422577532569;8933.59798809055;7590.696372145052;8839.806626105523;9144.588493517807;9268.675596354095;9290.535473226311;3208.8235147067135;3259.2503724143107;3551.769135006268;3758.4550240215563;3765.548134223856;935.4153653966271;992.3351354592296;1046.3564907581936;1056.587930707025;1086.2667699303097;17599;21207.57584848325;21375.251866184608;21412.143514259566;21698.240561580267;903.2051794420868;942.9057094290516;974.7222041718218;984.9359791613522;991.5339790298548;10249.641262555775;10466.476676166161;10467.110295624805;10539.6197384328;10691.679249622524;770489;775035;779632;780600;807694;124248;124516;145666.27166864098;152829.70755438678;153786.31068446534;1268.6067319131098;1279.1301914697908;1305.7845455499737;1307.843058832946;1309.7445998030294;17244.827551724324;17593.472195834147;17676.116194190497;18083.08552219358;18153.001584912956;59017.40982590119;59209.40790592211;60257.698711506164;60387.490312742535;60737.392626073175;88442;88905;89148;91229;91704.54147729218;10248.795024099625;10597.417142056953;10764;11131.777364452504;11286.887131128584;12164.209326393757;12207.145499814927;12257.632271031884;12404;12567.245965242115;10661.786764264827;10823.729406764895;10905.781884362426;11128.554857805597;11174.944125279322;9792.363496372713;10050.246231532517;10053.04496072872;10138.594456221963;10345.482725863527;10810.837837432287;11142.777144456903;11212.215144939775;11245;11348.148888833206;10712.62505812324;10727.517261723086;10729.141668666332;10744.194185435967;11071.667849964513;10342.638007669997;10582.947085264525;10741.89258107409;10786.029257366874;10988.615398461016 02:00:47 INFO - PROCESS | 1631 | |3;mootools.html;1539.4611885839956;1542.0747551469126;1567.8588926996574;1568.7882135911652;1603.518944316705;10562.894371056287;11181.385023823686;11188.440577971109;11193.10455163587;11210.262409326548;8834.911650883489;10979.341239525635;11170.553177872896;11185.217034807567;11188.66434006979;2047.3857842647221;2398.5322862041908;2427.6601275821313;2433.051110067075;2434.6834911461574;2334.054707843318;2407.6508906208587;2419.661247425362;2420.9394765130837;2421.418859473731;2335.4161459635093;2404.1705611563984;2410.8553486790847;2422.4307287787356;2423.9151629692965;2113.123053932616;2215.1360969222014;2364.3970787449175;2370.9407264818346;2372.454335502844;2363.3028256664325;2384.9046038158453;2389.8446600971056;2395.3891757601873;2395.8682272475007;10892.019718225398;11120.443977801158;11143.609973650884;11157.442127893653;11164.609238676689;5784.623999440023;5957.285125784891;5984.910226346608;5985.610935289235;5988.670623115727;3206.8556914938886;3463.2207753255566;3497.4404095344876;3503.929921401583;3581.1226249568763;1203.8555373355252;1210.056156198158;1242.173954320376;1248.3633346993008;1259.137490818783;13530.323483825869;13889.930550347284;14131.293435328294;15473.613159670986;15670.921645391814;4646.930296045562;4829.879253018632;4839.903201935942;4868.95131048685;4872.512748725099;11907.404629768476;11929.522819087313;11953;11953;11981.341026243466;4911.312416261726;5080.288759573663;5152.046871328816;5154.020736060136;5172.586193104543;4620.561046700558;5189.766460509286;5287.391949925808;5290.682559046392;5311.468853114735;3840.3663395539984;3841.6158384161918;3914.5889681583594;3915.569287378386;3921.274564205631;1039.838824982129;1051.3218973762034;1061.6092918276927;1064.435849000031;1065.8241390170535;904.2991681446931;919.4850883505259;930.8882934047957;934.238595544629;978.0903759503587;6466.967665161738;6586.209654841354;6596.278641540781;6666.166729158856;6725.764598239136;985.3053597213947;985.9161971232382;992.8758905136858;1011.261778901406;1014.5383850348074;4207.810648520824;4209.705320627588;4227.936580951288;4337.414449049338;4362.1493808707;13274.203547787163;13795.793063104062;13821.861781382258;13826.239556824472;13882.236476993661;12756.425960831784;13277.668058298426;13741.381637826322;13745.725085498434;13756.862431375559;9975.950120249352;10243.94878025605;10257.58969641206;10266.794664106676;10272.691819245434;6294.143227747917;6315.400036996478;6490.7079181436;6505.349465053457;6566.474682025522;11202.887971120184;11248.043916267208;11407.372594507382;11436.1422893285;11982.10134239918;10997.285176463503;11349.319040857576;12784.977201823645;12789.872101278868;12805.039622028198;7745.690172393041;9052.456852588866;9099.499527525784;9201.677941272023;9460.195883349992;10303.278770485995;10322.845157322796;10420.47897605132;10443.112335451571;10445.425501597485;8727.214550690469;8773;8837.91162088371;8842.336824738042;8903.910960890309;8640.222379985831;8659.567021649018;8683.826323473622;8686.565671716262;8748.300135989233;7773.222677732181;7874.763757087297;7960.522368657899;7961.164077771982;7990.280874721303;5621.971890140523;5807.332156802022;5965.522758179422;5988.431099045583;6004.909926351195;4623.791929363119;4967.627427942991;5935.762569497172;6064.787732429344;6285.5600107992 02:00:47 INFO - PROCESS | 1631 | |4;prototype.html;368.2653107051431;376.80971109589655;381.39168026996947;382.9731918765684;389.51505375807125;4315.697901146921;4636.0496098299855;4804.423469183698;5081.949180508193;5170.629783107474;4349.739015659063;4589.311603259513;4927.728974906378;5078.542931136197;5151.522722162535;3612.9161251624537;4199.916001679964;4210.705250632457;4243.745375277478;4265.978670106645;3999.58014904709;4284.507281662602;4310.125095583431;4322.265214913472;4353.412289340946;3716.7955762433057;4060;4259.936100958473;4321.65426765858;4352.804123814421;4222.4299719538085;4226.4716910386205;4250.638695710868;4251.574842515754;4283.850065247717;3714.888553343404;3908.394198899175;3923.1565213478953;3956.7625942443547;3976.980115099435;4300.505441874162;4701.365315682373;4883.633727470418;4992.625553083533;5064.860406408566;4518.502964673883;4699.600533954618;4826.107170173494;4852.4662287148385;4907.723991762167;4671.598520443853;5126.71803050832;5149.219421512379;5346.658338538414;5364.570834333244;3676.3750162472443;3909.550401703812;4210.0529629259645;4439.314214900003;4455.46534415869;4616.792244349012;4722.197226471508;5096.898062038738;5317.388500322474;5609.551235901077;3775.565809931893;4110.835566577303;4512.014713526038;4542.795574199169;4549.453185916738;3958.2281455115976;4151.605597468296;4314.848980285675;4407.228734971367;4669.929951050737;4354.934675979863;4514.277715565494;4755.453122890843;4831.855044348676;4912.389393795557;4525.977370113194;4853.6602437829015;4899.657024008286;4997.525235102659;5477.808276710296;1395.1559306619552;1474.5723740115247;1511.6825466651906;1563.4996801023563;1563.6716289579088;1092.9945350273356;1154.4112502623723;1174.671092094215;1176.353105652077;1204.3616883051996;4516.390287311171;4535.6662852803165;5025.346704928336;5057.671251368649;5162.6902385856965;5043.420006699276;5067.986402719471;5335.813246536352;5679.233303503974;5689.061304884731;4432.645388368923;4633.513481084437;5057.544820966131;5086.643934924594;5099.7417156673855;2785.8189217700783;2954.8623779844916;2961.2892905702474;2961.526155815059;2988.5068963621193;4891.032939813422;5368.543673787772;5493.176023596492;5705.771769129271;5785.929603023455;5457.590680698963;5576.944230557724;5601.747921343549;5829.562782791308;5864.38423965486;4989.12690279207;5015.423226328946;5401.543726425714;5422.75597598109;5782.710864456761;5257.789688412574;5268.394134674561;5278.577713782965;5637.633553818989;5744.885102297847;4949.257611358181;5026.425952383313;5047.343845300087;5294.258803767399;5573.470520300565;4848.551481501819;4927.211646136601;4939.777710003131;5859.652279975715;5877.970610146922;3691.6492933171307;4386.912261754684;4465.615659145676;4516.932246016247;4529.592336689714;5312.74980015978;5345.305110335631;5377.686346568742;5531.585131115102;5605.943940560543;4471.821127154877;5429.212764149255;5462.726863656881;5503.917441238465;5516.420775818481;4750.714957102585;5145.871353216199;5218.478152184903;5395.196386547553;5500.874344241819;4742.739149346681;4815.951840481691;5015.764831683471;5248.790048398021;5334.199870019528;4754.50077741846;5127.359080114986;5468.047254482535;5499.652585116672;5513.9448605513435;4652.511486294025;4910.459849416633;5043.839916819079;5438.987574597424;5461.42655021233 02:00:47 INFO - PROCESS | 1631 | |5;yui.html;720.5604581205461;735.7535225699387;795.9044914610248;839.110542824606;839.3117643532302;13732.931335343334;14162.575122746308;14164.079334843227;14226.502072427467;14230.644233894158;14615.78076328856;14726.969112162125;14751.18868462234;14755.704885902276;14760.6309842254;943.79708362702;944.1078181118845;960.1934375124929;960.7790208252071;969.9515024248794;969.0503306759344;969.3456916581315;969.3795970578835;970.708787363788;971.7424882406168;1019.0777346501428;1021.1371391174483;1021.3310281765418;1021.9386836789816;1023.4984857419885;1009.6163457885956;1012.7113772574854;1012.7974405118969;1013.6857574152036;1015.9542820573055;755.8223817402906;758.666186877772;758.6775620361325;759.0625577411892;759.4418102694515;15593.142377169252;15785.289661965124;15804;16108.275127619168;16380.180990950525;13523.188608683511;13629.76947535769;13798.93100534491;13806.516771912935;13969;11657.125715571281;11697.175771273802;11763.882361176364;11829.112816538707;11962.222455540363;3651.835667394974;3663.9450408243897;3701.8704345347783;3782.6973842092566;3898.8245528951265;46650;76057;103874.44188337181;106961.93038069598;107259;10805.945970270099;11152.553897844158;11167;11797.705057373634;11880.643580692593;22055.889720551295;22297.66553501699;22608.886955565118;22671.886640567023;22719.88640056789;7848.13670496245;7983.321417679446;8008.919910800934;8019.238172373615;8108.5945702714625;3636.3272794533095;4248.129133527619;4353.934690979638;4392.890177745582;4455.019895622958;3342.131045928076;3423.383790917609;3425.3320602482277;3427.845746941394;3436.0722604896537;594.2453084582556;596.6151832068292;597.9940200598026;598.3986093975527;598.796409220867;533.6477924569765;639.9360063993656;647.5693663713672;655.1384928818588;677.0893148714971;9289.97810240873;9736.513174341255;9751;9771.657991970247;10081.344712593658;578.8292453726161;630.7729217481703;664.9069130321759;675.1560549313358;684.5590032980604;4766.6901651392545;4769.594584460359;4784.425868895755;4794.736289504111;4806.831760888352;102514;105927.4703626477;107519;107766.46116769366;109934;53920.73039634777;58644.7067764667;60086.39913600896;67736;90053.64919526082;76515;78468;79170.60414698005;79558;80064;10835.295705779099;11043.282186657842;11128.221024528206;11268.830967535658;11311.717207069889;48975;49284.75357623189;49673;50523;50872;60448.697756510934;63877.40306492375;64790.38024049436;64964.35035649583;65089.34910650833;10103.124641755274;12888.806667900177;12918.547850825176;13131.671708207372;13597.116187447784;14599.85400145985;14709.485168019068;14727;15262.3895044197;15644.59198672125;12863.678408039874;13313.933430332787;13353;13631.522896698569;13843.584692458839;13808.378622961789;14041.297935102999;14074.366653500412;14231.217283049531;14232.074915130483;13338.93330533341;13715.794263085862;13716.794248086087;13720.382582783599;13800.93099534496;8675.219230269306;8970.506622135845;9583.664571739955;9660.613575456902;10271.383716976707;10826.492500049657;11416.714582135513;11482.483288251882;11514.36670983104;11784.882151178379 02:00:47 INFO - PROCESS | 1631 | __end_tp_report 02:00:47 INFO - PROCESS | 1631 | __start_cc_report 02:00:47 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,1582 02:00:47 INFO - PROCESS | 1631 | __end_cc_report 02:00:47 INFO - PROCESS | 1631 | __startTimestamp1490950847207__endTimestamp 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | ------- Summary: start ------- 02:00:47 INFO - PROCESS | 1631 | Number of tests: 6 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5934.66 Median:6128.69 stddev:670.04 (10.9%) stddev-sans-first:641.46 02:00:47 INFO - PROCESS | 1631 | Values: 3381.4 3394.5 3396.7 3416.8 3439.4 5945.9 5969.7 5984.6 6001.8 6029.6 5933.4 5994.4 5994.9 6021.0 6028.6 5334.8 5358.0 5390.9 5393.5 5490.1 5274.5 5304.7 5314.7 5481.7 5539.7 4467.7 5411.8 5455.7 5463.8 5474.4 5460.6 5475.7 5479.2 5482.0 5483.3 5249.2 5388.9 5393.6 5395.6 5421.6 5826.8 5838.2 5856.2 5877.6 5916.6 6383.5 6407.9 6436.1 6450.9 6454.8 6425.3 6491.0 6495.6 6497.1 6511.7 5887.9 5925.6 5990.2 6108.5 6128.7 6047.5 6069.3 6600.3 6603.4 6626.5 6410.7 6417.7 6425.0 6430.2 6449.5 5314.8 6315.1 6349.8 6479.7 6489.6 5277.0 6244.1 6355.6 6426.4 6441.9 6316.7 6373.7 6383.8 6385.4 6390.6 5114.2 5142.4 5153.2 5171.1 5190.2 4596.0 4602.6 4660.5 4667.5 4688.1 5765.6 5800.2 5858.5 5967.6 5977.9 5322.3 6362.2 6368.7 6446.7 6478.7 6001.0 6010.9 6015.7 6020.3 6056.6 5631.9 5641.7 5655.1 5664.4 5682.8 6345.8 6411.2 6531.8 6563.6 6635.6 6458.8 6476.4 6477.1 6478.8 6486.7 6551.7 6630.2 6634.9 6646.8 6649.6 6235.7 6247.7 6290.3 6381.5 6405.4 6368.9 6438.8 6459.7 6470.3 6484.7 6273.8 6366.5 6398.7 6399.3 6406.6 6151.4 6215.8 6238.1 6264.7 6366.7 6151.3 6228.3 6237.7 6239.7 6249.2 6374.1 6387.8 6388.2 6397.4 6408.5 6067.0 6108.6 6115.0 6190.2 6265.3 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:54781.09 Median:3172.52 stddev:107569.13 (3390.6%) stddev-sans-first:107794.30 02:00:47 INFO - PROCESS | 1631 | Values: 716.9 754.2 817.6 870.2 886.9 26371.3 32567.8 40057.4 40109.0 40184.6 41186.8 41393.6 41464.0 41468.4 41558.0 7283.6 9173.9 9314.0 9325.4 9347.9 7345.3 10965.0 11216.2 11262.4 11326.9 11124.3 11150.3 11168.3 11183.3 11188.4 7280.3 11109.8 11158.9 11169.6 11204.8 7340.4 10852.8 11069.9 11095.9 11107.8 38918.0 39062.6 39144.2 39191.6 39315.6 3798.1 3814.6 3825.0 3828.3 3905.3 27589.0 27753.6 27898.7 28556.0 29211.3 3053.5 3137.6 3169.8 3175.3 3193.3 347960.0 352313.0 352795.0 353951.5 354883.0 53074.7 53207.0 53359.7 53450.5 53460.0 55511.7 55698.0 55704.4 55708.0 55743.0 14751.9 15105.5 15128.8 15135.9 15142.8 11336.4 11535.0 12904.9 12943.5 12943.7 9522.7 10749.4 12240.2 12296.0 12426.4 5363.5 5378.1 5408.7 5409.2 5412.8 1079.1 1095.3 1100.6 1111.2 1190.1 26488.5 26686.7 26947.8 26966.5 27061.6 1215.0 1223.7 1260.2 1265.9 1273.9 13385.5 13753.9 13835.9 13869.8 14031.9 440674.0 441841.0 443233.0 446091.5 446747.0 56350.7 56392.4 56502.7 56721.7 56833.0 1422.2 1446.9 1459.5 1465.8 1468.0 23916.0 24906.6 25355.1 25590.6 25905.7 41429.6 46222.6 46261.5 46270.3 46383.8 414398.0 417627.0 418036.0 418267.0 418374.0 27602.9 34181.5 34303.0 34397.8 35093.9 38929.6 44278.0 45601.0 45789.5 46370.5 29178.7 30452.2 30765.7 31252.0 31303.8 30892.4 30938.8 31128.8 31399.8 31549.8 36014.8 36123.0 36189.8 36588.1 36620.5 30338.5 30764.1 30983.4 31128.0 31626.9 22537.9 24408.5 24450.5 24576.4 24729.9 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:42880.41 Median:21309.31 stddev:129834.24 (609.3%) stddev-sans-first:130159.25 02:00:47 INFO - PROCESS | 1631 | Values: 382.9 401.3 412.8 421.2 440.3 12905.3 14422.7 20524.8 20574.7 21077.3 21219.5 21345.3 21704.8 22470.3 22730.1 6327.1 6383.8 6432.9 6526.9 6551.4 3981.5 6506.4 6518.6 6559.3 6561.7 4273.5 4359.1 7301.4 7375.1 7376.4 7209.8 7308.6 7347.6 7359.8 7406.7 7244.8 7269.4 7271.3 7276.4 7284.9 21273.4 22557.1 25676.4 26809.0 26997.9 2850.8 2863.9 2872.5 2877.8 2894.1 15080.0 15706.2 15754.8 16555.3 16665.9 1765.4 1787.2 1965.7 2031.2 2078.8 111524.4 120128.4 153838.0 154205.2 161975.4 19671.8 19674.0 19891.8 20085.3 20138.9 31020.4 31573.8 31573.8 31577.7 31611.8 10135.4 10269.7 10408.9 10451.6 10616.3 8738.8 8741.7 8747.0 8883.4 8933.6 7590.7 8839.8 9144.6 9268.7 9290.5 3208.8 3259.3 3551.8 3758.5 3765.5 935.4 992.3 1046.4 1056.6 1086.3 17599.0 21207.6 21375.3 21412.1 21698.2 903.2 942.9 974.7 984.9 991.5 10249.6 10466.5 10467.1 10539.6 10691.7 770489.0 775035.0 779632.0 780600.0 807694.0 124248.0 124516.0 145666.3 152829.7 153786.3 1268.6 1279.1 1305.8 1307.8 1309.7 17244.8 17593.5 17676.1 18083.1 18153.0 59017.4 59209.4 60257.7 60387.5 60737.4 88442.0 88905.0 89148.0 91229.0 91704.5 10248.8 10597.4 10764.0 11131.8 11286.9 12164.2 12207.1 12257.6 12404.0 12567.2 10661.8 10823.7 10905.8 11128.6 11174.9 9792.4 10050.2 10053.0 10138.6 10345.5 10810.8 11142.8 11212.2 11245.0 11348.1 10712.6 10727.5 10729.1 10744.2 11071.7 10342.6 10582.9 10741.9 10786.0 10988.6 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:6658.45 Median:2423.17 stddev:4154.66 (171.5%) stddev-sans-first:4148.51 02:00:47 INFO - PROCESS | 1631 | Values: 1539.5 1542.1 1567.9 1568.8 1603.5 10562.9 11181.4 11188.4 11193.1 11210.3 8834.9 10979.3 11170.6 11185.2 11188.7 2047.4 2398.5 2427.7 2433.1 2434.7 2334.1 2407.7 2419.7 2420.9 2421.4 2335.4 2404.2 2410.9 2422.4 2423.9 2113.1 2215.1 2364.4 2370.9 2372.5 2363.3 2384.9 2389.8 2395.4 2395.9 10892.0 11120.4 11143.6 11157.4 11164.6 5784.6 5957.3 5984.9 5985.6 5988.7 3206.9 3463.2 3497.4 3503.9 3581.1 1203.9 1210.1 1242.2 1248.4 1259.1 13530.3 13889.9 14131.3 15473.6 15670.9 4646.9 4829.9 4839.9 4869.0 4872.5 11907.4 11929.5 11953.0 11953.0 11981.3 4911.3 5080.3 5152.0 5154.0 5172.6 4620.6 5189.8 5287.4 5290.7 5311.5 3840.4 3841.6 3914.6 3915.6 3921.3 1039.8 1051.3 1061.6 1064.4 1065.8 904.3 919.5 930.9 934.2 978.1 6467.0 6586.2 6596.3 6666.2 6725.8 985.3 985.9 992.9 1011.3 1014.5 4207.8 4209.7 4227.9 4337.4 4362.1 13274.2 13795.8 13821.9 13826.2 13882.2 12756.4 13277.7 13741.4 13745.7 13756.9 9976.0 10243.9 10257.6 10266.8 10272.7 6294.1 6315.4 6490.7 6505.3 6566.5 11202.9 11248.0 11407.4 11436.1 11982.1 10997.3 11349.3 12785.0 12789.9 12805.0 7745.7 9052.5 9099.5 9201.7 9460.2 10303.3 10322.8 10420.5 10443.1 10445.4 8727.2 8773.0 8837.9 8842.3 8903.9 8640.2 8659.6 8683.8 8686.6 8748.3 7773.2 7874.8 7960.5 7961.2 7990.3 5622.0 5807.3 5965.5 5988.4 6004.9 4623.8 4967.6 5935.8 6064.8 6285.6 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4483.90 Median:4821.03 stddev:1221.00 (25.3%) stddev-sans-first:1184.71 02:00:47 INFO - PROCESS | 1631 | Values: 368.3 376.8 381.4 383.0 389.5 4315.7 4636.0 4804.4 5081.9 5170.6 4349.7 4589.3 4927.7 5078.5 5151.5 3612.9 4199.9 4210.7 4243.7 4266.0 3999.6 4284.5 4310.1 4322.3 4353.4 3716.8 4060.0 4259.9 4321.7 4352.8 4222.4 4226.5 4250.6 4251.6 4283.9 3714.9 3908.4 3923.2 3956.8 3977.0 4300.5 4701.4 4883.6 4992.6 5064.9 4518.5 4699.6 4826.1 4852.5 4907.7 4671.6 5126.7 5149.2 5346.7 5364.6 3676.4 3909.6 4210.1 4439.3 4455.5 4616.8 4722.2 5096.9 5317.4 5609.6 3775.6 4110.8 4512.0 4542.8 4549.5 3958.2 4151.6 4314.8 4407.2 4669.9 4354.9 4514.3 4755.5 4831.9 4912.4 4526.0 4853.7 4899.7 4997.5 5477.8 1395.2 1474.6 1511.7 1563.5 1563.7 1093.0 1154.4 1174.7 1176.4 1204.4 4516.4 4535.7 5025.3 5057.7 5162.7 5043.4 5068.0 5335.8 5679.2 5689.1 4432.6 4633.5 5057.5 5086.6 5099.7 2785.8 2954.9 2961.3 2961.5 2988.5 4891.0 5368.5 5493.2 5705.8 5785.9 5457.6 5576.9 5601.7 5829.6 5864.4 4989.1 5015.4 5401.5 5422.8 5782.7 5257.8 5268.4 5278.6 5637.6 5744.9 4949.3 5026.4 5047.3 5294.3 5573.5 4848.6 4927.2 4939.8 5859.7 5878.0 3691.6 4386.9 4465.6 4516.9 4529.6 5312.7 5345.3 5377.7 5531.6 5605.9 4471.8 5429.2 5462.7 5503.9 5516.4 4750.7 5145.9 5218.5 5395.2 5500.9 4742.7 4816.0 5015.8 5248.8 5334.2 4754.5 5127.4 5468.0 5499.7 5513.9 4652.5 4910.5 5043.8 5439.0 5461.4 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:19428.17 Median:3382.76 stddev:27259.52 (805.8%) stddev-sans-first:27299.80 02:00:47 INFO - PROCESS | 1631 | Values: 720.6 735.8 795.9 839.1 839.3 13732.9 14162.6 14164.1 14226.5 14230.6 14615.8 14727.0 14751.2 14755.7 14760.6 943.8 944.1 960.2 960.8 970.0 969.1 969.3 969.4 970.7 971.7 1019.1 1021.1 1021.3 1021.9 1023.5 1009.6 1012.7 1012.8 1013.7 1016.0 755.8 758.7 758.7 759.1 759.4 15593.1 15785.3 15804.0 16108.3 16380.2 13523.2 13629.8 13798.9 13806.5 13969.0 11657.1 11697.2 11763.9 11829.1 11962.2 3651.8 3663.9 3701.9 3782.7 3898.8 46650.0 76057.0 103874.4 106961.9 107259.0 10805.9 11152.6 11167.0 11797.7 11880.6 22055.9 22297.7 22608.9 22671.9 22719.9 7848.1 7983.3 8008.9 8019.2 8108.6 3636.3 4248.1 4353.9 4392.9 4455.0 3342.1 3423.4 3425.3 3427.8 3436.1 594.2 596.6 598.0 598.4 598.8 533.6 639.9 647.6 655.1 677.1 9290.0 9736.5 9751.0 9771.7 10081.3 578.8 630.8 664.9 675.2 684.6 4766.7 4769.6 4784.4 4794.7 4806.8 102514.0 105927.5 107519.0 107766.5 109934.0 53920.7 58644.7 60086.4 67736.0 90053.6 76515.0 78468.0 79170.6 79558.0 80064.0 10835.3 11043.3 11128.2 11268.8 11311.7 48975.0 49284.8 49673.0 50523.0 50872.0 60448.7 63877.4 64790.4 64964.4 65089.3 10103.1 12888.8 12918.5 13131.7 13597.1 14599.9 14709.5 14727.0 15262.4 15644.6 12863.7 13313.9 13353.0 13631.5 13843.6 13808.4 14041.3 14074.4 14231.2 14232.1 13338.9 13715.8 13716.8 13720.4 13800.9 8675.2 8970.5 9583.7 9660.6 10271.4 10826.5 11416.7 11482.5 11514.4 11784.9 02:00:47 INFO - PROCESS | 1631 | -------- Summary: end -------- 02:00:47 INFO - PROCESS | 1631 | 02:00:47 INFO - TEST-INFO | 1631: exit 0 02:00:47 INFO - TEST-OK | dromaeo_css | took 1120654ms 02:00:47 INFO - TEST-START | kraken 02:00:47 INFO - operating with platform_type : mac_ 02:00:47 INFO - Initialising browser for kraken test... 02:00:47 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/tmphlw5K5/profile http://localhost:49240/getInfo.html) 02:00:50 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 02:00:50 INFO - PROCESS | 1642 | colorDepth:24 02:00:50 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 02:00:50 INFO - PROCESS | 1642 | __metrics 02:00:50 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:00:50 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:00:51 INFO - TEST-INFO | 1642: exit 0 02:00:51 INFO - Browser initialized. 02:00:51 INFO - Running cycle 1/1 for kraken test... 02:00:51 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/T/tmphlw5K5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:03 INFO - PROCESS | 1644 | RSS: Main: 214884352 02:01:03 INFO - PROCESS | 1644 | 02:01:06 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 02:01:07 INFO - PROCESS | 1644 | RSS: Main: 269025280 02:01:07 INFO - PROCESS | 1644 | 02:01:09 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 02:01:10 INFO - PROCESS | 1644 | RSS: Main: 281083904 02:01:10 INFO - PROCESS | 1644 | 02:01:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 02:01:14 INFO - PROCESS | 1644 | RSS: Main: 376471552 02:01:14 INFO - PROCESS | 1644 | 02:01:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 02:01:16 INFO - PROCESS | 1644 | RSS: Main: 279040000 02:01:16 INFO - PROCESS | 1644 | 02:01:18 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:01:19 INFO - PROCESS | 1644 | RSS: Main: 280600576 02:01:19 INFO - PROCESS | 1644 | 02:01:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 02:01:23 INFO - PROCESS | 1644 | RSS: Main: 319545344 02:01:23 INFO - PROCESS | 1644 | 02:01:26 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 02:01:26 INFO - PROCESS | 1644 | RSS: Main: 321568768 02:01:26 INFO - PROCESS | 1644 | 02:01:29 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 02:01:30 INFO - PROCESS | 1644 | RSS: Main: 318742528 02:01:30 INFO - PROCESS | 1644 | 02:01:32 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:01:32 INFO - PROCESS | 1644 | RSS: Main: 293695488 02:01:32 INFO - PROCESS | 1644 | 02:01:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:01:35 INFO - PROCESS | 1644 | RSS: Main: 294649856 02:01:35 INFO - PROCESS | 1644 | 02:01:37 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:01:37 INFO - PROCESS | 1644 | RSS: Main: 301645824 02:01:37 INFO - PROCESS | 1644 | 02:01:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:01:41 INFO - PROCESS | 1644 | RSS: Main: 316772352 02:01:41 INFO - PROCESS | 1644 | 02:01:44 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:01:45 INFO - PROCESS | 1644 | RSS: Main: 310845440 02:01:45 INFO - PROCESS | 1644 | 02:01:46 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 02:01:47 INFO - PROCESS | 1644 | RSS: Main: 355663872 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | __start_tp_report 02:01:47 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 02:01:47 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 02:01:47 INFO - PROCESS | 1644 | |i|pagename|runs| 02:01:47 INFO - PROCESS | 1644 | |0;ai-astar;116;125;174;148;117;117;116;117;118;117 02:01:47 INFO - PROCESS | 1644 | |1;audio-beat-detection;169;135;134;141;107;110;121;107;129;109 02:01:47 INFO - PROCESS | 1644 | |2;audio-dft;184;190;188;186;185;184;184;186;184;185 02:01:47 INFO - PROCESS | 1644 | |3;audio-fft;84;61;61;93;62;60;61;61;78;60 02:01:47 INFO - PROCESS | 1644 | |4;audio-oscillator;92;87;117;98;81;68;82;67;68;83 02:01:47 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;89;88;88;89;89;88;90;88;89;91 02:01:47 INFO - PROCESS | 1644 | |6;imaging-darkroom;95;95;96;97;96;96;96;99;95;95 02:01:47 INFO - PROCESS | 1644 | |7;imaging-desaturate;86;84;85;84;85;87;85;86;86;83 02:01:47 INFO - PROCESS | 1644 | |8;json-parse-financial;62;60;60;62;62;62;75;80;97;97 02:01:47 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;53;65;70;64;60;58;58;58;57;58 02:01:47 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;79;83;81;85;83;85;81;80;87;82 02:01:47 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;136;137;140;140;143;127;139;139;177;137 02:01:47 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;162;211;160;165;165;165;164;162;163;165 02:01:47 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;67;66;65;66;65;64;64;64;63;70 02:01:47 INFO - PROCESS | 1644 | __end_tp_report 02:01:47 INFO - PROCESS | 1644 | __start_cc_report 02:01:47 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2144 02:01:47 INFO - PROCESS | 1644 | __end_cc_report 02:01:47 INFO - PROCESS | 1644 | __startTimestamp1490950907014__endTimestamp 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | ------- Summary: start ------- 02:01:47 INFO - PROCESS | 1644 | Number of tests: 14 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:126.50 Median:117.50 stddev:19.36 (16.5%) stddev-sans-first:20.16 02:01:47 INFO - PROCESS | 1644 | Values: 116.0 125.0 174.0 148.0 117.0 117.0 116.0 117.0 118.0 117.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:131.50 stddev:19.78 (15.0%) stddev-sans-first:13.62 02:01:47 INFO - PROCESS | 1644 | Values: 169.0 135.0 134.0 141.0 107.0 110.0 121.0 107.0 129.0 109.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:185.60 Median:185.50 stddev:2.01 (1.1%) stddev-sans-first:2.05 02:01:47 INFO - PROCESS | 1644 | Values: 184.0 190.0 188.0 186.0 185.0 184.0 184.0 186.0 184.0 185.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:68.10 Median:61.50 stddev:12.21 (19.8%) stddev-sans-first:11.51 02:01:47 INFO - PROCESS | 1644 | Values: 84.0 61.0 61.0 93.0 62.0 60.0 61.0 61.0 78.0 60.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:82.50 stddev:15.54 (18.8%) stddev-sans-first:16.23 02:01:47 INFO - PROCESS | 1644 | Values: 92.0 87.0 117.0 98.0 81.0 68.0 82.0 67.0 68.0 83.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:89.00 stddev:0.99 (1.1%) stddev-sans-first:1.05 02:01:47 INFO - PROCESS | 1644 | Values: 89.0 88.0 88.0 89.0 89.0 88.0 90.0 88.0 89.0 91.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.27 02:01:47 INFO - PROCESS | 1644 | Values: 95.0 95.0 96.0 97.0 96.0 96.0 96.0 99.0 95.0 95.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.20 (1.4%) stddev-sans-first:1.22 02:01:47 INFO - PROCESS | 1644 | Values: 86.0 84.0 85.0 84.0 85.0 87.0 85.0 86.0 86.0 83.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:68.50 stddev:14.94 (21.8%) stddev-sans-first:15.43 02:01:47 INFO - PROCESS | 1644 | Values: 62.0 60.0 60.0 62.0 62.0 62.0 75.0 80.0 97.0 97.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:59.00 stddev:4.89 (8.3%) stddev-sans-first:4.46 02:01:47 INFO - PROCESS | 1644 | Values: 53.0 65.0 70.0 64.0 60.0 58.0 58.0 58.0 57.0 58.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:2.50 (3.0%) stddev-sans-first:2.29 02:01:47 INFO - PROCESS | 1644 | Values: 79.0 83.0 81.0 85.0 83.0 85.0 81.0 80.0 87.0 82.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:139.50 stddev:13.17 (9.4%) stddev-sans-first:13.82 02:01:47 INFO - PROCESS | 1644 | Values: 136.0 137.0 140.0 140.0 143.0 127.0 139.0 139.0 177.0 137.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:165.00 stddev:15.13 (9.2%) stddev-sans-first:15.89 02:01:47 INFO - PROCESS | 1644 | Values: 162.0 211.0 160.0 165.0 165.0 165.0 164.0 162.0 163.0 165.0 02:01:47 INFO - PROCESS | 1644 | 02:01:47 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:2.01 (3.1%) stddev-sans-first:2.05 02:01:47 INFO - PROCESS | 1644 | Values: 67.0 66.0 65.0 66.0 65.0 64.0 64.0 64.0 63.0 70.0 02:01:47 INFO - PROCESS | 1644 | -------- Summary: end -------- 02:01:47 INFO - PROCESS | 1644 | 02:01:48 INFO - TEST-INFO | 1644: exit 0 02:01:48 INFO - TEST-OK | kraken | took 60239ms 02:01:48 INFO - SUITE-END | took 1180s 02:01:48 INFO - Completed test suite (00:19:40) 02:01:48 INFO - javascript benchmark 02:01:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7623.393573678085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.425157723187, 3394.490826376043, 3396.728261739061, 3416.8120753358558, 3439.363717712223, 5945.940540594598, 5969.701514924258, 5984.581079324449, 6001.849953751158, 6029.608075475091, 5933.376995415473, 5994.430529099728, 5994.940050599493, 6021.006533921908, 6028.577999540034, 5334.786608535664, 5357.973210133944, 5390.9191362129595, 5393.514583687467, 5490.149026900836, 5274.472552744734, 5304.681719096847, 5314.681119132845, 5481.698506582136, 5539.667619942817, 4467.664925130612, 5411.756470958797, 5455.727213639302, 5463.7814487420455, 5474.42518535554, 5460.6177567570285, 5475.698836563987, 5479.232907392969, 5482.0406428874785, 5483.341998960131, 5249.186376111708, 5388.892222155574, 5393.622446428752, 5395.568354531628, 5421.603064039215, 5826.766929322865, 5838.241028666246, 5856.238688970449, 5877.588568800185, 5916.585838991272, 6383.521235907326, 6407.903881441782, 6436.131122298477, 6450.935490645081, 6454.774082907123, 6425.261094974045, 6490.967545162292, 6495.642739649317, 6497.057926600663, 6511.706973186218, 5887.911681324741, 5925.585209035412, 5990.161377407167, 6108.480779133779, 6128.686460748315, 6047.455728984324, 6069.332373438918, 6600.339966003361, 6603.438707709898, 6626.503012274099, 6410.743570257231, 6417.679116044273, 6425.0, 6430.228372595225, 6449.548531602836, 5314.7608357624, 6315.052742088632, 6349.841253968688, 6479.6760161991715, 6489.5781774184525, 5277.0, 6244.094606282064, 6355.586886852339, 6426.389492998158, 6441.935580644134, 6316.652584107826, 6373.74505019794, 6383.776567820104, 6385.425311721968, 6390.648514331663, 5114.232865070269, 5142.382914050338, 5153.175491921274, 5171.069207542603, 5190.195519694454, 4596.034832685106, 4602.585767280961, 4660.53394660538, 4667.509911459248, 4688.062387522441, 5765.567582431335, 5800.216970708984, 5858.53131749459, 5967.5524335675, 5977.850553736104, 5322.33470816148, 6362.172917520693, 6368.745250190033, 6446.7421303148285, 6478.676066196671, 6001.0, 6010.939890601126, 6015.699215039231, 6020.277566692025, 6056.606320589148, 5631.943680563142, 5641.746121424464, 5655.123455864347, 5664.376918538957, 5682.829515114553, 6345.777897773556, 6411.166548348685, 6531.836704082436, 6563.573367731082, 6635.601863888182, 6458.806235812933, 6476.417122459001, 6477.060826180272, 6478.773242936474, 6486.6756662167645, 6551.70517326731, 6630.204375474974, 6634.867302654016, 6646.833829154117, 6649.63427011519, 6235.657038862906, 6247.656378899204, 6290.339514351111, 6381.521385896169, 6405.3594640535575, 6368.949123394588, 6438.806835794933, 6459.709313081016, 6470.320616335405, 6484.675766211765, 6273.780417685359, 6366.5225108118, 6398.680065996588, 6399.328070552711, 6406.5515413920575, 6151.446369826737, 6215.844603884939, 6238.095476155841, 6264.68676566179, 6366.745330186741, 6151.292601350723, 6228.252609686867, 6237.688115594293, 6239.688015599293, 6249.218847644044, 6374.07575901501, 6387.808365749035, 6388.169537960035, 6397.424231819158, 6408.487321014214, 6066.969665151646, 6108.645631960441, 6114.969425152845, 6190.164327815687, 6265.310815810349], "value": 5891.868948206152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.9318914703103, 754.1704125461993, 817.5748610722425, 870.2385412763832, 886.9068747781487, 26371.340716482075, 32567.837160814193, 40057.3991390129, 40109.0, 40184.59815401845, 41186.7940660297, 41393.58606413935, 41464.0, 41468.37797433041, 41558.0, 7283.562986220843, 9173.862392064124, 9314.0, 9325.440473571574, 9347.906520934806, 7345.338919497244, 10965.013148816604, 11216.158788090885, 11262.380569068699, 11326.886731132665, 11124.276922000045, 11150.275232109927, 11168.274062185932, 11183.32900026001, 11188.440577971109, 7280.344768970818, 11109.777804443906, 11158.888411115866, 11169.553217871235, 11204.775904481947, 7340.4127669786285, 10852.837207441895, 11069.944650276777, 11095.889041109567, 11107.777844443066, 38918.02704932371, 39062.60937390618, 39144.21711565781, 39191.60808391908, 39315.60684393177, 3798.0694729791103, 3814.6376094271, 3824.9808750956345, 3828.3028056331223, 3905.258000979805, 27589.0, 27753.583696244572, 27898.721012789814, 28556.0, 29211.269718257212, 3053.4961731314306, 3137.6037663239867, 3169.793963392372, 3175.25381535339, 3193.3134376109015, 347960.0, 352313.0, 352795.0, 353951.46048539184, 354883.0, 53074.73462632662, 53207.0, 53359.666008349326, 53450.46549534455, 53460.0, 55511.722441388345, 55698.0, 55704.442955569924, 55708.0, 55743.0, 14751.852481475262, 15105.47130850415, 15128.848711512965, 15135.924320378548, 15142.772858407132, 11336.43317834105, 11535.0, 12904.935475322563, 12943.482260709467, 12943.741125177632, 9522.714318570454, 10749.355038697548, 12240.204386714835, 12296.0, 12426.378681065911, 5363.517283444508, 5378.13949768043, 5408.729563521808, 5409.161579955114, 5412.756425960842, 1079.1169409380682, 1095.3373209208473, 1100.6367898593444, 1111.1777284809184, 1190.0836356006, 26488.470230595667, 26686.733132668815, 26947.787349569317, 26966.460670786866, 27061.594076088873, 1214.9574764883187, 1223.749131428055, 1260.1871792693662, 1265.9113862029753, 1273.8789814967563, 13385.531506397425, 13753.881581242676, 13835.930820346035, 13869.791953120712, 14031.929840350937, 440674.0, 441841.0, 443233.0, 446091.5390846115, 446747.0, 56350.71824640933, 56392.43607563954, 56502.71748641313, 56721.71639141778, 56833.0, 1422.1893520693313, 1446.8842492600568, 1459.5329494561638, 1465.8460861609378, 1468.0237641967972, 23916.04776249993, 24906.626400603644, 25355.112571059923, 25590.647478423238, 25905.74094259033, 41429.58570414257, 46222.61332160041, 46261.53738462572, 46270.30594541152, 46383.76808115938, 414398.0, 417627.0, 418036.0, 418267.0, 418374.0, 27602.895884165213, 34181.46183421802, 34302.97091087271, 34397.82801085978, 35093.94718158459, 38929.6107038926, 44278.0, 45601.0, 45789.542104578526, 46370.53629463662, 29178.708212917598, 30452.238694032825, 30765.69234307718, 31252.0, 31303.84348078245, 30892.374148197654, 30938.845305774226, 31128.844355778077, 31399.84300078485, 31549.8422507886, 36014.8199259002, 36123.0, 36189.81905090563, 36588.085297867765, 36620.45069323909, 30338.544921826633, 30764.077077687703, 30983.380332393677, 31128.0, 31626.893058743753, 22537.887310563343, 24408.51182976366, 24450.51098978046, 24576.376188848208, 24729.882357644983], "value": 18784.084285383433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8679105708533, 401.31575663493726, 412.7729748638248, 421.20602663978394, 440.3131115459883, 12905.2902090385, 14422.711545769078, 20524.794752052494, 20574.69137962932, 21077.262295819648, 21219.469513262175, 21345.25291614794, 21704.782952170473, 22470.325890223277, 22730.090796368124, 6327.114204011442, 6383.7551677422925, 6432.935670643304, 6526.902096468557, 6551.377619126175, 3981.542122655903, 6506.414422701956, 6518.576292540994, 6559.34406559345, 6561.704723287464, 4273.465816772903, 4359.149965756678, 7301.415886729049, 7375.114986201664, 7376.409887209011, 7209.819754506153, 7308.598027108507, 7347.55914645123, 7359.816004599901, 7406.740764073285, 7244.818879528001, 7269.418446524265, 7271.3455788979245, 7276.381507571863, 7284.9271507284775, 21273.36179914605, 22557.097716091335, 25676.358091047685, 26809.0, 26997.92008319665, 2850.7719382449563, 2863.9284017899513, 2872.482953068447, 2877.84171870547, 2894.1028281232884, 15080.0, 15706.214689265491, 15754.763678544716, 16555.337786488526, 16665.916670416693, 1765.4438851761654, 1787.2046939112101, 1965.6953172258322, 2031.2179810772811, 2078.7505499340023, 111524.44237778841, 120128.39935800264, 153838.0, 154205.22897385442, 161975.3802461972, 19671.803281966997, 19674.0, 19891.801081988993, 20085.297014604417, 20138.89930550338, 31020.379592408026, 31573.8421307892, 31573.8421307892, 31577.736890524582, 31611.841940790608, 10135.391876487287, 10269.716285464317, 10408.895911040943, 10451.581936722447, 10616.256862019585, 8738.781530461789, 8741.650333986569, 8747.0, 8883.422577532569, 8933.59798809055, 7590.696372145052, 8839.806626105523, 9144.588493517807, 9268.675596354095, 9290.535473226311, 3208.8235147067135, 3259.2503724143107, 3551.769135006268, 3758.4550240215563, 3765.548134223856, 935.4153653966271, 992.3351354592296, 1046.3564907581936, 1056.587930707025, 1086.2667699303097, 17599.0, 21207.57584848325, 21375.251866184608, 21412.143514259566, 21698.240561580267, 903.2051794420868, 942.9057094290516, 974.7222041718218, 984.9359791613522, 991.5339790298548, 10249.641262555775, 10466.476676166161, 10467.110295624805, 10539.6197384328, 10691.679249622524, 770489.0, 775035.0, 779632.0, 780600.0, 807694.0, 124248.0, 124516.0, 145666.27166864098, 152829.70755438678, 153786.31068446534, 1268.6067319131098, 1279.1301914697908, 1305.7845455499737, 1307.843058832946, 1309.7445998030294, 17244.827551724324, 17593.472195834147, 17676.116194190497, 18083.08552219358, 18153.001584912956, 59017.40982590119, 59209.40790592211, 60257.698711506164, 60387.490312742535, 60737.392626073175, 88442.0, 88905.0, 89148.0, 91229.0, 91704.54147729218, 10248.795024099625, 10597.417142056953, 10764.0, 11131.777364452504, 11286.887131128584, 12164.209326393757, 12207.145499814927, 12257.632271031884, 12404.0, 12567.245965242115, 10661.786764264827, 10823.729406764895, 10905.781884362426, 11128.554857805597, 11174.944125279322, 9792.363496372713, 10050.246231532517, 10053.04496072872, 10138.594456221963, 10345.482725863527, 10810.837837432287, 11142.777144456903, 11212.215144939775, 11245.0, 11348.148888833206, 10712.62505812324, 10727.517261723086, 10729.141668666332, 10744.194185435967, 11071.667849964513, 10342.638007669997, 10582.947085264525, 10741.89258107409, 10786.029257366874, 10988.615398461016], "value": 11208.391166460811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.4611885839956, 1542.0747551469126, 1567.8588926996574, 1568.7882135911652, 1603.518944316705, 10562.894371056287, 11181.385023823686, 11188.440577971109, 11193.10455163587, 11210.262409326548, 8834.911650883489, 10979.341239525635, 11170.553177872896, 11185.217034807567, 11188.66434006979, 2047.3857842647221, 2398.5322862041908, 2427.6601275821313, 2433.051110067075, 2434.6834911461574, 2334.054707843318, 2407.6508906208587, 2419.661247425362, 2420.9394765130837, 2421.418859473731, 2335.4161459635093, 2404.1705611563984, 2410.8553486790847, 2422.4307287787356, 2423.9151629692965, 2113.123053932616, 2215.1360969222014, 2364.3970787449175, 2370.9407264818346, 2372.454335502844, 2363.3028256664325, 2384.9046038158453, 2389.8446600971056, 2395.3891757601873, 2395.8682272475007, 10892.019718225398, 11120.443977801158, 11143.609973650884, 11157.442127893653, 11164.609238676689, 5784.623999440023, 5957.285125784891, 5984.910226346608, 5985.610935289235, 5988.670623115727, 3206.8556914938886, 3463.2207753255566, 3497.4404095344876, 3503.929921401583, 3581.1226249568763, 1203.8555373355252, 1210.056156198158, 1242.173954320376, 1248.3633346993008, 1259.137490818783, 13530.323483825869, 13889.930550347284, 14131.293435328294, 15473.613159670986, 15670.921645391814, 4646.930296045562, 4829.879253018632, 4839.903201935942, 4868.95131048685, 4872.512748725099, 11907.404629768476, 11929.522819087313, 11953.0, 11953.0, 11981.341026243466, 4911.312416261726, 5080.288759573663, 5152.046871328816, 5154.020736060136, 5172.586193104543, 4620.561046700558, 5189.766460509286, 5287.391949925808, 5290.682559046392, 5311.468853114735, 3840.3663395539984, 3841.6158384161918, 3914.5889681583594, 3915.569287378386, 3921.274564205631, 1039.838824982129, 1051.3218973762034, 1061.6092918276927, 1064.435849000031, 1065.8241390170535, 904.2991681446931, 919.4850883505259, 930.8882934047957, 934.238595544629, 978.0903759503587, 6466.967665161738, 6586.209654841354, 6596.278641540781, 6666.166729158856, 6725.764598239136, 985.3053597213947, 985.9161971232382, 992.8758905136858, 1011.261778901406, 1014.5383850348074, 4207.810648520824, 4209.705320627588, 4227.936580951288, 4337.414449049338, 4362.1493808707, 13274.203547787163, 13795.793063104062, 13821.861781382258, 13826.239556824472, 13882.236476993661, 12756.425960831784, 13277.668058298426, 13741.381637826322, 13745.725085498434, 13756.862431375559, 9975.950120249352, 10243.94878025605, 10257.58969641206, 10266.794664106676, 10272.691819245434, 6294.143227747917, 6315.400036996478, 6490.7079181436, 6505.349465053457, 6566.474682025522, 11202.887971120184, 11248.043916267208, 11407.372594507382, 11436.1422893285, 11982.10134239918, 10997.285176463503, 11349.319040857576, 12784.977201823645, 12789.872101278868, 12805.039622028198, 7745.690172393041, 9052.456852588866, 9099.499527525784, 9201.677941272023, 9460.195883349992, 10303.278770485995, 10322.845157322796, 10420.47897605132, 10443.112335451571, 10445.425501597485, 8727.214550690469, 8773.0, 8837.91162088371, 8842.336824738042, 8903.910960890309, 8640.222379985831, 8659.567021649018, 8683.826323473622, 8686.565671716262, 8748.300135989233, 7773.222677732181, 7874.763757087297, 7960.522368657899, 7961.164077771982, 7990.280874721303, 5621.971890140523, 5807.332156802022, 5965.522758179422, 5988.431099045583, 6004.909926351195, 4623.791929363119, 4967.627427942991, 5935.762569497172, 6064.787732429344, 6285.5600107992], "value": 5092.044687936758, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.2653107051431, 376.80971109589655, 381.39168026996947, 382.9731918765684, 389.51505375807125, 4315.697901146921, 4636.0496098299855, 4804.423469183698, 5081.949180508193, 5170.629783107474, 4349.739015659063, 4589.311603259513, 4927.728974906378, 5078.542931136197, 5151.522722162535, 3612.9161251624537, 4199.916001679964, 4210.705250632457, 4243.745375277478, 4265.978670106645, 3999.58014904709, 4284.507281662602, 4310.125095583431, 4322.265214913472, 4353.412289340946, 3716.7955762433057, 4060.0, 4259.936100958473, 4321.65426765858, 4352.804123814421, 4222.4299719538085, 4226.4716910386205, 4250.638695710868, 4251.574842515754, 4283.850065247717, 3714.888553343404, 3908.394198899175, 3923.1565213478953, 3956.7625942443547, 3976.980115099435, 4300.505441874162, 4701.365315682373, 4883.633727470418, 4992.625553083533, 5064.860406408566, 4518.502964673883, 4699.600533954618, 4826.107170173494, 4852.4662287148385, 4907.723991762167, 4671.598520443853, 5126.71803050832, 5149.219421512379, 5346.658338538414, 5364.570834333244, 3676.3750162472443, 3909.550401703812, 4210.0529629259645, 4439.314214900003, 4455.46534415869, 4616.792244349012, 4722.197226471508, 5096.898062038738, 5317.388500322474, 5609.551235901077, 3775.565809931893, 4110.835566577303, 4512.014713526038, 4542.795574199169, 4549.453185916738, 3958.2281455115976, 4151.605597468296, 4314.848980285675, 4407.228734971367, 4669.929951050737, 4354.934675979863, 4514.277715565494, 4755.453122890843, 4831.855044348676, 4912.389393795557, 4525.977370113194, 4853.6602437829015, 4899.657024008286, 4997.525235102659, 5477.808276710296, 1395.1559306619552, 1474.5723740115247, 1511.6825466651906, 1563.4996801023563, 1563.6716289579088, 1092.9945350273356, 1154.4112502623723, 1174.671092094215, 1176.353105652077, 1204.3616883051996, 4516.390287311171, 4535.6662852803165, 5025.346704928336, 5057.671251368649, 5162.6902385856965, 5043.420006699276, 5067.986402719471, 5335.813246536352, 5679.233303503974, 5689.061304884731, 4432.645388368923, 4633.513481084437, 5057.544820966131, 5086.643934924594, 5099.7417156673855, 2785.8189217700783, 2954.8623779844916, 2961.2892905702474, 2961.526155815059, 2988.5068963621193, 4891.032939813422, 5368.543673787772, 5493.176023596492, 5705.771769129271, 5785.929603023455, 5457.590680698963, 5576.944230557724, 5601.747921343549, 5829.562782791308, 5864.38423965486, 4989.12690279207, 5015.423226328946, 5401.543726425714, 5422.75597598109, 5782.710864456761, 5257.789688412574, 5268.394134674561, 5278.577713782965, 5637.633553818989, 5744.885102297847, 4949.257611358181, 5026.425952383313, 5047.343845300087, 5294.258803767399, 5573.470520300565, 4848.551481501819, 4927.211646136601, 4939.777710003131, 5859.652279975715, 5877.970610146922, 3691.6492933171307, 4386.912261754684, 4465.615659145676, 4516.932246016247, 4529.592336689714, 5312.74980015978, 5345.305110335631, 5377.686346568742, 5531.585131115102, 5605.943940560543, 4471.821127154877, 5429.212764149255, 5462.726863656881, 5503.917441238465, 5516.420775818481, 4750.714957102585, 5145.871353216199, 5218.478152184903, 5395.196386547553, 5500.874344241819, 4742.739149346681, 4815.951840481691, 5015.764831683471, 5248.790048398021, 5334.199870019528, 4754.50077741846, 5127.359080114986, 5468.047254482535, 5499.652585116672, 5513.9448605513435, 4652.511486294025, 4910.459849416633, 5043.839916819079, 5438.987574597424, 5461.42655021233], "value": 4132.7963995687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5604581205461, 735.7535225699387, 795.9044914610248, 839.110542824606, 839.3117643532302, 13732.931335343334, 14162.575122746308, 14164.079334843227, 14226.502072427467, 14230.644233894158, 14615.78076328856, 14726.969112162125, 14751.18868462234, 14755.704885902276, 14760.6309842254, 943.79708362702, 944.1078181118845, 960.1934375124929, 960.7790208252071, 969.9515024248794, 969.0503306759344, 969.3456916581315, 969.3795970578835, 970.708787363788, 971.7424882406168, 1019.0777346501428, 1021.1371391174483, 1021.3310281765418, 1021.9386836789816, 1023.4984857419885, 1009.6163457885956, 1012.7113772574854, 1012.7974405118969, 1013.6857574152036, 1015.9542820573055, 755.8223817402906, 758.666186877772, 758.6775620361325, 759.0625577411892, 759.4418102694515, 15593.142377169252, 15785.289661965124, 15804.0, 16108.275127619168, 16380.180990950525, 13523.188608683511, 13629.76947535769, 13798.93100534491, 13806.516771912935, 13969.0, 11657.125715571281, 11697.175771273802, 11763.882361176364, 11829.112816538707, 11962.222455540363, 3651.835667394974, 3663.9450408243897, 3701.8704345347783, 3782.6973842092566, 3898.8245528951265, 46650.0, 76057.0, 103874.44188337181, 106961.93038069598, 107259.0, 10805.945970270099, 11152.553897844158, 11167.0, 11797.705057373634, 11880.643580692593, 22055.889720551295, 22297.66553501699, 22608.886955565118, 22671.886640567023, 22719.88640056789, 7848.13670496245, 7983.321417679446, 8008.919910800934, 8019.238172373615, 8108.5945702714625, 3636.3272794533095, 4248.129133527619, 4353.934690979638, 4392.890177745582, 4455.019895622958, 3342.131045928076, 3423.383790917609, 3425.3320602482277, 3427.845746941394, 3436.0722604896537, 594.2453084582556, 596.6151832068292, 597.9940200598026, 598.3986093975527, 598.796409220867, 533.6477924569765, 639.9360063993656, 647.5693663713672, 655.1384928818588, 677.0893148714971, 9289.97810240873, 9736.513174341255, 9751.0, 9771.657991970247, 10081.344712593658, 578.8292453726161, 630.7729217481703, 664.9069130321759, 675.1560549313358, 684.5590032980604, 4766.6901651392545, 4769.594584460359, 4784.425868895755, 4794.736289504111, 4806.831760888352, 102514.0, 105927.4703626477, 107519.0, 107766.46116769366, 109934.0, 53920.73039634777, 58644.7067764667, 60086.39913600896, 67736.0, 90053.64919526082, 76515.0, 78468.0, 79170.60414698005, 79558.0, 80064.0, 10835.295705779099, 11043.282186657842, 11128.221024528206, 11268.830967535658, 11311.717207069889, 48975.0, 49284.75357623189, 49673.0, 50523.0, 50872.0, 60448.697756510934, 63877.40306492375, 64790.38024049436, 64964.35035649583, 65089.34910650833, 10103.124641755274, 12888.806667900177, 12918.547850825176, 13131.671708207372, 13597.116187447784, 14599.85400145985, 14709.485168019068, 14727.0, 15262.3895044197, 15644.59198672125, 12863.678408039874, 13313.933430332787, 13353.0, 13631.522896698569, 13843.584692458839, 13808.378622961789, 14041.297935102999, 14074.366653500412, 14231.217283049531, 14232.074915130483, 13338.93330533341, 13715.794263085862, 13716.794248086087, 13720.382582783599, 13800.93099534496, 8675.219230269306, 8970.506622135845, 9583.664571739955, 9660.613575456902, 10271.383716976707, 10826.492500049657, 11416.714582135513, 11482.483288251882, 11514.36670983104, 11784.882151178379], "value": 7518.40219239021, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 125.0, 174.0, 148.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0], "value": 126.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 135.0, 134.0, 141.0, 107.0, 110.0, 121.0, 107.0, 129.0, 109.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 190.0, 188.0, 186.0, 185.0, 184.0, 184.0, 186.0, 184.0, 185.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 61.0, 93.0, 62.0, 60.0, 61.0, 61.0, 78.0, 60.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 117.0, 98.0, 81.0, 68.0, 82.0, 67.0, 68.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 89.0, 89.0, 88.0, 90.0, 88.0, 89.0, 91.0], "value": 88.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 99.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 84.0, 85.0, 87.0, 85.0, 86.0, 86.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 62.0, 62.0, 62.0, 75.0, 80.0, 97.0, 97.0], "value": 71.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 65.0, 70.0, 64.0, 60.0, 58.0, 58.0, 58.0, 57.0, 58.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 81.0, 85.0, 83.0, 85.0, 81.0, 80.0, 87.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 140.0, 140.0, 143.0, 127.0, 139.0, 139.0, 177.0, 137.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 211.0, 160.0, 165.0, 165.0, 165.0, 164.0, 162.0, 163.0, 165.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 65.0, 64.0, 64.0, 64.0, 63.0, 70.0], "value": 65.4, "unit": "score"}]}]} 02:01:48 INFO - Return code: 0 02:01:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:01:48 ERROR - # TBPL SUCCESS # 02:01:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:01:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:01:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:01:48 INFO - 2017-03-31 02:01:48.333 screenresolution[1648:9735] starting screenresolution argv=screenresolution get 02:01:48 INFO - 2017-03-31 02:01:48.336 screenresolution[1648:9735] Display 0: 1600x1200x32@60 02:01:48 INFO - 2017-03-31 02:01:48.342 screenresolution[1649:9738] starting screenresolution argv=screenresolution list 02:01:48 INFO - Available Modes on Display 0 02:01:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:01:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:01:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:01:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:01:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:01:48 INFO - Intel Iris: 02:01:48 INFO - Chipset Model: Intel Iris 02:01:48 INFO - Type: GPU 02:01:48 INFO - Bus: Built-In 02:01:48 INFO - VRAM (Dynamic, Max): 1536 MB 02:01:48 INFO - Vendor: Intel (0x8086) 02:01:48 INFO - Device ID: 0x0a2e 02:01:48 INFO - Revision ID: 0x0009 02:01:48 INFO - Displays: 02:01:48 INFO - Display: 02:01:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:01:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:01:48 INFO - Display Serial Number: 1600x1200 60 02:01:48 INFO - Main Display: Yes 02:01:48 INFO - Mirror: Off 02:01:48 INFO - Online: Yes 02:01:48 INFO - Rotation: Supported 02:01:48 INFO - Return code: 0 02:01:48 INFO - Running post-action listener: _resource_record_post_action 02:01:48 INFO - [mozharness: 2017-03-31 09:01:48.598661Z] Finished run-tests step (success) 02:01:48 INFO - Running post-run listener: _resource_record_post_run 02:01:48 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 36602880; Write bytes: 507515392; Read time: 430; Write time: 1947 02:01:48 INFO - TinderboxPrint: CPU usage
53.8% 02:01:48 INFO - TinderboxPrint: I/O read bytes / time
36,602,880 / 430 02:01:48 INFO - TinderboxPrint: I/O write bytes / time
507,515,392 / 1,947 02:01:48 INFO - TinderboxPrint: CPU idle
2,218.0 (46.2%) 02:01:48 INFO - TinderboxPrint: CPU system
959.5 (20.0%) 02:01:48 INFO - TinderboxPrint: CPU user
1,628.4 (33.9%) 02:01:48 INFO - TinderboxPrint: Swap in / out
244,707,328 / 0 02:01:48 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205836800; Write bytes: 201529344; Read time: 15774; Write time: 480 02:01:48 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 34477056; Write bytes: 294930944; Read time: 404; Write time: 1431 02:01:49 INFO - Running post-run listener: _upload_blobber_files 02:01:49 INFO - Blob upload gear active. 02:01:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:01:49 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 02:01:49 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'] 02:01:49 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 02:01:50 INFO - (blobuploader) - INFO - Open directory for files ... 02:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:01:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:52 INFO - (blobuploader) - INFO - Done attempting. 02:01:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:01:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:01:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:53 INFO - (blobuploader) - INFO - Done attempting. 02:01:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:01:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:01:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:55 INFO - (blobuploader) - INFO - Done attempting. 02:01:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:01:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:01:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:58 INFO - (blobuploader) - INFO - Done attempting. 02:01:58 INFO - (blobuploader) - INFO - Iteration through files over. 02:01:58 INFO - Return code: 0 02:01:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:01:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:01:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed1ef61dcf7cbed35432cb091428827487bbb445a418ba602bdbd80a3435c9be2a3ab0cf9c9b8ccbbf8405f8b8adf4e9f8ba905fceb06803aa56868f9cbfe26c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d61dcf1c8756db80a531be3682dd46362d6e19a790690e1826d7e6f46e09cfb0a74d3421aea0ca3f8ee10202f4066a311ff4c8e14d8912285bf1daaf2644527f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d3c8d6b87e864d904c0e9c04adf07b840b464d924131a2d0eb3f3eb2575b9fa489521f4d705565ed9d99c468fb2cccbcdd70ddf2811d2ca63198188fc79a04", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94d87950a96d1544d2dec24edfdac06d779ab797781e1386d4626572372478dbb74c6295e38525e3a9a54ea2cc1aed675adf9d984baed5d0f4c04d00299eae3c"} 02:01:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:01:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:01:58 INFO - Contents: 02:01:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed1ef61dcf7cbed35432cb091428827487bbb445a418ba602bdbd80a3435c9be2a3ab0cf9c9b8ccbbf8405f8b8adf4e9f8ba905fceb06803aa56868f9cbfe26c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d61dcf1c8756db80a531be3682dd46362d6e19a790690e1826d7e6f46e09cfb0a74d3421aea0ca3f8ee10202f4066a311ff4c8e14d8912285bf1daaf2644527f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d3c8d6b87e864d904c0e9c04adf07b840b464d924131a2d0eb3f3eb2575b9fa489521f4d705565ed9d99c468fb2cccbcdd70ddf2811d2ca63198188fc79a04", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94d87950a96d1544d2dec24edfdac06d779ab797781e1386d4626572372478dbb74c6295e38525e3a9a54ea2cc1aed675adf9d984baed5d0f4c04d00299eae3c"} 02:01:58 INFO - Running post-run listener: copy_logs_to_upload_dir 02:01:58 INFO - Copying logs to upload dir... 02:01:58 INFO - mkdir: /builds/slave/test/build/upload/logs 02:01:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.206880 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-31 02:01:58.400402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 02:01:58.404250) ========= 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.tRuShoW5Pt/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.geHokTsSWV/Listeners TMPDIR=/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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/ed1ef61dcf7cbed35432cb091428827487bbb445a418ba602bdbd80a3435c9be2a3ab0cf9c9b8ccbbf8405f8b8adf4e9f8ba905fceb06803aa56868f9cbfe26c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d61dcf1c8756db80a531be3682dd46362d6e19a790690e1826d7e6f46e09cfb0a74d3421aea0ca3f8ee10202f4066a311ff4c8e14d8912285bf1daaf2644527f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d3c8d6b87e864d904c0e9c04adf07b840b464d924131a2d0eb3f3eb2575b9fa489521f4d705565ed9d99c468fb2cccbcdd70ddf2811d2ca63198188fc79a04", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94d87950a96d1544d2dec24edfdac06d779ab797781e1386d4626572372478dbb74c6295e38525e3a9a54ea2cc1aed675adf9d984baed5d0f4c04d00299eae3c"} build_url:https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/A1r3hLrqRsSQwfXXkGJk7A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed1ef61dcf7cbed35432cb091428827487bbb445a418ba602bdbd80a3435c9be2a3ab0cf9c9b8ccbbf8405f8b8adf4e9f8ba905fceb06803aa56868f9cbfe26c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d61dcf1c8756db80a531be3682dd46362d6e19a790690e1826d7e6f46e09cfb0a74d3421aea0ca3f8ee10202f4066a311ff4c8e14d8912285bf1daaf2644527f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d3c8d6b87e864d904c0e9c04adf07b840b464d924131a2d0eb3f3eb2575b9fa489521f4d705565ed9d99c468fb2cccbcdd70ddf2811d2ca63198188fc79a04", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94d87950a96d1544d2dec24edfdac06d779ab797781e1386d4626572372478dbb74c6295e38525e3a9a54ea2cc1aed675adf9d984baed5d0f4c04d00299eae3c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 02:01:58.439456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 02:01:58.439838) ========= 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.tRuShoW5Pt/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.geHokTsSWV/Listeners TMPDIR=/var/folders/fg/qwsnv5p90m5_c4fzvl8fjr6w00000w/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.005136 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 02:01:58.490407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 02:01:58.490970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 02:01:58.491572) ========= ========= Total master_lag: 3.03 =========