builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1488542428.99 results: success (0) buildid: 20170303022539 builduid: 60048d5bfd014674940627324fe7db87 revision: 0d297906afe978a54991613faacbb8e7f99fa88f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:28.988818) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:28.989261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:28.989552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:29.021970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:29.022405) ========= 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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-03 04:00:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2017-03-03 04:00:29 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:29.169804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:29.170114) ========= 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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.028562 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:29.223186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-03 04:00:29.223532) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d297906afe978a54991613faacbb8e7f99fa88f --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 0d297906afe978a54991613faacbb8e7f99fa88f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0ynnzzQbbc/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.C8h7tgt9KV/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-03 04:00:29,334 truncating revision to first 12 chars 2017-03-03 04:00:29,334 Setting DEBUG logging. 2017-03-03 04:00:29,334 attempt 1/10 2017-03-03 04:00:29,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d297906afe9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 04:00:31,321 unpacking tar archive at: mozilla-aurora-0d297906afe9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.246076 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-03 04:00:31.507244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:31.508022) ========= script_repo_revision: 0d297906afe978a54991613faacbb8e7f99fa88f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:31.511886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:31.512489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 04:00:31.534661) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-03 04:00:31.535297) ========= /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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:00:31 INFO - MultiFileLogger online at 20170303 04:00:31 in /builds/slave/test 04:00:31 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 04:00:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:31 INFO - {'append_to_log': False, 04:00:31 INFO - 'base_work_dir': '/builds/slave/test', 04:00:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:00:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:31 INFO - 'branch': 'Mozilla-Aurora', 04:00:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:31 INFO - 'config_files': ('talos/mac_config.py',), 04:00:31 INFO - 'default_actions': ('clobber', 04:00:31 INFO - 'read-buildbot-config', 04:00:31 INFO - 'download-and-extract', 04:00:31 INFO - 'populate-webroot', 04:00:31 INFO - 'create-virtualenv', 04:00:31 INFO - 'install', 04:00:31 INFO - 'run-tests'), 04:00:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:31 INFO - 'download_minidump_stackwalk': True, 04:00:31 INFO - 'download_symbols': 'ondemand', 04:00:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:31 INFO - 'installer_path': 'installer.exe', 04:00:31 INFO - 'log_level': 'info', 04:00:31 INFO - 'log_name': 'talos', 04:00:31 INFO - 'log_to_console': True, 04:00:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:00:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:00:31 INFO - 'opt_config_files': (), 04:00:31 INFO - 'pip_index': False, 04:00:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:00:31 INFO - 'cmd': ('bash', 04:00:31 INFO - '-c', 04:00:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:00:31 INFO - 'enabled': True, 04:00:31 INFO - 'halt_on_failure': False, 04:00:31 INFO - 'name': 'check_screen_resolution'},), 04:00:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:00:31 INFO - 'cmd': ('bash', 04:00:31 INFO - '-c', 04:00:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:00:31 INFO - 'enabled': True, 04:00:31 INFO - 'halt_on_failure': False, 04:00:31 INFO - 'name': 'check_screen_resolution'},), 04:00:31 INFO - 'run_cmd_checks_enabled': True, 04:00:31 INFO - 'sps_profile': False, 04:00:31 INFO - 'sps_profile_interval': 0, 04:00:31 INFO - 'suite': 'dromaeojs', 04:00:31 INFO - 'system_bits': '32', 04:00:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:31 INFO - 'title': 't-yosemite-r7-0192', 04:00:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:31 INFO - 'use_talos_json': True, 04:00:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:31 INFO - 'work_dir': 'build'} 04:00:31 INFO - [mozharness: 2017-03-03 12:00:31.752395Z] Running clobber step. 04:00:31 INFO - Running pre-action listener: _resource_record_pre_action 04:00:31 INFO - Running main action method: clobber 04:00:31 INFO - rmtree: /builds/slave/test/build 04:00:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:36 INFO - Running post-action listener: _resource_record_post_action 04:00:36 INFO - [mozharness: 2017-03-03 12:00:36.000476Z] Finished clobber step (success) 04:00:36 INFO - [mozharness: 2017-03-03 12:00:36.000626Z] Running read-buildbot-config step. 04:00:36 INFO - Running pre-action listener: _resource_record_pre_action 04:00:36 INFO - Running main action method: read_buildbot_config 04:00:36 INFO - Using buildbot properties: 04:00:36 INFO - { 04:00:36 INFO - "project": "", 04:00:36 INFO - "product": "firefox", 04:00:36 INFO - "script_repo_revision": "production", 04:00:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:00:36 INFO - "repository": "", 04:00:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:00:36 INFO - "buildid": "20170303022539", 04:00:36 INFO - "pgo_build": "False", 04:00:36 INFO - "basedir": "/builds/slave/test", 04:00:36 INFO - "buildnumber": 73, 04:00:36 INFO - "slavename": "t-yosemite-r7-0192", 04:00:36 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:00:36 INFO - "platform": "yosemite_r7", 04:00:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:00:36 INFO - "branch": "mozilla-aurora", 04:00:36 INFO - "repo_path": "releases/mozilla-aurora", 04:00:36 INFO - "revision": "0d297906afe978a54991613faacbb8e7f99fa88f", 04:00:36 INFO - "stage_platform": "macosx64", 04:00:36 INFO - "builduid": "60048d5bfd014674940627324fe7db87", 04:00:36 INFO - "slavebuilddir": "test" 04:00:36 INFO - } 04:00:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 04:00:36 INFO - Running post-action listener: _resource_record_post_action 04:00:36 INFO - [mozharness: 2017-03-03 12:00:36.004178Z] Finished read-buildbot-config step (success) 04:00:36 INFO - [mozharness: 2017-03-03 12:00:36.004307Z] Running download-and-extract step. 04:00:36 INFO - Running pre-action listener: _resource_record_pre_action 04:00:36 INFO - Running main action method: download_and_extract 04:00:36 INFO - mkdir: /builds/slave/test/build/tests 04:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:36 INFO - trying https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 04:00:36 INFO - Downloading https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 04:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 04:00:36 INFO - Downloaded 1199 bytes. 04:00:36 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 04:00:36 INFO - Using the following test package requirements: 04:00:36 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 04:00:36 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 04:00:36 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 04:00:36 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'jsshell-mac.zip'], 04:00:36 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 04:00:36 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 04:00:36 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 04:00:36 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 04:00:36 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 04:00:36 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:00:36 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 04:00:36 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:00:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 04:00:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:00:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 04:00:37 INFO - Expected file size: 16357796 04:00:37 INFO - Obtained file size: 16357796 04:00:44 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:00:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 04:00:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:00:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 04:00:45 INFO - Expected file size: 16357796 04:00:45 INFO - Obtained file size: 16357796 04:00:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 04:00:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:00:52 INFO - Fetch https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 04:00:54 INFO - Expected file size: 14403650 04:00:54 INFO - Obtained file size: 14403650 04:00:54 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')]} 04:00:54 INFO - trying https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 04:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 04:00:56 INFO - Downloaded 73907508 bytes. 04:00:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:00:56 INFO - mkdir: /builds/slave/test/properties 04:00:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:56 INFO - Contents: 04:00:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:00:57 INFO - Running post-action listener: _resource_record_post_action 04:00:57 INFO - Running post-action listener: set_extra_try_arguments 04:00:57 INFO - [mozharness: 2017-03-03 12:00:57.197611Z] Finished download-and-extract step (success) 04:00:57 INFO - [mozharness: 2017-03-03 12:00:57.197745Z] Running populate-webroot step. 04:00:57 INFO - Running pre-action listener: _resource_record_pre_action 04:00:57 INFO - Running main action method: populate_webroot 04:00:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:57 INFO - '--tppagecycles', 04:00:57 INFO - '7'], 04:00:57 INFO - 'tests': ['tsvgm']}}, 04:00:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:00:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:00:57 INFO - 'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:00:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:00:57 INFO - 'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['damp', 'tps']}, 04:00:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:00:57 INFO - 'tests': ['damp', 'tps']}, 04:00:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['dromaeo_dom']}, 04:00:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['basic_compositor_video']}, 04:00:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:00:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['a11yr', 04:00:57 INFO - 'ts_paint', 04:00:57 INFO - 'tpaint', 04:00:57 INFO - 'sessionrestore', 04:00:57 INFO - 'sessionrestore_no_auto_restore', 04:00:57 INFO - 'tabpaint']}, 04:00:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:57 INFO - 'ts_paint', 04:00:57 INFO - 'tpaint', 04:00:57 INFO - 'sessionrestore', 04:00:57 INFO - 'sessionrestore_no_auto_restore', 04:00:57 INFO - 'tabpaint']}, 04:00:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:00:57 INFO - 'ts_paint', 04:00:57 INFO - 'tpaint', 04:00:57 INFO - 'sessionrestore', 04:00:57 INFO - 'sessionrestore_no_auto_restore', 04:00:57 INFO - 'tabpaint']}, 04:00:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:00:57 INFO - 'ts_paint', 04:00:57 INFO - 'tpaint', 04:00:57 INFO - 'sessionrestore', 04:00:57 INFO - 'sessionrestore_no_auto_restore', 04:00:57 INFO - 'tabpaint']}, 04:00:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['a11yr', 04:00:57 INFO - 'ts_paint', 04:00:57 INFO - 'tpaint', 04:00:57 INFO - 'sessionrestore', 04:00:57 INFO - 'sessionrestore_no_auto_restore', 04:00:57 INFO - 'tabpaint']}, 04:00:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['a11yr', 04:00:57 INFO - 'ts_paint', 04:00:57 INFO - 'tpaint', 04:00:57 INFO - 'sessionrestore', 04:00:57 INFO - 'sessionrestore_no_auto_restore', 04:00:57 INFO - 'tabpaint']}, 04:00:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['tsvgx', 04:00:57 INFO - 'tsvgr_opacity', 04:00:57 INFO - 'tart', 04:00:57 INFO - 'tscrollx', 04:00:57 INFO - 'cart', 04:00:57 INFO - 'tsvg_static']}, 04:00:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:57 INFO - 'tsvgr_opacity', 04:00:57 INFO - 'tart', 04:00:57 INFO - 'tscrollx', 04:00:57 INFO - 'cart', 04:00:57 INFO - 'tsvg_static']}, 04:00:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:00:57 INFO - 'talos_options': ['--disable-e10s'], 04:00:57 INFO - 'tests': ['tp5o']}, 04:00:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:00:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:00:57 INFO - 'talos_options': ['--disable-e10s', 04:00:57 INFO - '--xperf_path', 04:00:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:57 INFO - 'tests': ['tp5n']}, 04:00:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:00:57 INFO - 'talos_options': ['--xperf_path', 04:00:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:57 INFO - 'tests': ['tp5n']}}, 04:00:57 INFO - 'talos.zip': {'path': '', 04:00:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:57 INFO - Running post-action listener: _resource_record_post_action 04:00:57 INFO - [mozharness: 2017-03-03 12:00:57.216283Z] Finished populate-webroot step (success) 04:00:57 INFO - [mozharness: 2017-03-03 12:00:57.216393Z] Running create-virtualenv step. 04:00:57 INFO - Running pre-action listener: _resource_record_pre_action 04:00:57 INFO - Running main action method: create_virtualenv 04:00:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:57 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 04:00:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:57 INFO - Using real prefix '/tools/python27' 04:00:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:00 INFO - Installing pip.................done. 04:01:00 INFO - Return code: 0 04:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:01:01 INFO - Reading from file tmpfile_stdout 04:01:01 INFO - Output received: 04:01:01 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) 04:01:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:01 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')]} 04:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:01 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')]} 04:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:01 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:01 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 04:01:01 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 04:01:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:01 INFO - 'HOME': '/Users/cltbld', 04:01:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:01 INFO - 'LOGNAME': 'cltbld', 04:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:01 INFO - 'MOZ_NO_REMOTE': '1', 04:01:01 INFO - 'NO_EM_RESTART': '1', 04:01:01 INFO - 'PAGER': '/bin/cat', 04:01:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:01 INFO - 'PWD': '/builds/slave/test', 04:01:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:01 INFO - 'SHELL': '/bin/bash', 04:01:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:01 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:01 INFO - 'USER': 'cltbld', 04:01:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:01 INFO - 'XPC_FLAGS': '0x0', 04:01:01 INFO - 'XPC_SERVICE_NAME': '0', 04:01:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:01 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 04:01:01 INFO - Cleaning up... 04:01:01 INFO - Return code: 0 04:01:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:01:01 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')]} 04:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:01 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')]} 04:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:01 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:01 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 04:01:01 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 04:01:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:01 INFO - 'HOME': '/Users/cltbld', 04:01:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:01 INFO - 'LOGNAME': 'cltbld', 04:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:01 INFO - 'MOZ_NO_REMOTE': '1', 04:01:01 INFO - 'NO_EM_RESTART': '1', 04:01:01 INFO - 'PAGER': '/bin/cat', 04:01:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:01 INFO - 'PWD': '/builds/slave/test', 04:01:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:01 INFO - 'SHELL': '/bin/bash', 04:01:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:01 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:01 INFO - 'USER': 'cltbld', 04:01:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:01 INFO - 'XPC_FLAGS': '0x0', 04:01:01 INFO - 'XPC_SERVICE_NAME': '0', 04:01:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:01 INFO - Downloading/unpacking psutil>=3.1.1 04:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:05 INFO - Installing collected packages: psutil 04:01:05 INFO - Running setup.py install for psutil 04:01:05 INFO - building 'psutil._psutil_osx' extension 04:01:05 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 04:01:05 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 04:01:06 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 04:01:06 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 04:01:06 INFO - building 'psutil._psutil_posix' extension 04:01:06 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 04:01:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:01:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:01:06 INFO - ^ 04:01:06 INFO - 1 warning generated. 04:01:06 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 04:01:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:06 INFO - Successfully installed psutil 04:01:06 INFO - Cleaning up... 04:01:06 INFO - Return code: 0 04:01:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:06 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:06 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 04:01:06 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 04:01:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:06 INFO - 'HOME': '/Users/cltbld', 04:01:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:06 INFO - 'LOGNAME': 'cltbld', 04:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:06 INFO - 'MOZ_NO_REMOTE': '1', 04:01:06 INFO - 'NO_EM_RESTART': '1', 04:01:06 INFO - 'PAGER': '/bin/cat', 04:01:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:06 INFO - 'PWD': '/builds/slave/test', 04:01:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:06 INFO - 'SHELL': '/bin/bash', 04:01:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:06 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:06 INFO - 'USER': 'cltbld', 04:01:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:06 INFO - 'XPC_FLAGS': '0x0', 04:01:06 INFO - 'XPC_SERVICE_NAME': '0', 04:01:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 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 04:01:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:01:09 INFO - Installing collected packages: mozsystemmonitor 04:01:09 INFO - Running setup.py install for mozsystemmonitor 04:01:09 INFO - Successfully installed mozsystemmonitor 04:01:09 INFO - Cleaning up... 04:01:09 INFO - Return code: 0 04:01:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:01:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:09 INFO - 'HOME': '/Users/cltbld', 04:01:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:09 INFO - 'LOGNAME': 'cltbld', 04:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:09 INFO - 'MOZ_NO_REMOTE': '1', 04:01:09 INFO - 'NO_EM_RESTART': '1', 04:01:09 INFO - 'PAGER': '/bin/cat', 04:01:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:09 INFO - 'PWD': '/builds/slave/test', 04:01:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:09 INFO - 'SHELL': '/bin/bash', 04:01:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:09 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:09 INFO - 'USER': 'cltbld', 04:01:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:09 INFO - 'XPC_FLAGS': '0x0', 04:01:09 INFO - 'XPC_SERVICE_NAME': '0', 04:01:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:10 INFO - Downloading/unpacking jsonschema==2.5.1 04:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:01:12 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 04:01:12 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 04:01:12 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 04:01:12 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 04:01:12 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 04:01:12 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 04:01:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:13 INFO - warning: no files found matching '*.txt' 04:01:13 INFO - no previously-included directories found matching 'build' 04:01:13 INFO - no previously-included directories found matching 'dist' 04:01:13 INFO - no previously-included directories found matching '.git*' 04:01:13 INFO - Installing collected packages: jsonschema, functools32 04:01:13 INFO - Running setup.py install for functools32 04:01:13 INFO - warning: no files found matching '*.txt' 04:01:13 INFO - no previously-included directories found matching 'build' 04:01:13 INFO - no previously-included directories found matching 'dist' 04:01:13 INFO - no previously-included directories found matching '.git*' 04:01:13 INFO - Successfully installed jsonschema functools32 04:01:13 INFO - Cleaning up... 04:01:13 INFO - Return code: 0 04:01:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:01:13 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')]} 04:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:13 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')]} 04:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:13 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:13 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 04:01:13 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 04:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:13 INFO - 'HOME': '/Users/cltbld', 04:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:13 INFO - 'LOGNAME': 'cltbld', 04:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:13 INFO - 'MOZ_NO_REMOTE': '1', 04:01:13 INFO - 'NO_EM_RESTART': '1', 04:01:13 INFO - 'PAGER': '/bin/cat', 04:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:13 INFO - 'PWD': '/builds/slave/test', 04:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:13 INFO - 'SHELL': '/bin/bash', 04:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:13 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:13 INFO - 'USER': 'cltbld', 04:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:13 INFO - 'XPC_FLAGS': '0x0', 04:01:13 INFO - 'XPC_SERVICE_NAME': '0', 04:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:01:13 INFO - Cleaning up... 04:01:13 INFO - Return code: 0 04:01:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:13 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')]} 04:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:13 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')]} 04:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:13 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:13 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 04:01:13 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 04:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:13 INFO - 'HOME': '/Users/cltbld', 04:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:13 INFO - 'LOGNAME': 'cltbld', 04:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:13 INFO - 'MOZ_NO_REMOTE': '1', 04:01:13 INFO - 'NO_EM_RESTART': '1', 04:01:13 INFO - 'PAGER': '/bin/cat', 04:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:13 INFO - 'PWD': '/builds/slave/test', 04:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:13 INFO - 'SHELL': '/bin/bash', 04:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:13 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:13 INFO - 'USER': 'cltbld', 04:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:13 INFO - 'XPC_FLAGS': '0x0', 04:01:13 INFO - 'XPC_SERVICE_NAME': '0', 04:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:17 INFO - Downloading docopt-0.6.1.tar.gz 04:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:17 INFO - Running setup.py install for blobuploader 04:01:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:17 INFO - Running setup.py install for requests 04:01:18 INFO - Running setup.py install for docopt 04:01:18 INFO - Successfully installed blobuploader requests docopt 04:01:18 INFO - Cleaning up... 04:01:18 INFO - Return code: 0 04:01:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:18 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')]} 04:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:18 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')]} 04:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:18 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:18 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 04:01:18 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 04:01:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:18 INFO - 'HOME': '/Users/cltbld', 04:01:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:18 INFO - 'LOGNAME': 'cltbld', 04:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:18 INFO - 'MOZ_NO_REMOTE': '1', 04:01:18 INFO - 'NO_EM_RESTART': '1', 04:01:18 INFO - 'PAGER': '/bin/cat', 04:01:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:18 INFO - 'PWD': '/builds/slave/test', 04:01:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:18 INFO - 'SHELL': '/bin/bash', 04:01:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:18 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:18 INFO - 'USER': 'cltbld', 04:01:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:18 INFO - 'XPC_FLAGS': '0x0', 04:01:18 INFO - 'XPC_SERVICE_NAME': '0', 04:01:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:18 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Xphmub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-veOLdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-RxFRyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ys0stg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-RaE2_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3oR8fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-rmr4rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-0pgCLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-vCjLhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:19 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xRJeja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:20 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-YnE2Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:20 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-NUc578-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:20 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-wKzlA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:20 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-hERc0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:20 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-FWTAE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:20 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ndklYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:20 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-8L9Rho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:20 INFO - Running setup.py install for manifestparser 04:01:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Running setup.py install for mozcrash 04:01:21 INFO - Running setup.py install for mozdebug 04:01:21 INFO - Running setup.py install for mozdevice 04:01:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Running setup.py install for mozfile 04:01:21 INFO - Running setup.py install for mozhttpd 04:01:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Running setup.py install for mozinfo 04:01:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Running setup.py install for mozInstall 04:01:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Running setup.py install for mozleak 04:01:22 INFO - Running setup.py install for mozlog 04:01:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:22 INFO - Running setup.py install for moznetwork 04:01:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:22 INFO - Running setup.py install for mozprocess 04:01:22 INFO - Running setup.py install for mozprofile 04:01:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:22 INFO - Running setup.py install for mozrunner 04:01:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:22 INFO - Running setup.py install for mozscreenshot 04:01:23 INFO - Running setup.py install for moztest 04:01:23 INFO - Running setup.py install for mozversion 04:01:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:23 INFO - Cleaning up... 04:01:23 INFO - Return code: 0 04:01:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:23 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')]} 04:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:23 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')]} 04:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:24 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:24 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 04:01:24 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 04:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:24 INFO - 'HOME': '/Users/cltbld', 04:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:24 INFO - 'LOGNAME': 'cltbld', 04:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:24 INFO - 'MOZ_NO_REMOTE': '1', 04:01:24 INFO - 'NO_EM_RESTART': '1', 04:01:24 INFO - 'PAGER': '/bin/cat', 04:01:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:24 INFO - 'PWD': '/builds/slave/test', 04:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:24 INFO - 'SHELL': '/bin/bash', 04:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:24 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:24 INFO - 'USER': 'cltbld', 04:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:24 INFO - 'XPC_FLAGS': '0x0', 04:01:24 INFO - 'XPC_SERVICE_NAME': '0', 04:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:24 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-PHud2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:24 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)) 04:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:24 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ADaK6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:24 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)) 04:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:24 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-aI0xzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:24 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)) 04:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:24 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-X_NYcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:24 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)) 04:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:24 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1wASMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:24 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)) 04:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:24 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-E49wiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-XlSfw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-AYoL6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-nltieT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-0ipm2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-UiEy3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-fo3cQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-WLJBoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HmN0Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:25 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)) 04:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-JghZqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:26 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)) 04:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-laH3wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:26 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)) 04:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-N3iOfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:26 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)) 04:01:26 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)) 04:01:26 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)) 04:01:26 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)) 04:01:26 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)) 04:01:26 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)) 04:01:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:29 INFO - Downloading blessings-1.6.tar.gz 04:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:29 INFO - Installing collected packages: blessings 04:01:29 INFO - Running setup.py install for blessings 04:01:29 INFO - Successfully installed blessings 04:01:29 INFO - Cleaning up... 04:01:29 INFO - Return code: 0 04:01:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:29 INFO - Reading from file tmpfile_stdout 04:01:29 INFO - Current package versions: 04:01:29 INFO - blessings == 1.6 04:01:29 INFO - blobuploader == 1.2.4 04:01:29 INFO - docopt == 0.6.1 04:01:29 INFO - functools32 == 3.2.3-2 04:01:29 INFO - jsonschema == 2.5.1 04:01:29 INFO - manifestparser == 1.1 04:01:29 INFO - mozInstall == 1.12 04:01:29 INFO - mozcrash == 1.0 04:01:29 INFO - mozdebug == 0.1 04:01:29 INFO - mozdevice == 0.49 04:01:29 INFO - mozfile == 1.2 04:01:29 INFO - mozhttpd == 0.7 04:01:29 INFO - mozinfo == 0.9 04:01:29 INFO - mozleak == 0.1 04:01:29 INFO - mozlog == 3.4 04:01:29 INFO - moznetwork == 0.27 04:01:29 INFO - mozprocess == 0.24 04:01:29 INFO - mozprofile == 0.28 04:01:29 INFO - mozrunner == 6.13 04:01:29 INFO - mozscreenshot == 0.1 04:01:29 INFO - mozsystemmonitor == 0.3 04:01:29 INFO - moztest == 0.8 04:01:29 INFO - mozversion == 1.4 04:01:29 INFO - psutil == 3.1.1 04:01:29 INFO - requests == 1.2.3 04:01:29 INFO - wsgiref == 0.1.2 04:01:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:29 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 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:29 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 04:01:29 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 04:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:29 INFO - 'HOME': '/Users/cltbld', 04:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:29 INFO - 'LOGNAME': 'cltbld', 04:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:29 INFO - 'MOZ_NO_REMOTE': '1', 04:01:29 INFO - 'NO_EM_RESTART': '1', 04:01:29 INFO - 'PAGER': '/bin/cat', 04:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:29 INFO - 'PWD': '/builds/slave/test', 04:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:29 INFO - 'SHELL': '/bin/bash', 04:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:29 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:29 INFO - 'USER': 'cltbld', 04:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:29 INFO - 'XPC_FLAGS': '0x0', 04:01:29 INFO - 'XPC_SERVICE_NAME': '0', 04:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 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)) 04:01:30 INFO - Cleaning up... 04:01:30 INFO - Return code: 0 04:01:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1058ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9ca2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, '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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 04:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:30 INFO - 'HOME': '/Users/cltbld', 04:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:30 INFO - 'LOGNAME': 'cltbld', 04:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:30 INFO - 'MOZ_NO_REMOTE': '1', 04:01:30 INFO - 'NO_EM_RESTART': '1', 04:01:30 INFO - 'PAGER': '/bin/cat', 04:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:30 INFO - 'PWD': '/builds/slave/test', 04:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:30 INFO - 'SHELL': '/bin/bash', 04:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:30 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:30 INFO - 'USER': 'cltbld', 04:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:30 INFO - 'XPC_FLAGS': '0x0', 04:01:30 INFO - 'XPC_SERVICE_NAME': '0', 04:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:01:30 INFO - Cleaning up... 04:01:30 INFO - Return code: 0 04:01:30 INFO - Running post-action listener: _resource_record_post_action 04:01:30 INFO - Running post-action listener: _start_resource_monitoring 04:01:30 INFO - Starting resource monitoring. 04:01:30 INFO - [mozharness: 2017-03-03 12:01:30.374801Z] Finished create-virtualenv step (success) 04:01:30 INFO - [mozharness: 2017-03-03 12:01:30.375739Z] Running install step. 04:01:30 INFO - Running pre-action listener: _resource_record_pre_action 04:01:30 INFO - Running main action method: install 04:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:30 INFO - Reading from file tmpfile_stdout 04:01:30 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:30 INFO - Reading from file tmpfile_stdout 04:01:30 INFO - Output received: 04:01:30 INFO - Usage: mozinstall [options] installer 04:01:30 INFO - Options: 04:01:30 INFO - -h, --help show this help message and exit 04:01:30 INFO - -d DEST, --destination=DEST 04:01:30 INFO - Directory to install application into. [default: 04:01:30 INFO - "/builds/slave/test"] 04:01:30 INFO - --app=APP Application being installed. [default: firefox] 04:01:30 INFO - mkdir: /builds/slave/test/build/application 04:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:01:50 INFO - Reading from file tmpfile_stdout 04:01:50 INFO - Output received: 04:01:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - [mozharness: 2017-03-03 12:01:50.510545Z] Finished install step (success) 04:01:50 INFO - [mozharness: 2017-03-03 12:01:50.510686Z] Running run-tests step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: run_tests 04:01:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:01:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:01:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:01:50 INFO - 2017-03-03 04:01:50.525 screenresolution[1623:7324] starting screenresolution argv=screenresolution get 04:01:50 INFO - 2017-03-03 04:01:50.528 screenresolution[1623:7324] Display 0: 1600x1200x32@60 04:01:50 INFO - 2017-03-03 04:01:50.533 screenresolution[1624:7327] starting screenresolution argv=screenresolution list 04:01:50 INFO - Available Modes on Display 0 04:01:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:01:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:01:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:01:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:01:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:01:50 INFO - Intel Iris: 04:01:50 INFO - Chipset Model: Intel Iris 04:01:50 INFO - Type: GPU 04:01:50 INFO - Bus: Built-In 04:01:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:01:50 INFO - Vendor: Intel (0x8086) 04:01:50 INFO - Device ID: 0x0a2e 04:01:50 INFO - Revision ID: 0x0009 04:01:50 INFO - Displays: 04:01:50 INFO - Display: 04:01:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:01:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:01:50 INFO - Display Serial Number: 1600x1200 60 04:01:50 INFO - Main Display: Yes 04:01:50 INFO - Mirror: Off 04:01:50 INFO - Online: Yes 04:01:50 INFO - Rotation: Supported 04:01:50 INFO - Return code: 0 04:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:50 INFO - Python 2.7.3 04:01:50 INFO - Return code: 0 04:01:50 INFO - grabbing minidump binary from tooltool 04:01:50 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')]} 04:01:50 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 0x1056aad30>, '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 0x1055d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:50 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 04:01:50 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 04:01:50 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 04:01:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:50 INFO - Return code: 0 04:01:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:01:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:01:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:50 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/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 04:01:50 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/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --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 04:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ynnzzQbbc/Render', 04:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:50 INFO - 'HOME': '/Users/cltbld', 04:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:50 INFO - 'LOGNAME': 'cltbld', 04:01:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:50 INFO - 'MOZ_NO_REMOTE': '1', 04:01:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:50 INFO - 'NO_EM_RESTART': '1', 04:01:50 INFO - 'PAGER': '/bin/cat', 04:01:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:50 INFO - 'PWD': '/builds/slave/test', 04:01:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:50 INFO - 'SHELL': '/bin/bash', 04:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C8h7tgt9KV/Listeners', 04:01:50 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 04:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:50 INFO - 'USER': 'cltbld', 04:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:50 INFO - 'XPC_FLAGS': '0x0', 04:01:50 INFO - 'XPC_SERVICE_NAME': '0', 04:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:50 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/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 04:01:51 INFO - mozversion application_buildid: 20170303022539 04:01:51 INFO - mozversion application_changeset: 0d297906afe978a54991613faacbb8e7f99fa88f 04:01:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:01:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:51 INFO - mozversion application_name: Firefox 04:01:51 INFO - mozversion application_remotingname: firefox-dev 04:01:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:01:51 INFO - mozversion application_vendor: Mozilla 04:01:51 INFO - mozversion application_version: 53.0a2 04:01:51 INFO - mozversion platform_buildid: 20170303022539 04:01:51 INFO - mozversion platform_changeset: 0d297906afe978a54991613faacbb8e7f99fa88f 04:01:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:01:51 INFO - mozversion platform_version: 53.0a2 04:01:51 INFO - using testdate: 1488542511 04:01:51 INFO - actual date: 1488542511 04:01:51 INFO - starting webserver on 'localhost:49244' 04:01:51 INFO - SUITE-START | Running 2 tests 04:01:51 INFO - TEST-START | dromaeo_css 04:01:51 INFO - operating with platform_type : mac_ 04:01:51 INFO - Initialising browser for dromaeo_css test... 04:01:51 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpgEgWLr/profile http://localhost:49244/getInfo.html) 04:01:53 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 04:01:53 INFO - PROCESS | 1634 | colorDepth:24 04:01:53 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 04:01:53 INFO - PROCESS | 1634 | __metrics 04:01:53 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:01:53 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:01:54 INFO - TEST-INFO | 1634: exit 0 04:01:54 INFO - Browser initialized. 04:01:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:54 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpgEgWLr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:06 INFO - PROCESS | 1636 | RSS: Main: 212430848 04:02:06 INFO - PROCESS | 1636 | 04:05:10 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 04:05:11 INFO - PROCESS | 1636 | RSS: Main: 344129536 04:05:11 INFO - PROCESS | 1636 | 04:06:56 INFO - PROCESS | 1636 | ************************* 04:06:56 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 04:06:56 INFO - PROCESS | 1636 | 04:06:56 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:06:56 INFO - PROCESS | 1636 | Full stack: 04:06:56 INFO - PROCESS | 1636 | ************************* 04:08:14 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:08:15 INFO - PROCESS | 1636 | RSS: Main: 361619456 04:08:15 INFO - PROCESS | 1636 | 04:11:17 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 04:11:18 INFO - PROCESS | 1636 | RSS: Main: 346443776 04:11:18 INFO - PROCESS | 1636 | 04:14:20 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 04:14:21 INFO - PROCESS | 1636 | RSS: Main: 336461824 04:14:21 INFO - PROCESS | 1636 | 04:17:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 04:17:25 INFO - PROCESS | 1636 | RSS: Main: 312213504 04:17:25 INFO - PROCESS | 1636 | 04:20:28 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 04:20:29 INFO - PROCESS | 1636 | RSS: Main: 366698496 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | __start_tp_report 04:20:29 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 04:20:29 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 04:20:29 INFO - PROCESS | 1636 | |i|pagename|runs| 04:20:29 INFO - PROCESS | 1636 | |0;dojo.html;3300.438925382685;3308.3383323335333;3321.684439978201;3322.800631962081;3378.223008707997;5579.609427340088;5609.214709940607;5639.097744360903;5649.915251271234;5659.801906933259;4949.52979466951;5150.407703114143;5594.468525490082;5598.076317407623;5646;5152.768125434355;5177.508136727005;5217.713025783581;5253.290805741233;5336.759845806929;4883.804647814101;5099.949000509984;5104.489551044903;5107.719075450848;5228.5555727763185;5136.409312929005;5171.715555644438;5184.974075129638;5202.973985130088;5227.111391063529;4330.956690433102;5230.921536176922;5232.607554433433;5240.97800928819;5287.048331300364;4958.776855041532;4995.825146119904;5159.251908473288;5172.482751724835;5194.4026436959475;5525.033119204123;5542.86142846428;5545.584081193927;5549.38956714761;5552;6121.523955630164;6181.443670069715;6192.504599632019;6201.472874805647;6257.311695713468;5431.755570999315;6257.5619706620555;6292.811215663537;6314.936850631527;6323.715432805535;5271.525562699337;5625.184348269478;5710.8001219957105;5803.187553742479;5803.738831752581;6242.5942313749465;6246.593971391845;6260.530460215411;6299.779507717208;6315.684215789192;6150.938490615126;6160.44555989963;6160.476359509492;6176.135341052166;6180.227471566054;6194.163787888668;6271.6550589718;6280.120783090371;6289.276733175652;6296.464800491918;6067.575269731165;6088.6042407243385;6122.011845520044;6168.845778855564;6187.938120618736;6271.278802937721;6271.749130034747;6275.090111933744;6288.119663247149;6291.55959082869;4991.575716064175;4992.375953005874;4998.625103117281;4998.850034498971;5007.774650140753;4332.9133417332105;4339.500957389878;4365.3670217818235;4382.780860957003;4445.51099379068;5720.8283751487525;5721.942780572141;5777.971110144423;5781.5952883298605;5826.766929322865;6056.788012419633;6270.6864656766975;6279.215098112736;6299.244090709144;6306.905396419057;5616.157576363578;5626.212330273765;5670.121131224667;5681.801136960186;5692.516136128475;5339.252504649352;5340.893182136336;5344.786208551614;5348.8662783429945;5353.866153346197;6201.441870231701;6269.905951410824;6332.303446620868;6334.208223972004;6341.207349081365;6208.658523781235;6250.968745156245;6255.124282600348;6264.342244064308;6267.655278959519;5905.5570832186895;5978.730957106854;6244.562880598314;6282.968585157045;6283.685815709287;4929.359183306147;6026;6026.186464827192;6170.5372097092;6175.84560385994;6157.96921015392;6159.630422174684;6165.691715414122;6270.623762574261;6292.842678933063;5861.9413805863105;5892.381299963442;5940.28716553999;5983.282006159288;6042;5796.362400135898;5926.762929482772;6029.758809647565;6035.064564992434;6041.818745437644;4931.309616653743;4988.251762235694;5715.685637289989;5781.479666830005;5832.300123985149;4977.427595826526;5827.096799996008;5971.104334349882;6015.879682406415;6074.605150665193;5890.764369425175;5891.646501209942;5895.02732049207;5905.645661260338;5908.438698323653 04:20:29 INFO - PROCESS | 1636 | |1;ext.html;426.58408052149156;476.25466145482307;477.73485715427944;507.43421085489643;513.0585375835342;26272.605910911352;41471;43312.91717707055;43374.91562710934;45448.86377840555;44269.11461770763;44683;44757;44978.550214497925;46099.53900461003;7635.770926872203;9518.381305215173;9520.809583808319;9545.14093731564;9551.761205969837;8403.201695838885;8618.439801412887;8627.698030568932;8696.913030869706;8703.43427677199;11215.551377944872;11474.139439542068;11485.0811935045;11631;11650.6504804856;11270.492827822767;11306.773864522664;11397.430128493543;11486.597969071043;11516.963473287402;8433.746987590383;11363.375014374205;11406.657800266004;11410.657680269605;11424.42877856104;32662.346753064805;36270.45594316087;40812.795936020426;41779.74660760182;43677.908052298626;3912.15888583953;3953.991732108294;3961.2473630010204;3967.107400834818;4062.984253936516;30111.247218819484;31372.372552549048;31862.840685796655;32272.031839044867;32701.345973080643;3128.358686469291;3194.2493514024186;3248.2204270974794;3273.770836041478;3277.983610081958;499248.5037574825;501316;502233;502465.99999999633;502575;64911.67544162249;65355;65405.69188616296;65433;65498;70065;70189.64905175442;70233;70254;70288;16727.91636041812;16995;17011.914940425468;17059.573510662085;17073.231704573325;13024.804627930589;13100.934495327463;13117.803232951514;13125.67185820343;13133.408996595175;15704.29330680122;16081.839181608268;16913.7462938056;18310.81689183118;18343;6300.59046161998;6768.492363072789;7761.7671469855995;7808.687652493837;7811.375089992787;854.769212312672;867.2151702709058;876.7895705030746;881.4134557795942;902.4675441489553;30389.848050760047;30608.54087188694;30626.54060189099;30881.912108555363;31035.534466983012;1052.4527245832123;1059.0838924330399;1093.6992327110108;1102.3165637304762;1214.1804282109717;15575.844241557666;15790.921045394929;15829.287682054335;16164.676706465805;16281.837181628032;632343;636208;637350;637670.8116459388;638871;63417.048744268875;63464.04803927945;63517.36482635114;63562.36437635565;63588.68205659035;1388.9861101388856;1438.0652575825798;1450.6155868694593;1462.2834810942775;1464.978025329621;29340.853295733385;30668;32585.674143258264;32856.67143328536;32882.67117328796;62454;67471.66264168647;67530.64938701296;67685.27730974843;67864.3213567858;607451;616059.9197003986;616290;616539;617740;45743;46115.538844611125;46165.30752038789;47121.76439117782;47188.76405618087;37438.8128059358;44452.777736111115;51494.22758658698;51592;52239.47760522498;36562.08594785152;40579.782606521854;41294;41438.171236575705;42894.57105428906;41252.38121428241;41260.79369603253;41432.58567414287;43240.56759432366;43392.349114763936;33733;37405.01236701762;39234.01914952035;39377.21245575015;40910.59089409187;31000.534991974688;35792.46311305385;36441.63558364382;36610.45084323684;36741.26517469689;24043.797810109776;24416.87791561031;25740.871295643403;26222.737772622793;26800.463990720466 04:20:29 INFO - PROCESS | 1636 | |2;jquery.html;388.50077650219464;393.5297319702956;394.8361430006547;405.4404921208732;423.5383432059055;13309.600711978655;18920;20905;21258.681119783196;21299.57400851984;21556.245531406403;21683.349499515;21892.671609925823;22127.668084978697;22479.438014049658;5787.421257874211;6071.78748743794;6150.907736383958;6151.384861513835;6170.598911070789;5822.883542329151;6013;6023.277206735198;6041.9697901510435;6103.084537319393;6023.307319658252;6024.246969128859;6033.125196846455;6034;6035.185249991261;5836.2121113649755;6004.309504406983;6035.185249991261;6102.054181601814;6164.075388691687;6070.271567411939;6078.209832721718;6094.695265236721;6095.939040609582;6098.512119030512;13520.053596248266;13736.450541978309;23620;25848.09531666383;27110.051148209717;2906.9854650726825;2908.127561731493;2942.264433891527;2958.2456473599095;3005.443992861306;7368.705251789922;9550.235981121494;9938.900610993942;10127.746806329827;10193.133583645398;1825.9908700456544;1864.1424944525534;1865.32848174657;1874.7469091672585;1877.5493881468349;97507.02492975122;118164.40917795443;127946;128015;135411.64588354088;9665.71002869915;11687.181897267279;11851.46668399924;11903.166778325607;12055.397230138458;12155.817662735066;13742.244176570384;14443.133411995314;15609.531714048597;15619.3752249911;8181.509109453452;8528.872066919;8739.169778870997;8858.689945851864;8896.377253592187;8734.917389130158;8806.86789698155;8811.251043661232;8912.287017038621;9009.774755631162;4771.045790841846;4776.59398951093;4791.448983366888;4797.280407938837;4839.153148199051;1719.7678313427527;1752.6319472910832;2033.176563491788;2038.4190505705803;2039.2964427272568;964.6816550538306;975.6390135649713;976.4483067067084;982.6806287956442;1026.2457094035879;17154.828451715322;20486.282980095624;20730.274440394816;21458.24896128628;21579.892100539397;991.4002028772633;993.5082134343546;1014.4876837197169;1019.7858449725493;1020.6733845169623;8424.410291279552;10819.78360432787;11094.778104438028;11268;12513.812292815615;783962;787359;788672;794278;812448;161954;167364;167771;170931.1453442725;172628.27371726374;912.3066469483241;1035.8239099353127;1078.757279612081;1082.7780305037447;1083.4203701020074;20217.89891050535;20466.692999605315;20815.583688326453;20992.895035524725;21092;59936.14565585627;61242;64039.679801600694;64554.67722661357;65770.67114664396;95242.04757952332;96681;97135.57161071029;99475;100106;7105.50261481712;8113.553754543321;8366.790830229293;8601.655933762579;8620.396572239883;12287.56993505223;12862.67843303925;12958.352082396032;13323.933380333036;13562;11114.22200445961;11269.830952535882;11317.603883864025;11418.828717569077;11506.597269095542;11260.268082574607;11467.827982580435;11484.253523520945;11773.234739741889;11796.76406471883;9882.901170988198;11244.662660119882;11263.324200547993;11620.593279235187;11657.76684466289;6688.197416310074;6850.794476165723;7249.420046396381;7306.648270070054;8770.605322760364;8377.70678026266;11308.886911130783;11445.484953177294;11450.713732156762;11753.177277590486 04:20:29 INFO - PROCESS | 1636 | |3;mootools.html;1429.442517418207;1443.559714287142;1444.5449683349746;1452.4408102880388;1455.6433673749932;8004.279614834663;8462.66149354026;8468.44955077921;8478;8487.618057187434;6899.793006209809;7279.381252593523;7551.244875512446;7939.404544659159;8157.673693052286;2276.7040284762998;2282.1556024271044;2315.9925432436858;2319.5360927814504;2319.698439202901;2091.853570250083;2292.6446400807818;2322.988385058081;2334.428065124047;2339.146211632759;2035.8065983731522;2106.2522804404443;2220.600291947449;2282.018731945263;2298.2530677529785;2301.9654705179437;2306.077568972408;2307;2309.919152829643;2315.4211447138214;2213.4023813570407;2246.550689862018;2331.4754180309465;2332.195392589554;2333.57995560799;8272.503649781032;8358.958205208995;8366.748997530083;8371.204735550113;8403.663853445854;4990.775415106293;5153.510416510426;5156.149235376159;5158.045761534128;5163.974180129113;3275.4431746602895;3423.589169299675;3430.6397828227928;3483.6864682178725;3493.965060349389;1136.7044568412189;1179.8466199394109;1183.2190754102337;1228.2384921348732;1229.7479016801624;10689.679309620724;10742.570297188104;10795.29830561011;10817.513211905483;10837.512311945982;4409.559044095629;4571.657125715585;4628.39830821991;4647.9781295136045;4655.255159174516;9409.294302927308;9415.576299066559;9437.150656440816;9455.76360590977;9479.431234125837;5208.661437006658;5214.661047031931;5215.6609820361555;5218.452062533379;5219.634625576249;4216.346466297668;4340.848070317524;4444.911101778011;4693.78877950493;4772.832950846704;3747.4191500317493;3780.5652349979555;3886.7084968627464;3891.2412079644196;3921.352976758803;1263.0842639086588;1284.1588759362446;1285.1429684106376;1293.5731208701106;1294.1458637299338;781.7263957614903;862;902.8894459814466;923.2706162131975;957.5499515227832;5352.759125839347;5576.1356989666665;5639.492445679908;5801.245838041112;5833.970830145822;1005.8893521712606;1006.5168719014914;1014.8477728340808;1021.6934919524113;1040.0119886108228;3605.3330133924783;3658.9451158232646;3724.7020238380865;3747.569029561581;3868.052327179803;9589.760255993657;9921.355111917703;9925.553350099262;9933;9988.850167247498;9786.657466988621;9866.358686685342;9886.95056524727;9891.752706182404;9893.950530247446;6442.9355706443275;7369.484136110528;7738.729144479917;7869.488483248685;7897.131315555284;5541.944580554304;5659.830205093854;5708.4862362387585;5743.0811070228565;5766.106253530709;8619.956900215459;9011.594478248364;9047.547622618711;9198.448093114435;9322.627094916128;9236.07511662223;9293.814123717622;9387;9418.529073546159;9453.95273023658;6550;6762.898556521558;7060.364567188978;7247.311505406978;7255.709771609077;7508.136564294958;7635.503692259986;7812.218778122142;7890.092639346549;7984.760457186294;6079;6989.930100698928;7064.752733654297;7075.408033192491;7090.07828982229;6903.344182302673;6935.618540980295;6939.653017349011;6977.895331569929;7007.264237255014;6299.055141728594;6312.2740884796995;6339.2392912850755;6420.165378500765;6421.5504914657395;4851.102546028996;4870.975645121752;4907.877303067452;4971.627127965345;4990.900181996412;4860.3681521401995;4876.829310974099;4966.602671786176;5020.49795020495;5030.84907452777 04:20:29 INFO - PROCESS | 1636 | |4;prototype.html;352.33408857259775;358.1922764166805;359.3137108123484;375.11472923899595;378.4625831319526;4174.269502837003;5192.92210616841;5205.453427390122;5245.947540524594;5259.079661059319;4832.9275060874115;4885.413750349954;4960.826371077013;5043.85636104655;5074.467180946003;3426.623071462137;3613.981930090359;4057.1885622875398;4100.077482566428;4105.958940410603;4023.879283621496;4048.3320252158505;4102.712810103294;4114.588541145891;4119.732217405859;3464.9703865336614;3550.325438166753;3816.3017457231545;3950.822213000422;4066.6746660267254;3680.926381472382;4030.0730831908827;4038;4050.41269015991;4054.8580799672163;3119.845657106885;3529.8411571479346;3584.2473080653094;3609.729270304738;3610.097475631092;3569.8837053205116;4670.734693673566;4956.107900577895;5024.974875125601;5070.442251352349;4613;4624.768761561909;4710.788014539354;4726.881827954294;4752.906831428756;4718.764061796896;5322.547583455411;5474.945250547523;5518.813455107131;5540.750666219989;3998.5009369144286;4011.799410029487;4023.5574086850424;4025.9597404025876;4042.919141617151;4396.296592545209;4799;5212.921806172911;5582;5702.914456283159;4073.124278280184;4075.166175221162;4081.367453018757;4090.447789548373;4106.055607210358;4138.317177665652;4140.834366625361;4174.666026717916;4196.643285320721;4197.580241975778;3981.6814654827544;4395.340698895191;4595.954040459553;4681.765911704401;4765;4490.236659767847;4525.434320709911;5492.340919089735;5497.642653227527;5512.448755124536;1184.8222766585081;1210.9767246676545;1224.1186345830988;1350.9054366194273;1354.4897439355047;901.7475106970059;906.7305771919366;926.7219834049893;946.5693109635099;947.1570302430843;4142.005918579519;4475.395821564047;4533.52397998212;4857.562819346276;4872.975635121873;4673.345731597579;4888.780004899788;5207.583393328525;5332.986732520809;5452.40023597404;4187;4462.634680342256;4780.275243111462;4816.579109162805;4818.7108773473;2475.0965897447304;2505.797217335689;2637.630731697564;2644.7833996361505;2799.3981294021883;4594;4937.8644560704215;5324.9530356928235;5513.862153446115;5533.695646739468;4968.503149685002;4971.000832822217;5440.863978400493;5804.2744656917885;5872.794452194153;4619.653525985565;5823.330317013598;5834.766609335664;5835.928245472881;6000.029985157288;5085.3134826797905;5196.246544251138;5599.692016939108;5602.3837377887585;5642.379338272869;5487.887163442024;5565.191312823429;5577.163425486209;5604.663720176803;5617.747201375866;5878.030125029493;5887.087501437284;5902.2327097477055;5938.524918006636;5956.076808094752;3226.532152837872;3757.774533527888;3798.981005094957;3807.9238415232094;3823.3309170894427;4514.864554063383;5604.803831866028;5618.52242559387;5669.574781891457;5674.602777805679;4867.977724677858;5473.863153421196;5481.232627432242;5481.917771233355;5485.149801780731;4599.931001035054;5254.816081437131;5324.574034077342;5360.490753378423;5370.19447082925;4922.778474968563;5058.747062646779;5350.3312085989255;5358.089124848707;5405.216243644728;4953.628477864103;5123.89836185222;5307.52232299095;5352.357717073976;5361.169018801936;4343.522212556553;4534.795934182904;5208.374995000624;5396.811111611075;5398.838034858961 04:20:29 INFO - PROCESS | 1636 | |5;yui.html;690.7927621713485;702.5573888450275;721.8592374486975;764.7017663111384;810.9675612975482;14632.561023169308;15206.391744330242;15589.298481568328;15616.297266623002;15628.921855390721;14252.928735356334;14442.783358249635;14444.783328250058;14454.638634034154;14462.276886155676;671.6406722403515;691.4606606846668;695.4540685561835;849.5752123938031;867.6746220167437;686.6223577032637;689.3347919257915;689.7585844954276;838.6226198210799;867.2758246863876;906.9546522673872;913.7532866126141;916.9862452063225;920.4707293306342;924.8104138651561;868.5049521772593;912.6075787411411;917.3395155488038;918.3938600523622;919.0350132361027;662.3707477896018;665.9600423974578;679.8164495586165;684.6953105867891;685.1469919949644;11943.581974630846;12476.50093996239;14711.852881471155;15176.392944282215;15297.388104475807;14168.079074860205;14268.215248161347;14282.64293392663;14314.713705725828;14333.78499322511;11049.015025705785;11117.999380055833;11341.943290283496;11651.30092194471;12189.902908738168;3405.1146701857697;3429.159855835311;3593.4070878305047;3612.8554857805657;3622.7464077514583;106936;109573.45213273962;110005.89994099956;111576.32635510474;112118.43940780325;10282;10587.364758114538;10599.788004240027;10822.375131224762;10893.782124357469;21330.78669213319;21771.67342489864;21842;21848.344549663536;21925.122995080335;7532.284432978859;7649.808754781064;7650.961745191238;7745.883811742829;7892.304079072943;3811.8856434307013;4271.743695378287;4321.783910804447;4367.148406060851;4523.841665541756;3519.3665140274484;3527.1182204448887;3608.0979755061235;3608.1520842601967;3620.2035552178477;586.5835256967515;596.6837576084595;597.9103134529855;613.8894998900241;618.3599974026861;661.3329090194785;692.757534862794;694.4722011271471;699.40899939551;720.8342081321325;9502.783262718192;10119.392836429837;10243.48782560869;10255.9487202565;10290.691279261635;664.3854434647932;689.1213702529316;694.9131358580178;696.7491702986921;697.1564407067403;4756.976215118972;4901.358045054875;4951.950480495149;4968.453470118284;4970.956099219205;90068.09931900597;109131;111579.44210279059;112453;114761;78805.423891523;78964.81552776713;100195;102766;103954.4802275999;82960;85050;85714.00060870087;89351.10648893687;89971;7783.416243781626;7957.482763620346;9373.85939210926;9679.758006049624;9736.318457707892;52687.9462410742;53584;53750.19374709461;54656.72671636617;54689.08588199394;74238;75200.24799752151;75674;76878;78786.6060669693;11331.32012079278;11367.886321136682;11731;11768.882311176778;11837.881621183678;12106.152569320064;12166.939165304117;12330.403448172929;12553.874461255637;12883.162594431333;11608.6517404478;11793.351365674627;12270;12412.317322547347;12418.627441176779;9982.650607228712;11483.629244246713;11773.646790596296;12056.879431205576;12420.875791241971;10640.148788096778;11192.38441885704;11599;11705.063594912557;11724.765504689687;9349.439033658002;9623.278254130828;9643.710688679352;9790.090932268424;10342.948285258526;9197.627379445721;9636.518174091407;9707.951460242653;9737.123658870736;9739.123478886933 04:20:29 INFO - PROCESS | 1636 | __end_tp_report 04:20:29 INFO - PROCESS | 1636 | __start_cc_report 04:20:29 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1323 04:20:29 INFO - PROCESS | 1636 | __end_cc_report 04:20:29 INFO - PROCESS | 1636 | __startTimestamp1488543629135__endTimestamp 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | ------- Summary: start ------- 04:20:29 INFO - PROCESS | 1636 | Number of tests: 6 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5660.14 Median:5826.77 stddev:658.59 (11.3%) stddev-sans-first:634.06 04:20:29 INFO - PROCESS | 1636 | Values: 3300.4 3308.3 3321.7 3322.8 3378.2 5579.6 5609.2 5639.1 5649.9 5659.8 4949.5 5150.4 5594.5 5598.1 5646.0 5152.8 5177.5 5217.7 5253.3 5336.8 4883.8 5099.9 5104.5 5107.7 5228.6 5136.4 5171.7 5185.0 5203.0 5227.1 4331.0 5230.9 5232.6 5241.0 5287.0 4958.8 4995.8 5159.3 5172.5 5194.4 5525.0 5542.9 5545.6 5549.4 5552.0 6121.5 6181.4 6192.5 6201.5 6257.3 5431.8 6257.6 6292.8 6314.9 6323.7 5271.5 5625.2 5710.8 5803.2 5803.7 6242.6 6246.6 6260.5 6299.8 6315.7 6150.9 6160.4 6160.5 6176.1 6180.2 6194.2 6271.7 6280.1 6289.3 6296.5 6067.6 6088.6 6122.0 6168.8 6187.9 6271.3 6271.7 6275.1 6288.1 6291.6 4991.6 4992.4 4998.6 4998.9 5007.8 4332.9 4339.5 4365.4 4382.8 4445.5 5720.8 5721.9 5778.0 5781.6 5826.8 6056.8 6270.7 6279.2 6299.2 6306.9 5616.2 5626.2 5670.1 5681.8 5692.5 5339.3 5340.9 5344.8 5348.9 5353.9 6201.4 6269.9 6332.3 6334.2 6341.2 6208.7 6251.0 6255.1 6264.3 6267.7 5905.6 5978.7 6244.6 6283.0 6283.7 4929.4 6026.0 6026.2 6170.5 6175.8 6158.0 6159.6 6165.7 6270.6 6292.8 5861.9 5892.4 5940.3 5983.3 6042.0 5796.4 5926.8 6029.8 6035.1 6041.8 4931.3 4988.3 5715.7 5781.5 5832.3 4977.4 5827.1 5971.1 6015.9 6074.6 5890.8 5891.6 5895.0 5905.6 5908.4 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:73469.94 Median:41081.49 stddev:156700.53 (381.4%) stddev-sans-first:157044.15 04:20:29 INFO - PROCESS | 1636 | Values: 426.6 476.3 477.7 507.4 513.1 26272.6 41471.0 43312.9 43374.9 45448.9 44269.1 44683.0 44757.0 44978.6 46099.5 7635.8 9518.4 9520.8 9545.1 9551.8 8403.2 8618.4 8627.7 8696.9 8703.4 11215.6 11474.1 11485.1 11631.0 11650.7 11270.5 11306.8 11397.4 11486.6 11517.0 8433.7 11363.4 11406.7 11410.7 11424.4 32662.3 36270.5 40812.8 41779.7 43677.9 3912.2 3954.0 3961.2 3967.1 4063.0 30111.2 31372.4 31862.8 32272.0 32701.3 3128.4 3194.2 3248.2 3273.8 3278.0 499248.5 501316.0 502233.0 502466.0 502575.0 64911.7 65355.0 65405.7 65433.0 65498.0 70065.0 70189.6 70233.0 70254.0 70288.0 16727.9 16995.0 17011.9 17059.6 17073.2 13024.8 13100.9 13117.8 13125.7 13133.4 15704.3 16081.8 16913.7 18310.8 18343.0 6300.6 6768.5 7761.8 7808.7 7811.4 854.8 867.2 876.8 881.4 902.5 30389.8 30608.5 30626.5 30881.9 31035.5 1052.5 1059.1 1093.7 1102.3 1214.2 15575.8 15790.9 15829.3 16164.7 16281.8 632343.0 636208.0 637350.0 637670.8 638871.0 63417.0 63464.0 63517.4 63562.4 63588.7 1389.0 1438.1 1450.6 1462.3 1465.0 29340.9 30668.0 32585.7 32856.7 32882.7 62454.0 67471.7 67530.6 67685.3 67864.3 607451.0 616059.9 616290.0 616539.0 617740.0 45743.0 46115.5 46165.3 47121.8 47188.8 37438.8 44452.8 51494.2 51592.0 52239.5 36562.1 40579.8 41294.0 41438.2 42894.6 41252.4 41260.8 41432.6 43240.6 43392.3 33733.0 37405.0 39234.0 39377.2 40910.6 31000.5 35792.5 36441.6 36610.5 36741.3 24043.8 24416.9 25740.9 26222.7 26800.5 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:42462.60 Median:15008.52 stddev:132151.35 (880.5%) stddev-sans-first:132484.31 04:20:29 INFO - PROCESS | 1636 | Values: 388.5 393.5 394.8 405.4 423.5 13309.6 18920.0 20905.0 21258.7 21299.6 21556.2 21683.3 21892.7 22127.7 22479.4 5787.4 6071.8 6150.9 6151.4 6170.6 5822.9 6013.0 6023.3 6042.0 6103.1 6023.3 6024.2 6033.1 6034.0 6035.2 5836.2 6004.3 6035.2 6102.1 6164.1 6070.3 6078.2 6094.7 6095.9 6098.5 13520.1 13736.5 23620.0 25848.1 27110.1 2907.0 2908.1 2942.3 2958.2 3005.4 7368.7 9550.2 9938.9 10127.7 10193.1 1826.0 1864.1 1865.3 1874.7 1877.5 97507.0 118164.4 127946.0 128015.0 135411.6 9665.7 11687.2 11851.5 11903.2 12055.4 12155.8 13742.2 14443.1 15609.5 15619.4 8181.5 8528.9 8739.2 8858.7 8896.4 8734.9 8806.9 8811.3 8912.3 9009.8 4771.0 4776.6 4791.4 4797.3 4839.2 1719.8 1752.6 2033.2 2038.4 2039.3 964.7 975.6 976.4 982.7 1026.2 17154.8 20486.3 20730.3 21458.2 21579.9 991.4 993.5 1014.5 1019.8 1020.7 8424.4 10819.8 11094.8 11268.0 12513.8 783962.0 787359.0 788672.0 794278.0 812448.0 161954.0 167364.0 167771.0 170931.1 172628.3 912.3 1035.8 1078.8 1082.8 1083.4 20217.9 20466.7 20815.6 20992.9 21092.0 59936.1 61242.0 64039.7 64554.7 65770.7 95242.0 96681.0 97135.6 99475.0 100106.0 7105.5 8113.6 8366.8 8601.7 8620.4 12287.6 12862.7 12958.4 13323.9 13562.0 11114.2 11269.8 11317.6 11418.8 11506.6 11260.3 11467.8 11484.3 11773.2 11796.8 9882.9 11244.7 11263.3 11620.6 11657.8 6688.2 6850.8 7249.4 7306.6 8770.6 8377.7 11308.9 11445.5 11450.7 11753.2 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5383.79 Median:5211.66 stddev:2920.20 (56.0%) stddev-sans-first:2913.27 04:20:29 INFO - PROCESS | 1636 | Values: 1429.4 1443.6 1444.5 1452.4 1455.6 8004.3 8462.7 8468.4 8478.0 8487.6 6899.8 7279.4 7551.2 7939.4 8157.7 2276.7 2282.2 2316.0 2319.5 2319.7 2091.9 2292.6 2323.0 2334.4 2339.1 2035.8 2106.3 2220.6 2282.0 2298.3 2302.0 2306.1 2307.0 2309.9 2315.4 2213.4 2246.6 2331.5 2332.2 2333.6 8272.5 8359.0 8366.7 8371.2 8403.7 4990.8 5153.5 5156.1 5158.0 5164.0 3275.4 3423.6 3430.6 3483.7 3494.0 1136.7 1179.8 1183.2 1228.2 1229.7 10689.7 10742.6 10795.3 10817.5 10837.5 4409.6 4571.7 4628.4 4648.0 4655.3 9409.3 9415.6 9437.2 9455.8 9479.4 5208.7 5214.7 5215.7 5218.5 5219.6 4216.3 4340.8 4444.9 4693.8 4772.8 3747.4 3780.6 3886.7 3891.2 3921.4 1263.1 1284.2 1285.1 1293.6 1294.1 781.7 862.0 902.9 923.3 957.5 5352.8 5576.1 5639.5 5801.2 5834.0 1005.9 1006.5 1014.8 1021.7 1040.0 3605.3 3658.9 3724.7 3747.6 3868.1 9589.8 9921.4 9925.6 9933.0 9988.9 9786.7 9866.4 9887.0 9891.8 9894.0 6442.9 7369.5 7738.7 7869.5 7897.1 5541.9 5659.8 5708.5 5743.1 5766.1 8620.0 9011.6 9047.5 9198.4 9322.6 9236.1 9293.8 9387.0 9418.5 9454.0 6550.0 6762.9 7060.4 7247.3 7255.7 7508.1 7635.5 7812.2 7890.1 7984.8 6079.0 6989.9 7064.8 7075.4 7090.1 6903.3 6935.6 6939.7 6977.9 7007.3 6299.1 6312.3 6339.2 6420.2 6421.6 4851.1 4871.0 4907.9 4971.6 4990.9 4860.4 4876.8 4966.6 5020.5 5030.8 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4401.56 Median:4807.79 stddev:1318.28 (27.4%) stddev-sans-first:1286.47 04:20:29 INFO - PROCESS | 1636 | Values: 352.3 358.2 359.3 375.1 378.5 4174.3 5192.9 5205.5 5245.9 5259.1 4832.9 4885.4 4960.8 5043.9 5074.5 3426.6 3614.0 4057.2 4100.1 4106.0 4023.9 4048.3 4102.7 4114.6 4119.7 3465.0 3550.3 3816.3 3950.8 4066.7 3680.9 4030.1 4038.0 4050.4 4054.9 3119.8 3529.8 3584.2 3609.7 3610.1 3569.9 4670.7 4956.1 5025.0 5070.4 4613.0 4624.8 4710.8 4726.9 4752.9 4718.8 5322.5 5474.9 5518.8 5540.8 3998.5 4011.8 4023.6 4026.0 4042.9 4396.3 4799.0 5212.9 5582.0 5702.9 4073.1 4075.2 4081.4 4090.4 4106.1 4138.3 4140.8 4174.7 4196.6 4197.6 3981.7 4395.3 4596.0 4681.8 4765.0 4490.2 4525.4 5492.3 5497.6 5512.4 1184.8 1211.0 1224.1 1350.9 1354.5 901.7 906.7 926.7 946.6 947.2 4142.0 4475.4 4533.5 4857.6 4873.0 4673.3 4888.8 5207.6 5333.0 5452.4 4187.0 4462.6 4780.3 4816.6 4818.7 2475.1 2505.8 2637.6 2644.8 2799.4 4594.0 4937.9 5325.0 5513.9 5533.7 4968.5 4971.0 5440.9 5804.3 5872.8 4619.7 5823.3 5834.8 5835.9 6000.0 5085.3 5196.2 5599.7 5602.4 5642.4 5487.9 5565.2 5577.2 5604.7 5617.7 5878.0 5887.1 5902.2 5938.5 5956.1 3226.5 3757.8 3799.0 3807.9 3823.3 4514.9 5604.8 5618.5 5669.6 5674.6 4868.0 5473.9 5481.2 5481.9 5485.1 4599.9 5254.8 5324.6 5360.5 5370.2 4922.8 5058.7 5350.3 5358.1 5405.2 4953.6 5123.9 5307.5 5352.4 5361.2 4343.5 4534.8 5208.4 5396.8 5398.8 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:21030.17 Median:4640.41 stddev:31530.96 (679.5%) stddev-sans-first:31582.43 04:20:29 INFO - PROCESS | 1636 | Values: 690.8 702.6 721.9 764.7 811.0 14632.6 15206.4 15589.3 15616.3 15628.9 14252.9 14442.8 14444.8 14454.6 14462.3 671.6 691.5 695.5 849.6 867.7 686.6 689.3 689.8 838.6 867.3 907.0 913.8 917.0 920.5 924.8 868.5 912.6 917.3 918.4 919.0 662.4 666.0 679.8 684.7 685.1 11943.6 12476.5 14711.9 15176.4 15297.4 14168.1 14268.2 14282.6 14314.7 14333.8 11049.0 11118.0 11341.9 11651.3 12189.9 3405.1 3429.2 3593.4 3612.9 3622.7 106936.0 109573.5 110005.9 111576.3 112118.4 10282.0 10587.4 10599.8 10822.4 10893.8 21330.8 21771.7 21842.0 21848.3 21925.1 7532.3 7649.8 7651.0 7745.9 7892.3 3811.9 4271.7 4321.8 4367.1 4523.8 3519.4 3527.1 3608.1 3608.2 3620.2 586.6 596.7 597.9 613.9 618.4 661.3 692.8 694.5 699.4 720.8 9502.8 10119.4 10243.5 10255.9 10290.7 664.4 689.1 694.9 696.7 697.2 4757.0 4901.4 4952.0 4968.5 4971.0 90068.1 109131.0 111579.4 112453.0 114761.0 78805.4 78964.8 100195.0 102766.0 103954.5 82960.0 85050.0 85714.0 89351.1 89971.0 7783.4 7957.5 9373.9 9679.8 9736.3 52687.9 53584.0 53750.2 54656.7 54689.1 74238.0 75200.2 75674.0 76878.0 78786.6 11331.3 11367.9 11731.0 11768.9 11837.9 12106.2 12166.9 12330.4 12553.9 12883.2 11608.7 11793.4 12270.0 12412.3 12418.6 9982.7 11483.6 11773.6 12056.9 12420.9 10640.1 11192.4 11599.0 11705.1 11724.8 9349.4 9623.3 9643.7 9790.1 10342.9 9197.6 9636.5 9708.0 9737.1 9739.1 04:20:29 INFO - PROCESS | 1636 | -------- Summary: end -------- 04:20:29 INFO - PROCESS | 1636 | 04:20:29 INFO - TEST-INFO | 1636: exit 0 04:20:29 INFO - TEST-OK | dromaeo_css | took 1118644ms 04:20:29 INFO - TEST-START | kraken 04:20:29 INFO - operating with platform_type : mac_ 04:20:29 INFO - Initialising browser for kraken test... 04:20:29 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpYr9iSt/profile http://localhost:49244/getInfo.html) 04:20:32 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 04:20:32 INFO - PROCESS | 1647 | colorDepth:24 04:20:32 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 04:20:32 INFO - PROCESS | 1647 | __metrics 04:20:32 INFO - PROCESS | 1647 | 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" 04:20:32 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:20:32 INFO - TEST-INFO | 1647: exit 0 04:20:32 INFO - Browser initialized. 04:20:32 INFO - Running cycle 1/1 for kraken test... 04:20:32 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpYr9iSt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:45 INFO - PROCESS | 1648 | RSS: Main: 212766720 04:20:45 INFO - PROCESS | 1648 | 04:20:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:48 INFO - PROCESS | 1648 | RSS: Main: 266555392 04:20:48 INFO - PROCESS | 1648 | 04:20:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 04:20:52 INFO - PROCESS | 1648 | RSS: Main: 276623360 04:20:52 INFO - PROCESS | 1648 | 04:20:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 04:20:55 INFO - PROCESS | 1648 | RSS: Main: 372871168 04:20:55 INFO - PROCESS | 1648 | 04:20:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 04:20:58 INFO - PROCESS | 1648 | RSS: Main: 276226048 04:20:58 INFO - PROCESS | 1648 | 04:21:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:01 INFO - PROCESS | 1648 | RSS: Main: 277458944 04:21:01 INFO - PROCESS | 1648 | 04:21:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:04 INFO - PROCESS | 1648 | RSS: Main: 317378560 04:21:04 INFO - PROCESS | 1648 | 04:21:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:08 INFO - PROCESS | 1648 | RSS: Main: 319234048 04:21:08 INFO - PROCESS | 1648 | 04:21:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 04:21:11 INFO - PROCESS | 1648 | RSS: Main: 314277888 04:21:11 INFO - PROCESS | 1648 | 04:21:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:13 INFO - PROCESS | 1648 | RSS: Main: 294113280 04:21:13 INFO - PROCESS | 1648 | 04:21:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:16 INFO - PROCESS | 1648 | RSS: Main: 296738816 04:21:16 INFO - PROCESS | 1648 | 04:21:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:19 INFO - PROCESS | 1648 | RSS: Main: 301543424 04:21:19 INFO - PROCESS | 1648 | 04:21:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:23 INFO - PROCESS | 1648 | RSS: Main: 318230528 04:21:23 INFO - PROCESS | 1648 | 04:21:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:26 INFO - PROCESS | 1648 | RSS: Main: 310861824 04:21:26 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 04:21:28 INFO - PROCESS | 1648 | RSS: Main: 354807808 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | __start_tp_report 04:21:28 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 04:21:28 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 04:21:28 INFO - PROCESS | 1648 | |i|pagename|runs| 04:21:28 INFO - PROCESS | 1648 | |0;ai-astar;119;112;114;119;166;161;113;115;112;114 04:21:28 INFO - PROCESS | 1648 | |1;audio-beat-detection;147;110;109;145;112;109;110;108;129;109 04:21:28 INFO - PROCESS | 1648 | |2;audio-dft;186;183;188;185;184;183;182;196;263;204 04:21:28 INFO - PROCESS | 1648 | |3;audio-fft;80;57;59;88;59;59;57;59;73;57 04:21:28 INFO - PROCESS | 1648 | |4;audio-oscillator;88;70;85;70;70;71;80;67;69;82 04:21:28 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;85;87;85;86;84;87;85;86;93 04:21:28 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;93;93;119;155;94;94;94;113;154 04:21:28 INFO - PROCESS | 1648 | |7;imaging-desaturate;88;87;85;84;87;86;87;88;86;87 04:21:28 INFO - PROCESS | 1648 | |8;json-parse-financial;55;56;55;57;57;57;58;56;57;56 04:21:28 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;74;77;68;91;111;99;101;77;69;69 04:21:28 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;83;80;82;82;81;85;82;80;87;84 04:21:28 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;163;144;150;137;134;125;139;140;173;179 04:21:28 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;174;197;168;165;170;169;168;169;165;166 04:21:28 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;66;66;68;69;82;82;83;84;65;65 04:21:28 INFO - PROCESS | 1648 | __end_tp_report 04:21:28 INFO - PROCESS | 1648 | __start_cc_report 04:21:28 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2195 04:21:28 INFO - PROCESS | 1648 | __end_cc_report 04:21:28 INFO - PROCESS | 1648 | __startTimestamp1488543688767__endTimestamp 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | ------- Summary: start ------- 04:21:28 INFO - PROCESS | 1648 | Number of tests: 14 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:124.50 Median:117.00 stddev:20.74 (17.7%) stddev-sans-first:21.90 04:21:28 INFO - PROCESS | 1648 | Values: 119.0 112.0 114.0 119.0 166.0 161.0 113.0 115.0 112.0 114.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:111.00 stddev:15.60 (14.1%) stddev-sans-first:12.79 04:21:28 INFO - PROCESS | 1648 | Values: 147.0 110.0 109.0 145.0 112.0 109.0 110.0 108.0 129.0 109.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:195.40 Median:187.00 stddev:24.75 (13.2%) stddev-sans-first:26.01 04:21:28 INFO - PROCESS | 1648 | Values: 186.0 183.0 188.0 185.0 184.0 183.0 182.0 196.0 263.0 204.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:64.80 Median:59.00 stddev:11.32 (19.2%) stddev-sans-first:10.59 04:21:28 INFO - PROCESS | 1648 | Values: 80.0 57.0 59.0 88.0 59.0 59.0 57.0 59.0 73.0 57.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:75.50 stddev:7.70 (10.2%) stddev-sans-first:6.63 04:21:28 INFO - PROCESS | 1648 | Values: 88.0 70.0 85.0 70.0 70.0 71.0 80.0 67.0 69.0 82.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:86.50 stddev:2.51 (2.9%) stddev-sans-first:2.65 04:21:28 INFO - PROCESS | 1648 | Values: 87.0 85.0 87.0 85.0 86.0 84.0 87.0 85.0 86.0 93.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:93.50 stddev:25.06 (26.8%) stddev-sans-first:25.88 04:21:28 INFO - PROCESS | 1648 | Values: 94.0 93.0 93.0 119.0 155.0 94.0 94.0 94.0 113.0 154.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.27 (1.5%) stddev-sans-first:1.22 04:21:28 INFO - PROCESS | 1648 | Values: 88.0 87.0 85.0 84.0 87.0 86.0 87.0 88.0 86.0 87.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:0.97 (1.7%) stddev-sans-first:0.88 04:21:28 INFO - PROCESS | 1648 | Values: 55.0 56.0 55.0 57.0 57.0 57.0 58.0 56.0 57.0 56.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:83.60 Median:75.50 stddev:15.61 (20.7%) stddev-sans-first:16.17 04:21:28 INFO - PROCESS | 1648 | Values: 74.0 77.0 68.0 91.0 111.0 99.0 101.0 77.0 69.0 69.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:2.22 (2.7%) stddev-sans-first:2.35 04:21:28 INFO - PROCESS | 1648 | Values: 83.0 80.0 82.0 82.0 81.0 85.0 82.0 80.0 87.0 84.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:147.00 stddev:17.70 (12.0%) stddev-sans-first:17.97 04:21:28 INFO - PROCESS | 1648 | Values: 163.0 144.0 150.0 137.0 134.0 125.0 139.0 140.0 173.0 179.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:169.00 stddev:9.48 (5.6%) stddev-sans-first:10.00 04:21:28 INFO - PROCESS | 1648 | Values: 174.0 197.0 168.0 165.0 170.0 169.0 168.0 169.0 165.0 166.0 04:21:28 INFO - PROCESS | 1648 | 04:21:28 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:75.50 stddev:8.50 (11.3%) stddev-sans-first:8.63 04:21:28 INFO - PROCESS | 1648 | Values: 66.0 66.0 68.0 69.0 82.0 82.0 83.0 84.0 65.0 65.0 04:21:28 INFO - PROCESS | 1648 | -------- Summary: end -------- 04:21:28 INFO - PROCESS | 1648 | 04:21:29 INFO - TEST-INFO | 1648: exit 0 04:21:29 INFO - TEST-OK | kraken | took 59940ms 04:21:29 INFO - SUITE-END | took 1178s 04:21:29 INFO - Completed test suite (00:19:38) 04:21:29 INFO - javascript benchmark 04:21:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.438925382685, 3308.3383323335333, 3321.684439978201, 3322.800631962081, 3378.223008707997, 5579.609427340088, 5609.214709940607, 5639.097744360903, 5649.915251271234, 5659.801906933259, 4949.52979466951, 5150.407703114143, 5594.468525490082, 5598.076317407623, 5646.0, 5152.768125434355, 5177.508136727005, 5217.713025783581, 5253.290805741233, 5336.759845806929, 4883.804647814101, 5099.949000509984, 5104.489551044903, 5107.719075450848, 5228.5555727763185, 5136.409312929005, 5171.715555644438, 5184.974075129638, 5202.973985130088, 5227.111391063529, 4330.956690433102, 5230.921536176922, 5232.607554433433, 5240.97800928819, 5287.048331300364, 4958.776855041532, 4995.825146119904, 5159.251908473288, 5172.482751724835, 5194.4026436959475, 5525.033119204123, 5542.86142846428, 5545.584081193927, 5549.38956714761, 5552.0, 6121.523955630164, 6181.443670069715, 6192.504599632019, 6201.472874805647, 6257.311695713468, 5431.755570999315, 6257.5619706620555, 6292.811215663537, 6314.936850631527, 6323.715432805535, 5271.525562699337, 5625.184348269478, 5710.8001219957105, 5803.187553742479, 5803.738831752581, 6242.5942313749465, 6246.593971391845, 6260.530460215411, 6299.779507717208, 6315.684215789192, 6150.938490615126, 6160.44555989963, 6160.476359509492, 6176.135341052166, 6180.227471566054, 6194.163787888668, 6271.6550589718, 6280.120783090371, 6289.276733175652, 6296.464800491918, 6067.575269731165, 6088.6042407243385, 6122.011845520044, 6168.845778855564, 6187.938120618736, 6271.278802937721, 6271.749130034747, 6275.090111933744, 6288.119663247149, 6291.55959082869, 4991.575716064175, 4992.375953005874, 4998.625103117281, 4998.850034498971, 5007.774650140753, 4332.9133417332105, 4339.500957389878, 4365.3670217818235, 4382.780860957003, 4445.51099379068, 5720.8283751487525, 5721.942780572141, 5777.971110144423, 5781.5952883298605, 5826.766929322865, 6056.788012419633, 6270.6864656766975, 6279.215098112736, 6299.244090709144, 6306.905396419057, 5616.157576363578, 5626.212330273765, 5670.121131224667, 5681.801136960186, 5692.516136128475, 5339.252504649352, 5340.893182136336, 5344.786208551614, 5348.8662783429945, 5353.866153346197, 6201.441870231701, 6269.905951410824, 6332.303446620868, 6334.208223972004, 6341.207349081365, 6208.658523781235, 6250.968745156245, 6255.124282600348, 6264.342244064308, 6267.655278959519, 5905.5570832186895, 5978.730957106854, 6244.562880598314, 6282.968585157045, 6283.685815709287, 4929.359183306147, 6026.0, 6026.186464827192, 6170.5372097092, 6175.84560385994, 6157.96921015392, 6159.630422174684, 6165.691715414122, 6270.623762574261, 6292.842678933063, 5861.9413805863105, 5892.381299963442, 5940.28716553999, 5983.282006159288, 6042.0, 5796.362400135898, 5926.762929482772, 6029.758809647565, 6035.064564992434, 6041.818745437644, 4931.309616653743, 4988.251762235694, 5715.685637289989, 5781.479666830005, 5832.300123985149, 4977.427595826526, 5827.096799996008, 5971.104334349882, 6015.879682406415, 6074.605150665193, 5890.764369425175, 5891.646501209942, 5895.02732049207, 5905.645661260338, 5908.438698323653], "value": 5618.518652571959, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.58408052149156, 476.25466145482307, 477.73485715427944, 507.43421085489643, 513.0585375835342, 26272.605910911352, 41471.0, 43312.91717707055, 43374.91562710934, 45448.86377840555, 44269.11461770763, 44683.0, 44757.0, 44978.550214497925, 46099.53900461003, 7635.770926872203, 9518.381305215173, 9520.809583808319, 9545.14093731564, 9551.761205969837, 8403.201695838885, 8618.439801412887, 8627.698030568932, 8696.913030869706, 8703.43427677199, 11215.551377944872, 11474.139439542068, 11485.0811935045, 11631.0, 11650.6504804856, 11270.492827822767, 11306.773864522664, 11397.430128493543, 11486.597969071043, 11516.963473287402, 8433.746987590383, 11363.375014374205, 11406.657800266004, 11410.657680269605, 11424.42877856104, 32662.346753064805, 36270.45594316087, 40812.795936020426, 41779.74660760182, 43677.908052298626, 3912.15888583953, 3953.991732108294, 3961.2473630010204, 3967.107400834818, 4062.984253936516, 30111.247218819484, 31372.372552549048, 31862.840685796655, 32272.031839044867, 32701.345973080643, 3128.358686469291, 3194.2493514024186, 3248.2204270974794, 3273.770836041478, 3277.983610081958, 499248.5037574825, 501316.0, 502233.0, 502465.99999999633, 502575.0, 64911.67544162249, 65355.0, 65405.69188616296, 65433.0, 65498.0, 70065.0, 70189.64905175442, 70233.0, 70254.0, 70288.0, 16727.91636041812, 16995.0, 17011.914940425468, 17059.573510662085, 17073.231704573325, 13024.804627930589, 13100.934495327463, 13117.803232951514, 13125.67185820343, 13133.408996595175, 15704.29330680122, 16081.839181608268, 16913.7462938056, 18310.81689183118, 18343.0, 6300.59046161998, 6768.492363072789, 7761.7671469855995, 7808.687652493837, 7811.375089992787, 854.769212312672, 867.2151702709058, 876.7895705030746, 881.4134557795942, 902.4675441489553, 30389.848050760047, 30608.54087188694, 30626.54060189099, 30881.912108555363, 31035.534466983012, 1052.4527245832123, 1059.0838924330399, 1093.6992327110108, 1102.3165637304762, 1214.1804282109717, 15575.844241557666, 15790.921045394929, 15829.287682054335, 16164.676706465805, 16281.837181628032, 632343.0, 636208.0, 637350.0, 637670.8116459388, 638871.0, 63417.048744268875, 63464.04803927945, 63517.36482635114, 63562.36437635565, 63588.68205659035, 1388.9861101388856, 1438.0652575825798, 1450.6155868694593, 1462.2834810942775, 1464.978025329621, 29340.853295733385, 30668.0, 32585.674143258264, 32856.67143328536, 32882.67117328796, 62454.0, 67471.66264168647, 67530.64938701296, 67685.27730974843, 67864.3213567858, 607451.0, 616059.9197003986, 616290.0, 616539.0, 617740.0, 45743.0, 46115.538844611125, 46165.30752038789, 47121.76439117782, 47188.76405618087, 37438.8128059358, 44452.777736111115, 51494.22758658698, 51592.0, 52239.47760522498, 36562.08594785152, 40579.782606521854, 41294.0, 41438.171236575705, 42894.57105428906, 41252.38121428241, 41260.79369603253, 41432.58567414287, 43240.56759432366, 43392.349114763936, 33733.0, 37405.01236701762, 39234.01914952035, 39377.21245575015, 40910.59089409187, 31000.534991974688, 35792.46311305385, 36441.63558364382, 36610.45084323684, 36741.26517469689, 24043.797810109776, 24416.87791561031, 25740.871295643403, 26222.737772622793, 26800.463990720466], "value": 21071.557197289076, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.50077650219464, 393.5297319702956, 394.8361430006547, 405.4404921208732, 423.5383432059055, 13309.600711978655, 18920.0, 20905.0, 21258.681119783196, 21299.57400851984, 21556.245531406403, 21683.349499515, 21892.671609925823, 22127.668084978697, 22479.438014049658, 5787.421257874211, 6071.78748743794, 6150.907736383958, 6151.384861513835, 6170.598911070789, 5822.883542329151, 6013.0, 6023.277206735198, 6041.9697901510435, 6103.084537319393, 6023.307319658252, 6024.246969128859, 6033.125196846455, 6034.0, 6035.185249991261, 5836.2121113649755, 6004.309504406983, 6035.185249991261, 6102.054181601814, 6164.075388691687, 6070.271567411939, 6078.209832721718, 6094.695265236721, 6095.939040609582, 6098.512119030512, 13520.053596248266, 13736.450541978309, 23620.0, 25848.09531666383, 27110.051148209717, 2906.9854650726825, 2908.127561731493, 2942.264433891527, 2958.2456473599095, 3005.443992861306, 7368.705251789922, 9550.235981121494, 9938.900610993942, 10127.746806329827, 10193.133583645398, 1825.9908700456544, 1864.1424944525534, 1865.32848174657, 1874.7469091672585, 1877.5493881468349, 97507.02492975122, 118164.40917795443, 127946.0, 128015.0, 135411.64588354088, 9665.71002869915, 11687.181897267279, 11851.46668399924, 11903.166778325607, 12055.397230138458, 12155.817662735066, 13742.244176570384, 14443.133411995314, 15609.531714048597, 15619.3752249911, 8181.509109453452, 8528.872066919, 8739.169778870997, 8858.689945851864, 8896.377253592187, 8734.917389130158, 8806.86789698155, 8811.251043661232, 8912.287017038621, 9009.774755631162, 4771.045790841846, 4776.59398951093, 4791.448983366888, 4797.280407938837, 4839.153148199051, 1719.7678313427527, 1752.6319472910832, 2033.176563491788, 2038.4190505705803, 2039.2964427272568, 964.6816550538306, 975.6390135649713, 976.4483067067084, 982.6806287956442, 1026.2457094035879, 17154.828451715322, 20486.282980095624, 20730.274440394816, 21458.24896128628, 21579.892100539397, 991.4002028772633, 993.5082134343546, 1014.4876837197169, 1019.7858449725493, 1020.6733845169623, 8424.410291279552, 10819.78360432787, 11094.778104438028, 11268.0, 12513.812292815615, 783962.0, 787359.0, 788672.0, 794278.0, 812448.0, 161954.0, 167364.0, 167771.0, 170931.1453442725, 172628.27371726374, 912.3066469483241, 1035.8239099353127, 1078.757279612081, 1082.7780305037447, 1083.4203701020074, 20217.89891050535, 20466.692999605315, 20815.583688326453, 20992.895035524725, 21092.0, 59936.14565585627, 61242.0, 64039.679801600694, 64554.67722661357, 65770.67114664396, 95242.04757952332, 96681.0, 97135.57161071029, 99475.0, 100106.0, 7105.50261481712, 8113.553754543321, 8366.790830229293, 8601.655933762579, 8620.396572239883, 12287.56993505223, 12862.67843303925, 12958.352082396032, 13323.933380333036, 13562.0, 11114.22200445961, 11269.830952535882, 11317.603883864025, 11418.828717569077, 11506.597269095542, 11260.268082574607, 11467.827982580435, 11484.253523520945, 11773.234739741889, 11796.76406471883, 9882.901170988198, 11244.662660119882, 11263.324200547993, 11620.593279235187, 11657.76684466289, 6688.197416310074, 6850.794476165723, 7249.420046396381, 7306.648270070054, 8770.605322760364, 8377.70678026266, 11308.886911130783, 11445.484953177294, 11450.713732156762, 11753.177277590486], "value": 9994.202127617264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.442517418207, 1443.559714287142, 1444.5449683349746, 1452.4408102880388, 1455.6433673749932, 8004.279614834663, 8462.66149354026, 8468.44955077921, 8478.0, 8487.618057187434, 6899.793006209809, 7279.381252593523, 7551.244875512446, 7939.404544659159, 8157.673693052286, 2276.7040284762998, 2282.1556024271044, 2315.9925432436858, 2319.5360927814504, 2319.698439202901, 2091.853570250083, 2292.6446400807818, 2322.988385058081, 2334.428065124047, 2339.146211632759, 2035.8065983731522, 2106.2522804404443, 2220.600291947449, 2282.018731945263, 2298.2530677529785, 2301.9654705179437, 2306.077568972408, 2307.0, 2309.919152829643, 2315.4211447138214, 2213.4023813570407, 2246.550689862018, 2331.4754180309465, 2332.195392589554, 2333.57995560799, 8272.503649781032, 8358.958205208995, 8366.748997530083, 8371.204735550113, 8403.663853445854, 4990.775415106293, 5153.510416510426, 5156.149235376159, 5158.045761534128, 5163.974180129113, 3275.4431746602895, 3423.589169299675, 3430.6397828227928, 3483.6864682178725, 3493.965060349389, 1136.7044568412189, 1179.8466199394109, 1183.2190754102337, 1228.2384921348732, 1229.7479016801624, 10689.679309620724, 10742.570297188104, 10795.29830561011, 10817.513211905483, 10837.512311945982, 4409.559044095629, 4571.657125715585, 4628.39830821991, 4647.9781295136045, 4655.255159174516, 9409.294302927308, 9415.576299066559, 9437.150656440816, 9455.76360590977, 9479.431234125837, 5208.661437006658, 5214.661047031931, 5215.6609820361555, 5218.452062533379, 5219.634625576249, 4216.346466297668, 4340.848070317524, 4444.911101778011, 4693.78877950493, 4772.832950846704, 3747.4191500317493, 3780.5652349979555, 3886.7084968627464, 3891.2412079644196, 3921.352976758803, 1263.0842639086588, 1284.1588759362446, 1285.1429684106376, 1293.5731208701106, 1294.1458637299338, 781.7263957614903, 862.0, 902.8894459814466, 923.2706162131975, 957.5499515227832, 5352.759125839347, 5576.1356989666665, 5639.492445679908, 5801.245838041112, 5833.970830145822, 1005.8893521712606, 1006.5168719014914, 1014.8477728340808, 1021.6934919524113, 1040.0119886108228, 3605.3330133924783, 3658.9451158232646, 3724.7020238380865, 3747.569029561581, 3868.052327179803, 9589.760255993657, 9921.355111917703, 9925.553350099262, 9933.0, 9988.850167247498, 9786.657466988621, 9866.358686685342, 9886.95056524727, 9891.752706182404, 9893.950530247446, 6442.9355706443275, 7369.484136110528, 7738.729144479917, 7869.488483248685, 7897.131315555284, 5541.944580554304, 5659.830205093854, 5708.4862362387585, 5743.0811070228565, 5766.106253530709, 8619.956900215459, 9011.594478248364, 9047.547622618711, 9198.448093114435, 9322.627094916128, 9236.07511662223, 9293.814123717622, 9387.0, 9418.529073546159, 9453.95273023658, 6550.0, 6762.898556521558, 7060.364567188978, 7247.311505406978, 7255.709771609077, 7508.136564294958, 7635.503692259986, 7812.218778122142, 7890.092639346549, 7984.760457186294, 6079.0, 6989.930100698928, 7064.752733654297, 7075.408033192491, 7090.07828982229, 6903.344182302673, 6935.618540980295, 6939.653017349011, 6977.895331569929, 7007.264237255014, 6299.055141728594, 6312.2740884796995, 6339.2392912850755, 6420.165378500765, 6421.5504914657395, 4851.102546028996, 4870.975645121752, 4907.877303067452, 4971.627127965345, 4990.900181996412, 4860.3681521401995, 4876.829310974099, 4966.602671786176, 5020.49795020495, 5030.84907452777], "value": 4393.837636923007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.33408857259775, 358.1922764166805, 359.3137108123484, 375.11472923899595, 378.4625831319526, 4174.269502837003, 5192.92210616841, 5205.453427390122, 5245.947540524594, 5259.079661059319, 4832.9275060874115, 4885.413750349954, 4960.826371077013, 5043.85636104655, 5074.467180946003, 3426.623071462137, 3613.981930090359, 4057.1885622875398, 4100.077482566428, 4105.958940410603, 4023.879283621496, 4048.3320252158505, 4102.712810103294, 4114.588541145891, 4119.732217405859, 3464.9703865336614, 3550.325438166753, 3816.3017457231545, 3950.822213000422, 4066.6746660267254, 3680.926381472382, 4030.0730831908827, 4038.0, 4050.41269015991, 4054.8580799672163, 3119.845657106885, 3529.8411571479346, 3584.2473080653094, 3609.729270304738, 3610.097475631092, 3569.8837053205116, 4670.734693673566, 4956.107900577895, 5024.974875125601, 5070.442251352349, 4613.0, 4624.768761561909, 4710.788014539354, 4726.881827954294, 4752.906831428756, 4718.764061796896, 5322.547583455411, 5474.945250547523, 5518.813455107131, 5540.750666219989, 3998.5009369144286, 4011.799410029487, 4023.5574086850424, 4025.9597404025876, 4042.919141617151, 4396.296592545209, 4799.0, 5212.921806172911, 5582.0, 5702.914456283159, 4073.124278280184, 4075.166175221162, 4081.367453018757, 4090.447789548373, 4106.055607210358, 4138.317177665652, 4140.834366625361, 4174.666026717916, 4196.643285320721, 4197.580241975778, 3981.6814654827544, 4395.340698895191, 4595.954040459553, 4681.765911704401, 4765.0, 4490.236659767847, 4525.434320709911, 5492.340919089735, 5497.642653227527, 5512.448755124536, 1184.8222766585081, 1210.9767246676545, 1224.1186345830988, 1350.9054366194273, 1354.4897439355047, 901.7475106970059, 906.7305771919366, 926.7219834049893, 946.5693109635099, 947.1570302430843, 4142.005918579519, 4475.395821564047, 4533.52397998212, 4857.562819346276, 4872.975635121873, 4673.345731597579, 4888.780004899788, 5207.583393328525, 5332.986732520809, 5452.40023597404, 4187.0, 4462.634680342256, 4780.275243111462, 4816.579109162805, 4818.7108773473, 2475.0965897447304, 2505.797217335689, 2637.630731697564, 2644.7833996361505, 2799.3981294021883, 4594.0, 4937.8644560704215, 5324.9530356928235, 5513.862153446115, 5533.695646739468, 4968.503149685002, 4971.000832822217, 5440.863978400493, 5804.2744656917885, 5872.794452194153, 4619.653525985565, 5823.330317013598, 5834.766609335664, 5835.928245472881, 6000.029985157288, 5085.3134826797905, 5196.246544251138, 5599.692016939108, 5602.3837377887585, 5642.379338272869, 5487.887163442024, 5565.191312823429, 5577.163425486209, 5604.663720176803, 5617.747201375866, 5878.030125029493, 5887.087501437284, 5902.2327097477055, 5938.524918006636, 5956.076808094752, 3226.532152837872, 3757.774533527888, 3798.981005094957, 3807.9238415232094, 3823.3309170894427, 4514.864554063383, 5604.803831866028, 5618.52242559387, 5669.574781891457, 5674.602777805679, 4867.977724677858, 5473.863153421196, 5481.232627432242, 5481.917771233355, 5485.149801780731, 4599.931001035054, 5254.816081437131, 5324.574034077342, 5360.490753378423, 5370.19447082925, 4922.778474968563, 5058.747062646779, 5350.3312085989255, 5358.089124848707, 5405.216243644728, 4953.628477864103, 5123.89836185222, 5307.52232299095, 5352.357717073976, 5361.169018801936, 4343.522212556553, 4534.795934182904, 5208.374995000624, 5396.811111611075, 5398.838034858961], "value": 4003.8145458946174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.7927621713485, 702.5573888450275, 721.8592374486975, 764.7017663111384, 810.9675612975482, 14632.561023169308, 15206.391744330242, 15589.298481568328, 15616.297266623002, 15628.921855390721, 14252.928735356334, 14442.783358249635, 14444.783328250058, 14454.638634034154, 14462.276886155676, 671.6406722403515, 691.4606606846668, 695.4540685561835, 849.5752123938031, 867.6746220167437, 686.6223577032637, 689.3347919257915, 689.7585844954276, 838.6226198210799, 867.2758246863876, 906.9546522673872, 913.7532866126141, 916.9862452063225, 920.4707293306342, 924.8104138651561, 868.5049521772593, 912.6075787411411, 917.3395155488038, 918.3938600523622, 919.0350132361027, 662.3707477896018, 665.9600423974578, 679.8164495586165, 684.6953105867891, 685.1469919949644, 11943.581974630846, 12476.50093996239, 14711.852881471155, 15176.392944282215, 15297.388104475807, 14168.079074860205, 14268.215248161347, 14282.64293392663, 14314.713705725828, 14333.78499322511, 11049.015025705785, 11117.999380055833, 11341.943290283496, 11651.30092194471, 12189.902908738168, 3405.1146701857697, 3429.159855835311, 3593.4070878305047, 3612.8554857805657, 3622.7464077514583, 106936.0, 109573.45213273962, 110005.89994099956, 111576.32635510474, 112118.43940780325, 10282.0, 10587.364758114538, 10599.788004240027, 10822.375131224762, 10893.782124357469, 21330.78669213319, 21771.67342489864, 21842.0, 21848.344549663536, 21925.122995080335, 7532.284432978859, 7649.808754781064, 7650.961745191238, 7745.883811742829, 7892.304079072943, 3811.8856434307013, 4271.743695378287, 4321.783910804447, 4367.148406060851, 4523.841665541756, 3519.3665140274484, 3527.1182204448887, 3608.0979755061235, 3608.1520842601967, 3620.2035552178477, 586.5835256967515, 596.6837576084595, 597.9103134529855, 613.8894998900241, 618.3599974026861, 661.3329090194785, 692.757534862794, 694.4722011271471, 699.40899939551, 720.8342081321325, 9502.783262718192, 10119.392836429837, 10243.48782560869, 10255.9487202565, 10290.691279261635, 664.3854434647932, 689.1213702529316, 694.9131358580178, 696.7491702986921, 697.1564407067403, 4756.976215118972, 4901.358045054875, 4951.950480495149, 4968.453470118284, 4970.956099219205, 90068.09931900597, 109131.0, 111579.44210279059, 112453.0, 114761.0, 78805.423891523, 78964.81552776713, 100195.0, 102766.0, 103954.4802275999, 82960.0, 85050.0, 85714.00060870087, 89351.10648893687, 89971.0, 7783.416243781626, 7957.482763620346, 9373.85939210926, 9679.758006049624, 9736.318457707892, 52687.9462410742, 53584.0, 53750.19374709461, 54656.72671636617, 54689.08588199394, 74238.0, 75200.24799752151, 75674.0, 76878.0, 78786.6060669693, 11331.32012079278, 11367.886321136682, 11731.0, 11768.882311176778, 11837.881621183678, 12106.152569320064, 12166.939165304117, 12330.403448172929, 12553.874461255637, 12883.162594431333, 11608.6517404478, 11793.351365674627, 12270.0, 12412.317322547347, 12418.627441176779, 9982.650607228712, 11483.629244246713, 11773.646790596296, 12056.879431205576, 12420.875791241971, 10640.148788096778, 11192.38441885704, 11599.0, 11705.063594912557, 11724.765504689687, 9349.439033658002, 9623.278254130828, 9643.710688679352, 9790.090932268424, 10342.948285258526, 9197.627379445721, 9636.518174091407, 9707.951460242653, 9737.123658870736, 9739.123478886933], "value": 7303.701564091838, "unit": "score"}], "name": "dromaeo_css", "value": 7305.722442164929, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 112.0, 114.0, 119.0, 166.0, 161.0, 113.0, 115.0, 112.0, 114.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 110.0, 109.0, 145.0, 112.0, 109.0, 110.0, 108.0, 129.0, 109.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 188.0, 185.0, 184.0, 183.0, 182.0, 196.0, 263.0, 204.0], "value": 195.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 88.0, 59.0, 59.0, 57.0, 59.0, 73.0, 57.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 70.0, 70.0, 71.0, 80.0, 67.0, 69.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 86.0, 84.0, 87.0, 85.0, 86.0, 93.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 119.0, 155.0, 94.0, 94.0, 94.0, 113.0, 154.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 84.0, 87.0, 86.0, 87.0, 88.0, 86.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 57.0, 57.0, 57.0, 58.0, 56.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 68.0, 91.0, 111.0, 99.0, 101.0, 77.0, 69.0, 69.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 82.0, 82.0, 81.0, 85.0, 82.0, 80.0, 87.0, 84.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 144.0, 150.0, 137.0, 134.0, 125.0, 139.0, 140.0, 173.0, 179.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 197.0, 168.0, 165.0, 170.0, 169.0, 168.0, 169.0, 165.0, 166.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 69.0, 82.0, 82.0, 83.0, 84.0, 65.0, 65.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1477.1, "alertThreshold": 2.0}]} 04:21:30 INFO - Return code: 0 04:21:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:21:30 ERROR - # TBPL SUCCESS # 04:21:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:21:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:21:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:21:30 INFO - 2017-03-03 04:21:30.089 screenresolution[1652:9778] starting screenresolution argv=screenresolution get 04:21:30 INFO - 2017-03-03 04:21:30.092 screenresolution[1652:9778] Display 0: 1600x1200x32@60 04:21:30 INFO - 2017-03-03 04:21:30.098 screenresolution[1653:9781] starting screenresolution argv=screenresolution list 04:21:30 INFO - Available Modes on Display 0 04:21:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:21:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:21:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:21:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:21:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:21:30 INFO - Intel Iris: 04:21:30 INFO - Chipset Model: Intel Iris 04:21:30 INFO - Type: GPU 04:21:30 INFO - Bus: Built-In 04:21:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:21:30 INFO - Vendor: Intel (0x8086) 04:21:30 INFO - Device ID: 0x0a2e 04:21:30 INFO - Revision ID: 0x0009 04:21:30 INFO - Displays: 04:21:30 INFO - Display: 04:21:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:21:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:21:30 INFO - Display Serial Number: 1600x1200 60 04:21:30 INFO - Main Display: Yes 04:21:30 INFO - Mirror: Off 04:21:30 INFO - Online: Yes 04:21:30 INFO - Rotation: Supported 04:21:30 INFO - Return code: 0 04:21:30 INFO - Running post-action listener: _resource_record_post_action 04:21:30 INFO - [mozharness: 2017-03-03 12:21:30.338767Z] Finished run-tests step (success) 04:21:30 INFO - Running post-run listener: _resource_record_post_run 04:21:30 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38646784; Write bytes: 507503104; Read time: 380; Write time: 1747 04:21:30 INFO - TinderboxPrint: CPU usage
53.6% 04:21:30 INFO - TinderboxPrint: I/O read bytes / time
38,646,784 / 380 04:21:30 INFO - TinderboxPrint: I/O write bytes / time
507,503,104 / 1,747 04:21:30 INFO - TinderboxPrint: CPU idle
2,224.3 (46.4%) 04:21:30 INFO - TinderboxPrint: CPU system
958.5 (20.0%) 04:21:30 INFO - TinderboxPrint: CPU user
1,614.8 (33.7%) 04:21:30 INFO - TinderboxPrint: Swap in / out
246,329,344 / 0 04:21:30 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208919040; Write bytes: 200003584; Read time: 15949; Write time: 423 04:21:30 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34313216; Write bytes: 297406976; Read time: 344; Write time: 1288 04:21:30 INFO - Running post-run listener: _upload_blobber_files 04:21:30 INFO - Blob upload gear active. 04:21:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:30 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 04:21:30 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'] 04:21:30 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 04:21:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:32 INFO - (blobuploader) - INFO - Done attempting. 04:21:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:33 INFO - (blobuploader) - INFO - Done attempting. 04:21:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:21:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:21:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:34 INFO - (blobuploader) - INFO - Done attempting. 04:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:36 INFO - (blobuploader) - INFO - Done attempting. 04:21:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:36 INFO - Return code: 0 04:21:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00f900d72d703b05d56ecf8a58b190db2d4202aa80f3f80b7e82a3921bfe8f27260cead6b8b3770fd922d706b30a4dc51377d818c4250954154ea8939ac144f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d2857ff893720eba9ff49eff8911bf821ce001de4319b8bf5e429dd9b77ffb34860ccfe53cff6226f6542ada929ce0306b90f3d9f0d75e278e24e3ba6b1b00e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e048ea96207f047d8536b81f2f577e83ce352bfcea53961457a0081f67ae20c3d6a07ca5a6664fdf99d323e82491acd2ee4da69e60f5ba739f8cd4c5f29fb4b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7038d5dab30b887796ba69b2549eb47fd130a0c7c7ace7c5c090c524a979ddf574a0834abfbfc52314fa6a913cd0152d6d41ba00eadaeaf5226f946faf81ef41"} 04:21:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:36 INFO - Contents: 04:21:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00f900d72d703b05d56ecf8a58b190db2d4202aa80f3f80b7e82a3921bfe8f27260cead6b8b3770fd922d706b30a4dc51377d818c4250954154ea8939ac144f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d2857ff893720eba9ff49eff8911bf821ce001de4319b8bf5e429dd9b77ffb34860ccfe53cff6226f6542ada929ce0306b90f3d9f0d75e278e24e3ba6b1b00e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e048ea96207f047d8536b81f2f577e83ce352bfcea53961457a0081f67ae20c3d6a07ca5a6664fdf99d323e82491acd2ee4da69e60f5ba739f8cd4c5f29fb4b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7038d5dab30b887796ba69b2549eb47fd130a0c7c7ace7c5c090c524a979ddf574a0834abfbfc52314fa6a913cd0152d6d41ba00eadaeaf5226f946faf81ef41"} 04:21:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:36 INFO - Copying logs to upload dir... 04:21:36 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.085539 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-03 04:21:36.671324) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 04:21:36.675159) ========= 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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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/00f900d72d703b05d56ecf8a58b190db2d4202aa80f3f80b7e82a3921bfe8f27260cead6b8b3770fd922d706b30a4dc51377d818c4250954154ea8939ac144f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d2857ff893720eba9ff49eff8911bf821ce001de4319b8bf5e429dd9b77ffb34860ccfe53cff6226f6542ada929ce0306b90f3d9f0d75e278e24e3ba6b1b00e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e048ea96207f047d8536b81f2f577e83ce352bfcea53961457a0081f67ae20c3d6a07ca5a6664fdf99d323e82491acd2ee4da69e60f5ba739f8cd4c5f29fb4b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7038d5dab30b887796ba69b2549eb47fd130a0c7c7ace7c5c090c524a979ddf574a0834abfbfc52314fa6a913cd0152d6d41ba00eadaeaf5226f946faf81ef41"} build_url:https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/ZQ2cboB3QFizTf7ALwF9VQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00f900d72d703b05d56ecf8a58b190db2d4202aa80f3f80b7e82a3921bfe8f27260cead6b8b3770fd922d706b30a4dc51377d818c4250954154ea8939ac144f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d2857ff893720eba9ff49eff8911bf821ce001de4319b8bf5e429dd9b77ffb34860ccfe53cff6226f6542ada929ce0306b90f3d9f0d75e278e24e3ba6b1b00e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e048ea96207f047d8536b81f2f577e83ce352bfcea53961457a0081f67ae20c3d6a07ca5a6664fdf99d323e82491acd2ee4da69e60f5ba739f8cd4c5f29fb4b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7038d5dab30b887796ba69b2549eb47fd130a0c7c7ace7c5c090c524a979ddf574a0834abfbfc52314fa6a913cd0152d6d41ba00eadaeaf5226f946faf81ef41"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 04:21:36.711557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:21:36.712092) ========= 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.0ynnzzQbbc/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.C8h7tgt9KV/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005195 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:21:36.762728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 04:21:36.763223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 04:21:36.763759) ========= ========= Total master_lag: 0.21 =========