builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0173 starttime: 1483287296.42 results: success (0) buildid: 20170101070720 builduid: 845ca5ce325d433f869cb30495e44823 revision: d08c9540a13c3c183f592c7378688b14d8101d87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.416364) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.416795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.417084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.443444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.443816) ========= 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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-01-01 08:14:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-01-01 08:14:56 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.331689 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.797793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.798162) ========= 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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.027620 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.847008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:56.847351) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d08c9540a13c3c183f592c7378688b14d8101d87 --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 d08c9540a13c3c183f592c7378688b14d8101d87 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EU4JWmMdB1/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.Rf4ORj20cT/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-01-01 08:14:56,942 truncating revision to first 12 chars 2017-01-01 08:14:56,943 Setting DEBUG logging. 2017-01-01 08:14:56,943 attempt 1/10 2017-01-01 08:14:56,943 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d08c9540a13c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-01 08:14:57,642 unpacking tar archive at: mozilla-aurora-d08c9540a13c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965569 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:57.836685) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:57.837065) ========= script_repo_revision: d08c9540a13c3c183f592c7378688b14d8101d87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:57.837565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:57.837878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 08:14:57.858142) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-01 08:14:57.858447) ========= /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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:14:58 INFO - MultiFileLogger online at 20170101 08:14:58 in /builds/slave/test 08:14:58 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 08:14:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:58 INFO - {'append_to_log': False, 08:14:58 INFO - 'base_work_dir': '/builds/slave/test', 08:14:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:58 INFO - 'branch': 'Mozilla-Aurora', 08:14:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:58 INFO - 'config_files': ('talos/mac_config.py',), 08:14:58 INFO - 'default_actions': ('clobber', 08:14:58 INFO - 'read-buildbot-config', 08:14:58 INFO - 'download-and-extract', 08:14:58 INFO - 'populate-webroot', 08:14:58 INFO - 'create-virtualenv', 08:14:58 INFO - 'install', 08:14:58 INFO - 'run-tests'), 08:14:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:58 INFO - 'download_minidump_stackwalk': True, 08:14:58 INFO - 'download_symbols': 'ondemand', 08:14:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:58 INFO - 'installer_path': 'installer.exe', 08:14:58 INFO - 'log_level': 'info', 08:14:58 INFO - 'log_name': 'talos', 08:14:58 INFO - 'log_to_console': True, 08:14:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:14:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:14:58 INFO - 'opt_config_files': (), 08:14:58 INFO - 'pip_index': False, 08:14:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:58 INFO - 'cmd': ('bash', 08:14:58 INFO - '-c', 08:14:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:58 INFO - 'enabled': True, 08:14:58 INFO - 'halt_on_failure': False, 08:14:58 INFO - 'name': 'check_screen_resolution'},), 08:14:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:58 INFO - 'cmd': ('bash', 08:14:58 INFO - '-c', 08:14:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:58 INFO - 'enabled': True, 08:14:58 INFO - 'halt_on_failure': False, 08:14:58 INFO - 'name': 'check_screen_resolution'},), 08:14:58 INFO - 'run_cmd_checks_enabled': True, 08:14:58 INFO - 'sps_profile': False, 08:14:58 INFO - 'sps_profile_interval': 0, 08:14:58 INFO - 'suite': 'dromaeojs', 08:14:58 INFO - 'system_bits': '32', 08:14:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:58 INFO - 'title': 't-yosemite-r7-0173', 08:14:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:58 INFO - 'use_talos_json': True, 08:14:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:58 INFO - 'work_dir': 'build'} 08:14:58 INFO - [mozharness: 2017-01-01 16:14:58.063943Z] Running clobber step. 08:14:58 INFO - Running pre-action listener: _resource_record_pre_action 08:14:58 INFO - Running main action method: clobber 08:14:58 INFO - rmtree: /builds/slave/test/build 08:14:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:00 INFO - Running post-action listener: _resource_record_post_action 08:15:00 INFO - [mozharness: 2017-01-01 16:15:00.383015Z] Finished clobber step (success) 08:15:00 INFO - [mozharness: 2017-01-01 16:15:00.383144Z] Running read-buildbot-config step. 08:15:00 INFO - Running pre-action listener: _resource_record_pre_action 08:15:00 INFO - Running main action method: read_buildbot_config 08:15:00 INFO - Using buildbot properties: 08:15:00 INFO - { 08:15:00 INFO - "project": "", 08:15:00 INFO - "product": "firefox", 08:15:00 INFO - "script_repo_revision": "production", 08:15:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:15:00 INFO - "repository": "", 08:15:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:15:00 INFO - "buildid": "20170101070720", 08:15:00 INFO - "pgo_build": "False", 08:15:00 INFO - "basedir": "/builds/slave/test", 08:15:00 INFO - "buildnumber": 33, 08:15:00 INFO - "slavename": "t-yosemite-r7-0173", 08:15:00 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:15:00 INFO - "platform": "yosemite_r7", 08:15:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:15:00 INFO - "branch": "mozilla-aurora", 08:15:00 INFO - "repo_path": "releases/mozilla-aurora", 08:15:00 INFO - "revision": "d08c9540a13c3c183f592c7378688b14d8101d87", 08:15:00 INFO - "stage_platform": "macosx64", 08:15:00 INFO - "builduid": "845ca5ce325d433f869cb30495e44823", 08:15:00 INFO - "slavebuilddir": "test" 08:15:00 INFO - } 08:15:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:15:00 INFO - Running post-action listener: _resource_record_post_action 08:15:00 INFO - [mozharness: 2017-01-01 16:15:00.386419Z] Finished read-buildbot-config step (success) 08:15:00 INFO - [mozharness: 2017-01-01 16:15:00.386549Z] Running download-and-extract step. 08:15:00 INFO - Running pre-action listener: _resource_record_pre_action 08:15:00 INFO - Running main action method: download_and_extract 08:15:00 INFO - mkdir: /builds/slave/test/build/tests 08:15:00 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')]} 08:15:00 INFO - trying https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:15:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:15:01 INFO - Downloaded 1199 bytes. 08:15:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:15:01 INFO - Using the following test package requirements: 08:15:01 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:15:01 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:15:01 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:15:01 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'jsshell-mac.zip'], 08:15:01 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:15:01 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:15:01 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:15:01 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:15:01 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:15:01 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:01 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:15:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:15:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:15:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:15:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:15:02 INFO - Http code: 200 08:15:02 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:15:02 INFO - x-amz-cf-id: QqsJOyB3Dz8e_8I7P8mXmTYRuc4oRdf38DNy4fVDlKTE-lWZoghrbQ== 08:15:02 INFO - x-amz-version-id: PJPyFfaeLg7ClHWU8w7BysNSCpJZkI2T 08:15:02 INFO - Expected file size: 16268365 08:15:02 INFO - Obtained file size: 16268365 08:15:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:15:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:15:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:15:09 INFO - Fetch https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:15:09 INFO - Http code: 200 08:15:09 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 08:15:09 INFO - x-amz-cf-id: VlIMv2o0b0o5NqlFnnc1vetSJkUB8hQbxEtsHYlJDWdEkqusOfOSJw== 08:15:09 INFO - x-amz-version-id: PJPyFfaeLg7ClHWU8w7BysNSCpJZkI2T 08:15:10 INFO - Expected file size: 16268365 08:15:10 INFO - Obtained file size: 16268365 08:15:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:15:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:15:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:15:16 INFO - Http code: 200 08:15:16 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:15:16 INFO - x-amz-cf-id: 8GE8Riq1syLU0i2jniam8QRo4i_yUoX4rv80BAh-U1lIGc9oMDqxkQ== 08:15:16 INFO - x-amz-version-id: SjIz3ATN.qsjyCBx_fUVWsLHLwCEH67. 08:15:17 INFO - Expected file size: 14409038 08:15:17 INFO - Obtained file size: 14409038 08:15:17 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')]} 08:15:17 INFO - trying https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:15:20 INFO - Downloaded 109825996 bytes. 08:15:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:20 INFO - mkdir: /builds/slave/test/properties 08:15:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:20 INFO - Contents: 08:15:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:21 INFO - Running post-action listener: _resource_record_post_action 08:15:21 INFO - Running post-action listener: set_extra_try_arguments 08:15:21 INFO - [mozharness: 2017-01-01 16:15:21.085849Z] Finished download-and-extract step (success) 08:15:21 INFO - [mozharness: 2017-01-01 16:15:21.085984Z] Running populate-webroot step. 08:15:21 INFO - Running pre-action listener: _resource_record_pre_action 08:15:21 INFO - Running main action method: populate_webroot 08:15:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:21 INFO - '--tppagecycles', 08:15:21 INFO - '7'], 08:15:21 INFO - 'tests': ['tsvgm']}}, 08:15:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['damp', 'tps']}, 08:15:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'tests': ['damp', 'tps']}, 08:15:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['dromaeo_dom']}, 08:15:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['basic_compositor_video']}, 08:15:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:15:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['a11yr', 08:15:21 INFO - 'ts_paint', 08:15:21 INFO - 'tpaint', 08:15:21 INFO - 'sessionrestore', 08:15:21 INFO - 'sessionrestore_no_auto_restore', 08:15:21 INFO - 'tabpaint']}, 08:15:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:21 INFO - 'ts_paint', 08:15:21 INFO - 'tpaint', 08:15:21 INFO - 'sessionrestore', 08:15:21 INFO - 'sessionrestore_no_auto_restore', 08:15:21 INFO - 'tabpaint']}, 08:15:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:21 INFO - 'ts_paint', 08:15:21 INFO - 'tpaint', 08:15:21 INFO - 'sessionrestore', 08:15:21 INFO - 'sessionrestore_no_auto_restore', 08:15:21 INFO - 'tabpaint']}, 08:15:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:21 INFO - 'ts_paint', 08:15:21 INFO - 'tpaint', 08:15:21 INFO - 'sessionrestore', 08:15:21 INFO - 'sessionrestore_no_auto_restore', 08:15:21 INFO - 'tabpaint']}, 08:15:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['a11yr', 08:15:21 INFO - 'ts_paint', 08:15:21 INFO - 'tpaint', 08:15:21 INFO - 'sessionrestore', 08:15:21 INFO - 'sessionrestore_no_auto_restore', 08:15:21 INFO - 'tabpaint']}, 08:15:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['a11yr', 08:15:21 INFO - 'ts_paint', 08:15:21 INFO - 'tpaint', 08:15:21 INFO - 'sessionrestore', 08:15:21 INFO - 'sessionrestore_no_auto_restore', 08:15:21 INFO - 'tabpaint']}, 08:15:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['tsvgx', 08:15:21 INFO - 'tsvgr_opacity', 08:15:21 INFO - 'tart', 08:15:21 INFO - 'tscrollx', 08:15:21 INFO - 'cart']}, 08:15:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:21 INFO - 'tsvgr_opacity', 08:15:21 INFO - 'tart', 08:15:21 INFO - 'tscrollx', 08:15:21 INFO - 'cart']}, 08:15:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'talos_options': ['--disable-e10s'], 08:15:21 INFO - 'tests': ['tp5o']}, 08:15:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'tests': ['tp5o']}, 08:15:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'talos_options': ['--disable-e10s', 08:15:21 INFO - '--xperf_path', 08:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:21 INFO - 'tests': ['tp5n']}, 08:15:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:21 INFO - 'talos_options': ['--xperf_path', 08:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:21 INFO - 'tests': ['tp5n']}}, 08:15:21 INFO - 'talos.zip': {'path': '', 08:15:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:21 INFO - Running post-action listener: _resource_record_post_action 08:15:21 INFO - [mozharness: 2017-01-01 16:15:21.105125Z] Finished populate-webroot step (success) 08:15:21 INFO - [mozharness: 2017-01-01 16:15:21.105239Z] Running create-virtualenv step. 08:15:21 INFO - Running pre-action listener: _resource_record_pre_action 08:15:21 INFO - Running main action method: create_virtualenv 08:15:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:21 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 08:15:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:21 INFO - Using real prefix '/tools/python27' 08:15:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:21 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:24 INFO - Installing pip.................done. 08:15:24 INFO - Return code: 0 08:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:15:25 INFO - Reading from file tmpfile_stdout 08:15:25 INFO - Output received: 08:15:25 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) 08:15:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:15:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:25 INFO - 'HOME': '/Users/cltbld', 08:15:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:25 INFO - 'LOGNAME': 'cltbld', 08:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:25 INFO - 'MOZ_NO_REMOTE': '1', 08:15:25 INFO - 'NO_EM_RESTART': '1', 08:15:25 INFO - 'PAGER': '/bin/cat', 08:15:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:25 INFO - 'PWD': '/builds/slave/test', 08:15:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:25 INFO - 'SHELL': '/bin/bash', 08:15:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:25 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:25 INFO - 'USER': 'cltbld', 08:15:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:25 INFO - 'XPC_FLAGS': '0x0', 08:15:25 INFO - 'XPC_SERVICE_NAME': '0', 08:15:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:25 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 08:15:25 INFO - Cleaning up... 08:15:25 INFO - Return code: 0 08:15:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:15:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:25 INFO - 'HOME': '/Users/cltbld', 08:15:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:25 INFO - 'LOGNAME': 'cltbld', 08:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:25 INFO - 'MOZ_NO_REMOTE': '1', 08:15:25 INFO - 'NO_EM_RESTART': '1', 08:15:25 INFO - 'PAGER': '/bin/cat', 08:15:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:25 INFO - 'PWD': '/builds/slave/test', 08:15:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:25 INFO - 'SHELL': '/bin/bash', 08:15:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:25 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:25 INFO - 'USER': 'cltbld', 08:15:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:25 INFO - 'XPC_FLAGS': '0x0', 08:15:25 INFO - 'XPC_SERVICE_NAME': '0', 08:15:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:25 INFO - Downloading/unpacking psutil>=3.1.1 08:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:29 INFO - Installing collected packages: psutil 08:15:29 INFO - Running setup.py install for psutil 08:15:29 INFO - building 'psutil._psutil_osx' extension 08:15:29 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 08:15:29 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 08:15:29 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 08:15:29 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 08:15:30 INFO - building 'psutil._psutil_posix' extension 08:15:30 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 08:15:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:15:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:15:30 INFO - ^ 08:15:30 INFO - 1 warning generated. 08:15:30 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 08:15:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:30 INFO - Successfully installed psutil 08:15:30 INFO - Cleaning up... 08:15:30 INFO - Return code: 0 08:15:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:15: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 mozsystemmonitor==0.3 08:15:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:30 INFO - 'HOME': '/Users/cltbld', 08:15:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:30 INFO - 'LOGNAME': 'cltbld', 08:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:30 INFO - 'MOZ_NO_REMOTE': '1', 08:15:30 INFO - 'NO_EM_RESTART': '1', 08:15:30 INFO - 'PAGER': '/bin/cat', 08:15:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:30 INFO - 'PWD': '/builds/slave/test', 08:15:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:30 INFO - 'SHELL': '/bin/bash', 08:15:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:30 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:30 INFO - 'USER': 'cltbld', 08:15:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:30 INFO - 'XPC_FLAGS': '0x0', 08:15:30 INFO - 'XPC_SERVICE_NAME': '0', 08:15:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:30 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 08:15:30 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 08:15:30 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 08:15:30 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 08:15:30 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 08:15:30 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 08:15:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:33 INFO - Installing collected packages: mozsystemmonitor 08:15:33 INFO - Running setup.py install for mozsystemmonitor 08:15:33 INFO - Successfully installed mozsystemmonitor 08:15:33 INFO - Cleaning up... 08:15:33 INFO - Return code: 0 08:15:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:33 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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:33 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 08:15:33 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 08:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:33 INFO - 'HOME': '/Users/cltbld', 08:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:33 INFO - 'LOGNAME': 'cltbld', 08:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:33 INFO - 'MOZ_NO_REMOTE': '1', 08:15:33 INFO - 'NO_EM_RESTART': '1', 08:15:33 INFO - 'PAGER': '/bin/cat', 08:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:33 INFO - 'PWD': '/builds/slave/test', 08:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:33 INFO - 'SHELL': '/bin/bash', 08:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:33 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:33 INFO - 'USER': 'cltbld', 08:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:33 INFO - 'XPC_FLAGS': '0x0', 08:15:33 INFO - 'XPC_SERVICE_NAME': '0', 08:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:33 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:37 INFO - warning: no files found matching '*.txt' 08:15:37 INFO - no previously-included directories found matching 'build' 08:15:37 INFO - no previously-included directories found matching 'dist' 08:15:37 INFO - no previously-included directories found matching '.git*' 08:15:37 INFO - Installing collected packages: jsonschema, functools32 08:15:37 INFO - Running setup.py install for functools32 08:15:37 INFO - warning: no files found matching '*.txt' 08:15:37 INFO - no previously-included directories found matching 'build' 08:15:37 INFO - no previously-included directories found matching 'dist' 08:15:37 INFO - no previously-included directories found matching '.git*' 08:15:37 INFO - Successfully installed jsonschema functools32 08:15:37 INFO - Cleaning up... 08:15:37 INFO - Return code: 0 08:15:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:37 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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:37 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 08:15:37 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 08:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:37 INFO - 'HOME': '/Users/cltbld', 08:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:37 INFO - 'LOGNAME': 'cltbld', 08:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:37 INFO - 'MOZ_NO_REMOTE': '1', 08:15:37 INFO - 'NO_EM_RESTART': '1', 08:15:37 INFO - 'PAGER': '/bin/cat', 08:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:37 INFO - 'PWD': '/builds/slave/test', 08:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:37 INFO - 'SHELL': '/bin/bash', 08:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:37 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:37 INFO - 'USER': 'cltbld', 08:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:37 INFO - 'XPC_FLAGS': '0x0', 08:15:37 INFO - 'XPC_SERVICE_NAME': '0', 08:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:15:37 INFO - Cleaning up... 08:15:37 INFO - Return code: 0 08:15:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:37 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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:37 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 08:15:37 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 08:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:37 INFO - 'HOME': '/Users/cltbld', 08:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:37 INFO - 'LOGNAME': 'cltbld', 08:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:37 INFO - 'MOZ_NO_REMOTE': '1', 08:15:37 INFO - 'NO_EM_RESTART': '1', 08:15:37 INFO - 'PAGER': '/bin/cat', 08:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:37 INFO - 'PWD': '/builds/slave/test', 08:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:37 INFO - 'SHELL': '/bin/bash', 08:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:37 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:37 INFO - 'USER': 'cltbld', 08:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:37 INFO - 'XPC_FLAGS': '0x0', 08:15:37 INFO - 'XPC_SERVICE_NAME': '0', 08:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:15:37 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 08:15:37 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 08:15:37 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 08:15:37 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 08:15:37 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 08:15:37 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 08:15:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15:40 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 08:15:40 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 08:15:40 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 08:15:40 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 08:15:40 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 08:15:40 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 08:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15:41 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 08:15:41 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 08:15:41 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 08:15:41 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 08:15:41 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 08:15:41 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 08:15:41 INFO - Downloading docopt-0.6.1.tar.gz 08:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:41 INFO - Running setup.py install for blobuploader 08:15:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:41 INFO - Running setup.py install for requests 08:15:42 INFO - Running setup.py install for docopt 08:15:42 INFO - Successfully installed blobuploader requests docopt 08:15:42 INFO - Cleaning up... 08:15:42 INFO - Return code: 0 08:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:42 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')]} 08:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:42 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')]} 08:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:42 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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:42 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 08:15:42 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 08:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:42 INFO - 'HOME': '/Users/cltbld', 08:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:42 INFO - 'LOGNAME': 'cltbld', 08:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:42 INFO - 'MOZ_NO_REMOTE': '1', 08:15:42 INFO - 'NO_EM_RESTART': '1', 08:15:42 INFO - 'PAGER': '/bin/cat', 08:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:42 INFO - 'PWD': '/builds/slave/test', 08:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:42 INFO - 'SHELL': '/bin/bash', 08:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:42 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:42 INFO - 'USER': 'cltbld', 08:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:42 INFO - 'XPC_FLAGS': '0x0', 08:15:42 INFO - 'XPC_SERVICE_NAME': '0', 08:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:42 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-68P0Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_VyR_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-BDQf6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-LugbNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-jsDd6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-fUj5Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-fbdqI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-LpLZZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-vUgtEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-hh8mbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-t6AM6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-P6YTug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-LPOvE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-QvCQyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-EQviv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-o0CQOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-MS2RP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:44 INFO - Running setup.py install for manifestparser 08:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:44 INFO - Running setup.py install for mozcrash 08:15:45 INFO - Running setup.py install for mozdebug 08:15:45 INFO - Running setup.py install for mozdevice 08:15:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Running setup.py install for mozfile 08:15:45 INFO - Running setup.py install for mozhttpd 08:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Running setup.py install for mozinfo 08:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Running setup.py install for mozInstall 08:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:45 INFO - Running setup.py install for mozleak 08:15:46 INFO - Running setup.py install for mozlog 08:15:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:46 INFO - Running setup.py install for moznetwork 08:15:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:46 INFO - Running setup.py install for mozprocess 08:15:46 INFO - Running setup.py install for mozprofile 08:15:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:46 INFO - Running setup.py install for mozrunner 08:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:46 INFO - Running setup.py install for mozscreenshot 08:15:47 INFO - Running setup.py install for moztest 08:15:47 INFO - Running setup.py install for mozversion 08:15:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:47 INFO - Cleaning up... 08:15:47 INFO - Return code: 0 08:15:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:47 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')]} 08:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:47 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')]} 08:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:47 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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:47 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 08:15:47 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 08:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:47 INFO - 'HOME': '/Users/cltbld', 08:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:47 INFO - 'LOGNAME': 'cltbld', 08:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:47 INFO - 'MOZ_NO_REMOTE': '1', 08:15:47 INFO - 'NO_EM_RESTART': '1', 08:15:47 INFO - 'PAGER': '/bin/cat', 08:15:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:47 INFO - 'PWD': '/builds/slave/test', 08:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:47 INFO - 'SHELL': '/bin/bash', 08:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:47 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:47 INFO - 'USER': 'cltbld', 08:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:47 INFO - 'XPC_FLAGS': '0x0', 08:15:47 INFO - 'XPC_SERVICE_NAME': '0', 08:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:47 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-ZoeR7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:47 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)) 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:47 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-jKwDxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:47 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)) 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:47 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-jQeUkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:47 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)) 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:47 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-z3NX86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-1DulYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-rifdzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-9zgYhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-vB0x0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_xLrHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-wGBd8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-TBOAdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-uGhSrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-jEUw34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:48 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)) 08:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:48 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-zecL1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:49 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)) 08:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:49 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-SxJosb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:49 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)) 08:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:49 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_G4U74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:49 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-TsNABm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:49 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)) 08:15:49 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)) 08:15:49 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)) 08:15:49 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)) 08:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:49 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 08:15:49 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 08:15:49 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 08:15:49 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 08:15:49 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 08:15:49 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 08:15:52 INFO - Downloading blessings-1.6.tar.gz 08:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:52 INFO - Installing collected packages: blessings 08:15:52 INFO - Running setup.py install for blessings 08:15:52 INFO - Successfully installed blessings 08:15:52 INFO - Cleaning up... 08:15:52 INFO - Return code: 0 08:15:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:52 INFO - Reading from file tmpfile_stdout 08:15:52 INFO - Current package versions: 08:15:52 INFO - blessings == 1.6 08:15:52 INFO - blobuploader == 1.2.4 08:15:52 INFO - docopt == 0.6.1 08:15:52 INFO - functools32 == 3.2.3-2 08:15:52 INFO - jsonschema == 2.5.1 08:15:52 INFO - manifestparser == 1.1 08:15:52 INFO - mozInstall == 1.12 08:15:52 INFO - mozcrash == 1.0 08:15:52 INFO - mozdebug == 0.1 08:15:52 INFO - mozdevice == 0.48 08:15:52 INFO - mozfile == 1.2 08:15:52 INFO - mozhttpd == 0.7 08:15:52 INFO - mozinfo == 0.9 08:15:52 INFO - mozleak == 0.1 08:15:52 INFO - mozlog == 3.4 08:15:52 INFO - moznetwork == 0.27 08:15:52 INFO - mozprocess == 0.23 08:15:52 INFO - mozprofile == 0.28 08:15:52 INFO - mozrunner == 6.13 08:15:52 INFO - mozscreenshot == 0.1 08:15:52 INFO - mozsystemmonitor == 0.3 08:15:52 INFO - moztest == 0.7 08:15:52 INFO - mozversion == 1.4 08:15:52 INFO - psutil == 3.1.1 08:15:52 INFO - requests == 1.2.3 08:15:52 INFO - wsgiref == 0.1.2 08:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:53 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')]} 08:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:53 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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:53 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 08:15:53 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 08:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:53 INFO - 'HOME': '/Users/cltbld', 08:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:53 INFO - 'LOGNAME': 'cltbld', 08:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:53 INFO - 'MOZ_NO_REMOTE': '1', 08:15:53 INFO - 'NO_EM_RESTART': '1', 08:15:53 INFO - 'PAGER': '/bin/cat', 08:15:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:53 INFO - 'PWD': '/builds/slave/test', 08:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:53 INFO - 'SHELL': '/bin/bash', 08:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:53 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:53 INFO - 'USER': 'cltbld', 08:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:53 INFO - 'XPC_FLAGS': '0x0', 08:15:53 INFO - 'XPC_SERVICE_NAME': '0', 08:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 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)) 08:15:53 INFO - Cleaning up... 08:15:53 INFO - Return code: 0 08:15:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:53 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')]} 08:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:53 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')]} 08:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:54 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 0x10d499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed10429550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, '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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 08:15:54 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 08:15:54 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 08:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:54 INFO - 'HOME': '/Users/cltbld', 08:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:54 INFO - 'LOGNAME': 'cltbld', 08:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:54 INFO - 'MOZ_NO_REMOTE': '1', 08:15:54 INFO - 'NO_EM_RESTART': '1', 08:15:54 INFO - 'PAGER': '/bin/cat', 08:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:54 INFO - 'PWD': '/builds/slave/test', 08:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:54 INFO - 'SHELL': '/bin/bash', 08:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:15:54 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:54 INFO - 'USER': 'cltbld', 08:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:54 INFO - 'XPC_FLAGS': '0x0', 08:15:54 INFO - 'XPC_SERVICE_NAME': '0', 08:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:54 INFO - Cleaning up... 08:15:54 INFO - Return code: 0 08:15:54 INFO - Running post-action listener: _resource_record_post_action 08:15:54 INFO - Running post-action listener: _start_resource_monitoring 08:15:54 INFO - Starting resource monitoring. 08:15:54 INFO - [mozharness: 2017-01-01 16:15:54.444676Z] Finished create-virtualenv step (success) 08:15:54 INFO - [mozharness: 2017-01-01 16:15:54.445668Z] Running install step. 08:15:54 INFO - Running pre-action listener: _resource_record_pre_action 08:15:54 INFO - Running main action method: install 08:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:54 INFO - Reading from file tmpfile_stdout 08:15:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:54 INFO - Reading from file tmpfile_stdout 08:15:54 INFO - Output received: 08:15:54 INFO - Usage: mozinstall [options] installer 08:15:54 INFO - Options: 08:15:54 INFO - -h, --help show this help message and exit 08:15:54 INFO - -d DEST, --destination=DEST 08:15:54 INFO - Directory to install application into. [default: 08:15:54 INFO - "/builds/slave/test"] 08:15:54 INFO - --app=APP Application being installed. [default: firefox] 08:15:54 INFO - mkdir: /builds/slave/test/build/application 08:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:16:25 INFO - Reading from file tmpfile_stdout 08:16:25 INFO - Output received: 08:16:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:16:25 INFO - Running post-action listener: _resource_record_post_action 08:16:25 INFO - [mozharness: 2017-01-01 16:16:25.998608Z] Finished install step (success) 08:16:25 INFO - [mozharness: 2017-01-01 16:16:25.998776Z] Running run-tests step. 08:16:25 INFO - Running pre-action listener: _resource_record_pre_action 08:16:25 INFO - Running main action method: run_tests 08:16:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:16:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:16:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:16:26 INFO - 2017-01-01 08:16:26.013 screenresolution[1628:7535] starting screenresolution argv=screenresolution get 08:16:26 INFO - 2017-01-01 08:16:26.015 screenresolution[1628:7535] Display 0: 1600x1200x32@60 08:16:26 INFO - 2017-01-01 08:16:26.021 screenresolution[1629:7538] starting screenresolution argv=screenresolution list 08:16:26 INFO - Available Modes on Display 0 08:16:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:16:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:16:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:16:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:16:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:16:26 INFO - Intel Iris: 08:16:26 INFO - Chipset Model: Intel Iris 08:16:26 INFO - Type: GPU 08:16:26 INFO - Bus: Built-In 08:16:26 INFO - VRAM (Dynamic, Max): 1536 MB 08:16:26 INFO - Vendor: Intel (0x8086) 08:16:26 INFO - Device ID: 0x0a2e 08:16:26 INFO - Revision ID: 0x0009 08:16:26 INFO - Displays: 08:16:26 INFO - Display: 08:16:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:16:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:16:26 INFO - Display Serial Number: 1600x1200 60 08:16:26 INFO - Main Display: Yes 08:16:26 INFO - Mirror: Off 08:16:26 INFO - Online: Yes 08:16:26 INFO - Rotation: Supported 08:16:26 INFO - Return code: 0 08:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:26 INFO - Python 2.7.3 08:16:26 INFO - Return code: 0 08:16:26 INFO - grabbing minidump binary from tooltool 08:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:26 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 0x10d2add30>, '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 0x10d113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:26 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 08:16:26 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 08:16:26 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 08:16:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:26 INFO - Return code: 0 08:16:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:16:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:16:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:26 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/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 08:16:26 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/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0173 --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 08:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EU4JWmMdB1/Render', 08:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:26 INFO - 'HOME': '/Users/cltbld', 08:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:26 INFO - 'LOGNAME': 'cltbld', 08:16:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:26 INFO - 'MOZ_NO_REMOTE': '1', 08:16:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:26 INFO - 'NO_EM_RESTART': '1', 08:16:26 INFO - 'PAGER': '/bin/cat', 08:16:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:26 INFO - 'PWD': '/builds/slave/test', 08:16:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:26 INFO - 'SHELL': '/bin/bash', 08:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rf4ORj20cT/Listeners', 08:16:26 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 08:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:26 INFO - 'USER': 'cltbld', 08:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:26 INFO - 'XPC_FLAGS': '0x0', 08:16:26 INFO - 'XPC_SERVICE_NAME': '0', 08:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:26 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/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 08:16:26 INFO - mozversion application_buildid: 20170101070720 08:16:26 INFO - mozversion application_changeset: d08c9540a13c3c183f592c7378688b14d8101d87 08:16:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:16:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:26 INFO - mozversion application_name: Firefox 08:16:26 INFO - mozversion application_remotingname: firefox-dev 08:16:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:26 INFO - mozversion application_vendor: Mozilla 08:16:26 INFO - mozversion application_version: 52.0a2 08:16:26 INFO - mozversion platform_buildid: 20170101070720 08:16:26 INFO - mozversion platform_changeset: d08c9540a13c3c183f592c7378688b14d8101d87 08:16:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:26 INFO - mozversion platform_version: 52.0a2 08:16:26 INFO - using testdate: 1483287386 08:16:26 INFO - actual date: 1483287386 08:16:26 INFO - starting webserver on 'localhost:49244' 08:16:26 INFO - SUITE-START | Running 2 tests 08:16:26 INFO - TEST-START | dromaeo_css 08:16:26 INFO - operating with platform_type : mac_ 08:16:26 INFO - Initialising browser for dromaeo_css test... 08:16:26 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpaZbdZ0/profile http://localhost:49244/getInfo.html) 08:16:29 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 08:16:29 INFO - PROCESS | 1639 | colorDepth:24 08:16:29 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 08:16:29 INFO - PROCESS | 1639 | __metrics 08:16:29 INFO - PROCESS | 1639 | 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" 08:16:29 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:30 INFO - TEST-INFO | 1639: exit 0 08:16:30 INFO - Browser initialized. 08:16:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:30 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpaZbdZ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:42 INFO - PROCESS | 1641 | RSS: Main: 222642176 08:16:42 INFO - PROCESS | 1641 | 08:17:33 INFO - PROCESS | 1641 | 1483287453512 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:19:47 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 08:19:50 INFO - PROCESS | 1641 | RSS: Main: 423841792 08:19:50 INFO - PROCESS | 1641 | 08:22:52 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 08:22:53 INFO - PROCESS | 1641 | RSS: Main: 349810688 08:22:53 INFO - PROCESS | 1641 | 08:25:55 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 08:25:56 INFO - PROCESS | 1641 | RSS: Main: 325320704 08:25:56 INFO - PROCESS | 1641 | 08:28:58 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 08:28:59 INFO - PROCESS | 1641 | RSS: Main: 332288000 08:28:59 INFO - PROCESS | 1641 | 08:32:02 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 08:32:03 INFO - PROCESS | 1641 | RSS: Main: 310931456 08:32:03 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 08:35:06 INFO - PROCESS | 1641 | RSS: Main: 389484544 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | __start_tp_report 08:35:06 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 08:35:06 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 08:35:06 INFO - PROCESS | 1641 | |i|pagename|runs| 08:35:06 INFO - PROCESS | 1641 | |0;dojo.html;2857.571364295356;2986.9103926882203;3171.619405671321;3333.9333213335735;3355.714764245039;5640.858978525539;5676.744546495407;5709.971450142749;5744.454276843699;5761.222234998285;5679.545636349082;5705.372409035002;5731.770729170828;5763.711814409284;5768.394318596539;5083.1612783890705;5244;5267.631265811395;5277.102892508264;5302.284191634138;5193.013327467788;5206.349206349207;5208.791648334081;5339.679619222839;5373.650712703681;5247.2653828464045;5279.736013199325;5280;5283.207518872162;5294.735263236823;5270.7628156733035;5273.920891186635;5278.656887302352;5282.65662731925;5294.497022782849;5131.974340128276;5215.348081489814;5237.528622423962;5240.52835244826;5271.420143784219;5797.507211886995;5798.9130163047585;5809.6804675742815;5815.360310365856;5819.854503637401;6102.314311391842;6148.231471066117;6157.476614487774;6164.815055548341;6165.568410211287;6220.346863579304;6242.032484964792;6245.594036387665;6260.87478250437;6295.779647712308;5718.48533631971;5761.827145185651;5764.33710123337;5765.740541675635;5771.740271687784;6282.560220784501;6374.617522948638;6376.39424254695;6389.520785941073;6394.968025159845;5994.190784244159;6008.098785182257;6057.030875059969;6067.089936509471;6108.725107370179;6187.443130118311;6218.22272215973;6277.591956522811;6287.308396076428;6299.338569450233;6025.6083354581815;6185.226846644169;6229.844253893598;6233.470155036782;6239.532035097295;6134.5092392608485;6147.170132032208;6168.982117950488;6169.074638804215;6184.412480814315;4878.390201224847;4908.605258436838;4909.2881532177635;4915.11527924977;4949.901001980013;4430.379746835446;4440.71135376206;4442.244818380883;4449.644028477714;4484.417025786692;5616.66300022;5654.5193658538665;5678.630888992202;5696.629719068247;5766.913496297559;6344.809655710336;6347.333529979285;6354.078658594478;6354.459870910932;6370.299267080617;5678.886422271531;5742.971285143631;5748.19525266463;5750.396208398141;5813.970930145322;4754.7147171169845;5106.285120083191;5416.214648875891;5424.349078110652;5427.213054107132;6177.073438984008;6258.718357673824;6273.65494897785;6302.086197501245;6330.683465826598;6300.401461861115;6320.873582528416;6327.272363678236;6335.778247761306;6343;6268.717907694074;6327.936720632919;6330.841728956813;6343.492520598434;6344.777932772331;5973.954557952427;6065.848353791191;6083.574149809471;6100.145979562776;6130.367562715148;4871.878203044952;6041.2750469943885;6161.599496032743;6241.96879015602;6247.937520624736;6054.90917636227;6064.241969753781;6117.401149625394;6126.823043872828;6147.66187859672;6136.29432615255;6142.78500252489;6164.4143806338325;6165.106059621419;6183.196184495987;5742.109972954198;5974.163617093697;5997.370276120944;5997.520198384206;6010.4891084258325;5927.792527261525;6027.126066720213;6034.788782392595;6102.816915492543;6119.837693858789;6051.304100028553;6051.576389652682;6086.934786412448;6094.299155597163;6102.267727872683 08:35:06 INFO - PROCESS | 1641 | |1;ext.html;476.7794446217683;488.7482946282665;502.19899260679216;504.98485045448626;555.1090499747902;37856.24287514248;39308;39625.40561891567;40983.59016409835;41070.58929410705;40652.59347406525;41006.58993410065;41221.17557648845;41263.38104928428;41265.460799312124;9237.722868313927;9398.060193980615;9413.48225847578;9414.388064775801;9423.670171543998;9331.720048398525;9449.527523623825;9456.148946594805;9456.432614043179;9489;9465.432074075543;9492.288078394113;9496.192823609967;9501.857472137888;9505;9396.718098457022;9460.858087128732;9473.857892131624;9476.336656434052;9487.620495180185;9292.953535232347;9361.578728957213;9362.578683959238;9370;9382.624695012191;38647.61352386468;38916.80541597302;38965.61034389676;39132.80433597814;39169.412458812854;3168.778185527014;3300.6534313897178;3319.1204330852343;3326.550915626384;3538.5576802899636;24005;25170.622440663406;26945.191644250703;27630.44739105227;28149.718502814914;3141.371675912341;3183.8248896310693;3189.7926634768664;3255.6744325567493;3278.934421311584;363654.9999999974;363728;364144;364422;364921;30346.84826575897;30832.69167308343;31129.8443507781;54151.18773218405;54481.45518544843;33289;33293.83353083219;33310.50034249488;33362.332753344795;33400;14064.578062658136;14245.501407450689;14278.500252491112;14288.49990250357;14292.142471451747;11979.28124312544;12025;12028.699282517831;12047.39763011846;12052.216605920587;7602.581857997752;7613.505122167041;7683.807904802425;7693.884591731128;7708.113566939874;2668.226214397842;3176.285335799427;3181;3182.79311844734;3215.1158431431077;891.6789955615973;1001.3291094966245;1014.9647359693072;1040.6721882606955;1083.6694808083453;27698.169054928385;28333.858330708215;28678.569821452278;29123.12630621085;29155.562666559596;858.2576071697937;1004.3120462483222;1020.1532727835878;1043.3270540501485;1047.7747284333905;13851.445942162401;14294.856411487057;14517.98374113802;14539.92730036343;14581.489647862274;582908;674269;674417;675311;680569;51635.741821291405;52155.21767173496;52180;52180.95638087217;52227;1166.877477864812;1206.9275843449245;1254.8305978692943;1335.966600834948;1384.9861501385058;27550;27672.446551069268;28836.855815720788;28947.276318092216;29467.705322946495;45339.546604533534;46132.769336153106;46271.07457850757;46371.53628463672;46373.07253854837;552023;558501;560023;561062;562687;25353.619695704947;26285.737142628328;26395.60406593941;26881;26890.462190756465;43371.13257734891;43423.56576434321;43528.34707479327;43777;44157.89605259894;36733;36931.26137477181;37032.62967370292;37060;37470.812645936596;36452;36558.63441365552;36682.63317366792;37085;37535.81232093822;35607.28785424329;35760;36435.089122772144;36503.817480912425;36522.26955460929;28463;30776.46117694151;32677.836610816794;33271.33457330888;33322.500162498065;24336.90483928192;24562.754372456046;24745.133920312703;24968.253492116215;25347.746522534537 08:35:06 INFO - PROCESS | 1641 | |2;jquery.html;347.7774224496321;365.4171596303895;366.9596344402117;380.10295702142946;396.6667998880939;14784.334704938277;14884.92557537212;16075.517734467956;20386.796132038675;20421.08105135269;19589.314373996913;19708.605827883435;20170.69743953842;20414.69377959328;20484.487887802814;5610.66336019838;5683.571199875819;5862.267216597926;5862.912056319158;5870.677112758796;5072.6195535335;5707.6575405475805;5759.280089988752;5760.279965004374;5762;5469.617126801126;5698.487136157745;5712.685802280873;5713.77144914205;5718.456746609087;5636.2954630671165;5754.4533269339345;5756.992526307879;5760.10718338654;5762.164486149506;5067.366579177603;5071.18860982241;5087.287779710843;5098.439171691111;5401.189821526763;12812.743745125139;12890.355482225945;13055;13058.542950996669;13060.738785224337;2140.518383363746;2145.5923374558784;2152.182170775111;2175.9347219583437;2311.91908283211;9498.810023799486;9699.127078562893;10001.349912255753;10084.445355505444;10213.438260895648;1789.8389144977014;1802.7603213745917;1806.2774890043956;1834.706446968492;1883.5102873253054;116458.41770791177;121284;122312;123992;130573;9425.811483770287;11216.327020378803;11453.427328633536;11561.942190289163;11585.536578536932;13992.16047037181;14517.128972261487;14519.637009074857;14530.927345363205;14538.709225815424;8108.878366824502;8355.582220888931;8357.12250213731;8457.534835584102;8458.87311690325;8231.629576669064;8234.917650823534;8245.422820402515;8417.663293468315;8497.447665901696;3962.821673024721;4319.049809042006;4408.911821763547;4486.910261794746;4510.278355463176;1713.5544758362666;1730.6538692261347;1764.4882983934515;1828.1773202059126;1901.391554702482;801.8476489466983;864.4985908173245;919.8160367926441;941.7410212191702;948.966786162481;20217.49456263576;20557;20875.26936557213;20887.895560522404;21013.264535741175;882.170759486081;914.9908500915038;943.3773709351932;987.9259055570717;994.9056038357893;10421.166306695446;10914.836277455845;10989.285696429706;10992.945035274772;11016.834747478793;580019.1988480705;581154;591885;605520;606042;122198.38900805617;122212;124767;125013;126079;797.7686470923484;833.6957010691054;876.2114097312469;962.0235461007084;978.4325091446943;17294.654106918042;18571.40716544005;18679.90660046691;19627.31304404339;19726.210951561778;39765.80117099396;48990.265146022124;50248.49751502585;51785.482145178066;54492.637684058216;67050.3294967044;68856.27859303557;70780.64609676918;77570;79852.80220796577;6308.369163083838;7443.255674432514;7995.960020199862;8011.759647210593;8160.183981601793;9463.101005404476;11810.704732381415;12350.320732359807;12684.87315126837;12691.398263356174;10868.924153442458;10911.945440272748;10913.618023369145;11040.392778396945;11276.492557834754;8496.745097646834;9040.502772347583;10951.726206844893;10982.835257471304;11181.664550063511;9344.672936447192;10805.135589152691;11047.779044419227;11274.718132046764;11368.317900925971;7887.921120788718;7923.643436045507;8158.632861521127;8282.627281772455;8375.916240837514;9050.637974481211;10174.898251017692;11189.72025699364;11193.552257909918;11244.044256237985 08:35:06 INFO - PROCESS | 1641 | |3;mootools.html;1462.5393001204623;1490.8061951946247;1634.861036811871;1793.488855676131;1807.0783900210888;8039.276465118138;8483.703070392537;8484.787880302996;8491.980962284519;8495.447795893262;7451.217622149664;7674.808129796744;7691.115521715004;7934.246246606577;8253.876191857127;2305.3545007397956;2344.367020904355;2346.23747282134;2347.7652234776556;2353.0234952494693;2325.058351367699;2360.7757263060066;2367.4673198530363;2378.2389635316704;2379.976200237993;2044.4582185720797;2118.682197670354;2123.8088572028514;2259.7853203945597;2314.5023819878725;2328.604137296664;2341.4731685370825;2342;2342.7774361435636;2347.753485883983;2332.6151185054446;2341.519988402373;2362.9409264768346;2370.620700687899;2372.0630351011428;8256.587170641444;8274.255317021436;8373.120822313631;8375.162483751637;8396.958015209884;5058.494150584949;5232.607554433433;5236.581073514109;5239.502247286502;5239.79040838366;3269.395161895033;3459.290845376692;3537.557805274341;3539.2744487380023;3546.1666508370513;1021.6475316016036;1057.7672911959357;1095.3263742798201;1095.6767753512734;1097.1168209591276;10929.672109836718;10931;10933.016028557468;10968.23222374434;10987.340759554372;4607.861764147081;4803.711777293373;4804.855854324306;4825.372701548777;4837.105135549935;8629.266512346396;8675.6529738811;8676.392652514389;8690.304775617935;8694.521801300863;5116;5116.283720279164;5117.437081920985;5120.334356533627;5121.590272778169;4615.561521655437;4750.14497390473;4796.160671882407;4851.320815085891;4858.149823780825;3591.245838373971;3647.6170002149925;3684;3725.441183822394;3746.7751934883995;989.7278248481581;1075.676917391597;1117.6255954255253;1120.9887901120885;1138.618562781461;781.2148790465545;873.8470767615769;891.233539156325;911.3256190419042;912.5209265135724;5746.626469279484;5754.6547207167705;5810.460228039573;5860.179574859523;5903.940960590339;905.4386280506128;912.6577533424966;916.3768637326682;920.8204400141908;959.5633986536109;3688.8524459021874;3733.439984002367;3746.213295208037;3762.191128907298;3779.7921114338974;8646.827063458695;9825.557849896772;10038;10110.342827716322;10113.443760593238;10161.593536258615;10166.390016599027;10179.694609161737;10187.847182292271;10188.235882308856;7667.923320766721;7806.492577982526;7818.921810781933;7841.451098423056;7871.685132594632;5458.454154584669;5526.80656177048;5564.888702226014;5720.48515633595;5791.826245212482;9308.813823723623;9343.626254949726;9441.669541566287;9515;9531.714048578553;9339.392939458914;9473.57368918414;9497.43015419077;9559.713208603753;9698.95150524271;7033.788986330418;7179.353858152583;7213.278672132745;7265.164506081868;7273.0181425509;7821.022372203474;7833.216678332121;7904.13054564009;7910.288074073361;7912;6635.303293154149;6976.825579360557;7113.359797618239;7165.426765858823;7244.985702001829;6897.655117244018;7001.299870012958;7003.159620845531;7036.788896333118;7052.929470705432;6486.318936511599;6633.900491492535;6638.966805165944;6644.667766611747;6646.2356828965285;4744.952550474451;4871.95128048715;4878.707277563358;4895.388076490439;4923.310736496965;4753.429588449269;4789.425268967746;4801.639877009168;4983.053219888355;5002.9994001199175 08:35:06 INFO - PROCESS | 1641 | |4;prototype.html;282.5535653667206;292.52464744789717;296.38943775821804;305.46848483638473;312.83107122154024;4800.727807131113;4994.875128121799;5027.597792176626;5258.474152584739;5275.208718692198;4162.2321156430935;4257.76582287974;5072.619553533491;5165.405978312495;5182.559482443988;3507.6492350764975;3960.603939606045;3983.382575700771;3999.600039996006;4017.2969730297227;3469.1673998240367;3774.603666615007;3785.8864234072885;3963.385675220331;3995.9800200998952;3128.6558478567454;3382.697661400366;3921;3928.921421571567;3939.803009849496;2995.505741552641;3286.047046356554;3903.473031140788;3931.5282166140246;3940.8423663053586;2885.6825749167574;3414.2928535732135;3429.0398688367295;3443.6728510791436;3447.827608619584;4513.300438432048;4755.571998520115;4848.903021939576;4849.224124140121;4997.700137991732;4013.7190396672245;4081.3061779497557;4104.8152833122585;4136.896577585584;4263.317869140954;4460.821567137311;4879.853604391874;5048.027692722665;5244.16093425054;5430.56555475565;3483.529723487322;3604.2250916052913;3731.7574357666663;3747.850085996557;3769.5853456119803;5646.632968857052;5683.261176047087;5684.687342196177;5732.541396688297;5735.992402659078;3773.471713960048;3776.15036616759;3781.7920014399474;3791.6777073949024;3796.202797412519;3416.931661366759;3439.0370696205105;3675.6216418842932;3717.3308804414924;3813.7139714521522;3962.5641179470235;4240.681948853849;4388.204203364131;4454.354118652842;4469.888252793706;5212.791488340424;5387.0841956867425;5431.8098866539485;5469.699166545799;5482.23248745176;1113.6881673131536;1234.388977456147;1255.0963306419546;1256.0705078242036;1256.8680288569751;712.8182313510022;760.5284723471373;845.25617456639;852.9019162796234;864.9015749997468;4241.4404515145725;4715.4577223619035;4740.857774266778;4768.495156060293;4771.761411929459;4294;5209.95800839826;5235.973820130951;5254.528731955059;5299;4331;4460.1971645104195;4695.976520117378;4713.929291060636;4786.473487916326;2414.5995322712783;2486.5772818620876;2764.25365151412;2784.9303767405977;2799.7060308667296;4645;5352.839414817562;5469.179623056573;5525.861853453615;5527.944720552823;5157.690538567698;5326.36083669962;5349.732513374393;5421.403645598981;5456.854060647309;4592;4894.681845680019;4923.8276660316715;5164.328637277205;5449.373322067933;4257.361395790656;4265.552117027667;4579.404677391918;4782.928256076231;5205.657454145574;4410.977945110254;4541.659375546913;4936.580390666833;5185.847873132608;5446.400895901368;5488.533474654699;5778.624389414675;5795.217645617788;5816.47651711348;5819.941800582109;3145.735070749057;3389.8305084746394;3743;3778.5465744110884;3786.981065094767;4395.340698895191;5171.870703232449;5581.609287349846;5595.251181708347;5631.352394474688;5422.674639521641;5441.014029879145;5443.673379597237;5467.5625949923115;5471.835844924659;4753.595944344769;4785.569298763128;5060.165072762953;5180.922286165635;5443.673379597237;4338.848140315074;4468.396766436489;4910.8772280693265;5364.4099149094345;5367.3827509836865;5350.9732451337495;5411.567074633941;5423.213634023124;5434;5483.314585676791;4538.319252112209;4887.6783527824;5301.310829592128;5326.573874089986;5338.54622357104 08:35:06 INFO - PROCESS | 1641 | |5;yui.html;681.8363592737743;717.5674463568504;781.6739772268994;789.6091434739805;793.626995312203;13920;14542.127472351653;14566.198859062748;14611.853881461195;14653.633659158526;12500.437480313385;12582.496700131984;12695.555655552058;12727.554535591256;12810.67973300668;648.1768154443854;781.2890269854448;813.4102775487784;816.4692949582759;820.7332616899531;656.4518626946506;664.3555750921598;796.5857753967933;825.8307047055339;828.4449418889328;856.8243510080418;858.0775666158904;858.8368210040072;862.5773371048173;864.4899509289518;853.9359548033922;854.2695994924375;854.786303424144;856.6230858422306;856.6530555125184;498.5114587704034;506.9391672999227;602.6113157013701;619.7799781077742;641.9165508483914;13973.301334933314;14020.298985050707;14043.859561404357;14049.157050576998;14060.92969535156;12809.039322050883;12908.16096953695;13058.2817945013;13147.60557183286;13158.144720593227;11376.146788990776;11831.467583958742;11860.52557897683;12167.452464639113;12393.442295096742;4317.352397140423;4343.9348409773875;4421.579949904753;4470.441194850644;4472.664550158718;78951.21048789553;82679;87483;89509;89580;10155.492225388702;10380.325278857;10475.371477711362;10508.632197873038;10579.36523808574;19136.904315478612;19222.423327300203;19387.61224775525;19419.51451213731;19434.319798806973;6959.82600434983;7077.5753454792875;7160.069191005136;7487.5507469552;7522.924770752223;4102.138550904344;4141;4200.306949353384;4224.809883555247;4273.87178384649;3223.2747631782663;3328.484084966834;3349.732021438279;3350.27968986669;3353.9496907546404;618.5113760129537;626.9090981807703;627.3130921640796;632.34552238433;636.3254949753276;549.4615277028535;604.8760004199129;620.6307247187916;624.3600309682612;633.8542135308812;8307.792305192419;8544.829103417896;8599.183077607617;8697.695345698196;8743.825123497621;556.774506324939;568.2130249604328;579.9159121927297;600.3726106219011;633.8415396150963;4053.959460405358;4192.3711443283755;4199.223143718361;4249.87250382489;4314.1371725655;82179;108582;108867.45566272276;110114;113725.43137284426;92506.53746731223;92998.53500732454;93945;94882;95910.52044739871;68226;68462.9730554042;69209.61580768357;84475;84949.57525212334;9220.631174753204;9511.429314241168;9560.713178604376;9698.70903872885;9751.073648003428;46530;47701.04597908092;49878.50121498739;50057.749711251214;51448.48551514437;46620.76689616666;55223.723881380334;67128.66435667986;68268.3173168262;71578.64210678914;11607.825882611598;11754.707697812739;11782.293062416282;11885.821712674144;11910.166288359731;11805.527778888749;13236.279283693058;13935.372908218951;13971.930140349234;14134.15195088298;12749.49002039908;12839.050707605438;13429.932850336078;13788.93105534466;13860.722785544434;11555.826662600235;11572.6528204154;12432.751344972869;12496.937515312366;12712.110152289251;12503;12697.301648409426;12798.16811907223;12820.551280705504;13235.669108271984;10045;10770.873159710953;10840.295380800222;10844.45777711127;11005.229633925548;10478.79042419132;10812.56749730002;11086.556537738723;11189.552417903193;11267.7746445069 08:35:06 INFO - PROCESS | 1641 | __end_tp_report 08:35:06 INFO - PROCESS | 1641 | __start_cc_report 08:35:06 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,2554 08:35:06 INFO - PROCESS | 1641 | __end_cc_report 08:35:06 INFO - PROCESS | 1641 | __startTimestamp1483288506936__endTimestamp 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | ------- Summary: start ------- 08:35:06 INFO - PROCESS | 1641 | Number of tests: 6 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5740.10 Median:5997.52 stddev:666.80 (11.1%) stddev-sans-first:629.33 08:35:06 INFO - PROCESS | 1641 | Values: 2857.6 2986.9 3171.6 3333.9 3355.7 5640.9 5676.7 5710.0 5744.5 5761.2 5679.5 5705.4 5731.8 5763.7 5768.4 5083.2 5244.0 5267.6 5277.1 5302.3 5193.0 5206.3 5208.8 5339.7 5373.7 5247.3 5279.7 5280.0 5283.2 5294.7 5270.8 5273.9 5278.7 5282.7 5294.5 5132.0 5215.3 5237.5 5240.5 5271.4 5797.5 5798.9 5809.7 5815.4 5819.9 6102.3 6148.2 6157.5 6164.8 6165.6 6220.3 6242.0 6245.6 6260.9 6295.8 5718.5 5761.8 5764.3 5765.7 5771.7 6282.6 6374.6 6376.4 6389.5 6395.0 5994.2 6008.1 6057.0 6067.1 6108.7 6187.4 6218.2 6277.6 6287.3 6299.3 6025.6 6185.2 6229.8 6233.5 6239.5 6134.5 6147.2 6169.0 6169.1 6184.4 4878.4 4908.6 4909.3 4915.1 4949.9 4430.4 4440.7 4442.2 4449.6 4484.4 5616.7 5654.5 5678.6 5696.6 5766.9 6344.8 6347.3 6354.1 6354.5 6370.3 5678.9 5743.0 5748.2 5750.4 5814.0 4754.7 5106.3 5416.2 5424.3 5427.2 6177.1 6258.7 6273.7 6302.1 6330.7 6300.4 6320.9 6327.3 6335.8 6343.0 6268.7 6327.9 6330.8 6343.5 6344.8 5974.0 6065.8 6083.6 6100.1 6130.4 4871.9 6041.3 6161.6 6242.0 6247.9 6054.9 6064.2 6117.4 6126.8 6147.7 6136.3 6142.8 6164.4 6165.1 6183.2 5742.1 5974.2 5997.4 5997.5 6010.5 5927.8 6027.1 6034.8 6102.8 6119.8 6051.3 6051.6 6086.9 6094.3 6102.3 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:63913.65 Median:36513.04 stddev:145295.54 (397.9%) stddev-sans-first:145625.06 08:35:06 INFO - PROCESS | 1641 | Values: 476.8 488.7 502.2 505.0 555.1 37856.2 39308.0 39625.4 40983.6 41070.6 40652.6 41006.6 41221.2 41263.4 41265.5 9237.7 9398.1 9413.5 9414.4 9423.7 9331.7 9449.5 9456.1 9456.4 9489.0 9465.4 9492.3 9496.2 9501.9 9505.0 9396.7 9460.9 9473.9 9476.3 9487.6 9293.0 9361.6 9362.6 9370.0 9382.6 38647.6 38916.8 38965.6 39132.8 39169.4 3168.8 3300.7 3319.1 3326.6 3538.6 24005.0 25170.6 26945.2 27630.4 28149.7 3141.4 3183.8 3189.8 3255.7 3278.9 363655.0 363728.0 364144.0 364422.0 364921.0 30346.8 30832.7 31129.8 54151.2 54481.5 33289.0 33293.8 33310.5 33362.3 33400.0 14064.6 14245.5 14278.5 14288.5 14292.1 11979.3 12025.0 12028.7 12047.4 12052.2 7602.6 7613.5 7683.8 7693.9 7708.1 2668.2 3176.3 3181.0 3182.8 3215.1 891.7 1001.3 1015.0 1040.7 1083.7 27698.2 28333.9 28678.6 29123.1 29155.6 858.3 1004.3 1020.2 1043.3 1047.8 13851.4 14294.9 14518.0 14539.9 14581.5 582908.0 674269.0 674417.0 675311.0 680569.0 51635.7 52155.2 52180.0 52181.0 52227.0 1166.9 1206.9 1254.8 1336.0 1385.0 27550.0 27672.4 28836.9 28947.3 29467.7 45339.5 46132.8 46271.1 46371.5 46373.1 552023.0 558501.0 560023.0 561062.0 562687.0 25353.6 26285.7 26395.6 26881.0 26890.5 43371.1 43423.6 43528.3 43777.0 44157.9 36733.0 36931.3 37032.6 37060.0 37470.8 36452.0 36558.6 36682.6 37085.0 37535.8 35607.3 35760.0 36435.1 36503.8 36522.3 28463.0 30776.5 32677.8 33271.3 33322.5 24336.9 24562.8 24745.1 24968.3 25347.7 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34046.84 Median:388.38 stddev:99086.92 (25512.6%) stddev-sans-first:99332.57 08:35:06 INFO - PROCESS | 1641 | Values: 347.8 365.4 367.0 380.1 396.7 14784.3 14884.9 16075.5 20386.8 20421.1 19589.3 19708.6 20170.7 20414.7 20484.5 5610.7 5683.6 5862.3 5862.9 5870.7 5072.6 5707.7 5759.3 5760.3 5762.0 5469.6 5698.5 5712.7 5713.8 5718.5 5636.3 5754.5 5757.0 5760.1 5762.2 5067.4 5071.2 5087.3 5098.4 5401.2 12812.7 12890.4 13055.0 13058.5 13060.7 2140.5 2145.6 2152.2 2175.9 2311.9 9498.8 9699.1 10001.3 10084.4 10213.4 1789.8 1802.8 1806.3 1834.7 1883.5 116458.4 121284.0 122312.0 123992.0 130573.0 9425.8 11216.3 11453.4 11561.9 11585.5 13992.2 14517.1 14519.6 14530.9 14538.7 8108.9 8355.6 8357.1 8457.5 8458.9 8231.6 8234.9 8245.4 8417.7 8497.4 3962.8 4319.0 4408.9 4486.9 4510.3 1713.6 1730.7 1764.5 1828.2 1901.4 801.8 864.5 919.8 941.7 949.0 20217.5 20557.0 20875.3 20887.9 21013.3 882.2 915.0 943.4 987.9 994.9 10421.2 10914.8 10989.3 10992.9 11016.8 580019.2 581154.0 591885.0 605520.0 606042.0 122198.4 122212.0 124767.0 125013.0 126079.0 797.8 833.7 876.2 962.0 978.4 17294.7 18571.4 18679.9 19627.3 19726.2 39765.8 48990.3 50248.5 51785.5 54492.6 67050.3 68856.3 70780.6 77570.0 79852.8 6308.4 7443.3 7996.0 8011.8 8160.2 9463.1 11810.7 12350.3 12684.9 12691.4 10868.9 10911.9 10913.6 11040.4 11276.5 8496.7 9040.5 10951.7 10982.8 11181.7 9344.7 10805.1 11047.8 11274.7 11368.3 7887.9 7923.6 8158.6 8282.6 8375.9 9050.6 10174.9 11189.7 11193.6 11244.0 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5433.75 Median:5118.89 stddev:2956.23 (57.8%) stddev-sans-first:2949.45 08:35:06 INFO - PROCESS | 1641 | Values: 1462.5 1490.8 1634.9 1793.5 1807.1 8039.3 8483.7 8484.8 8492.0 8495.4 7451.2 7674.8 7691.1 7934.2 8253.9 2305.4 2344.4 2346.2 2347.8 2353.0 2325.1 2360.8 2367.5 2378.2 2380.0 2044.5 2118.7 2123.8 2259.8 2314.5 2328.6 2341.5 2342.0 2342.8 2347.8 2332.6 2341.5 2362.9 2370.6 2372.1 8256.6 8274.3 8373.1 8375.2 8397.0 5058.5 5232.6 5236.6 5239.5 5239.8 3269.4 3459.3 3537.6 3539.3 3546.2 1021.6 1057.8 1095.3 1095.7 1097.1 10929.7 10931.0 10933.0 10968.2 10987.3 4607.9 4803.7 4804.9 4825.4 4837.1 8629.3 8675.7 8676.4 8690.3 8694.5 5116.0 5116.3 5117.4 5120.3 5121.6 4615.6 4750.1 4796.2 4851.3 4858.1 3591.2 3647.6 3684.0 3725.4 3746.8 989.7 1075.7 1117.6 1121.0 1138.6 781.2 873.8 891.2 911.3 912.5 5746.6 5754.7 5810.5 5860.2 5903.9 905.4 912.7 916.4 920.8 959.6 3688.9 3733.4 3746.2 3762.2 3779.8 8646.8 9825.6 10038.0 10110.3 10113.4 10161.6 10166.4 10179.7 10187.8 10188.2 7667.9 7806.5 7818.9 7841.5 7871.7 5458.5 5526.8 5564.9 5720.5 5791.8 9308.8 9343.6 9441.7 9515.0 9531.7 9339.4 9473.6 9497.4 9559.7 9699.0 7033.8 7179.4 7213.3 7265.2 7273.0 7821.0 7833.2 7904.1 7910.3 7912.0 6635.3 6976.8 7113.4 7165.4 7245.0 6897.7 7001.3 7003.2 7036.8 7052.9 6486.3 6633.9 6639.0 6644.7 6646.2 4745.0 4872.0 4878.7 4895.4 4923.3 4753.4 4789.4 4801.6 4983.1 5003.0 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4262.10 Median:4714.69 stddev:1318.51 (28.0%) stddev-sans-first:1287.93 08:35:06 INFO - PROCESS | 1641 | Values: 282.6 292.5 296.4 305.5 312.8 4800.7 4994.9 5027.6 5258.5 5275.2 4162.2 4257.8 5072.6 5165.4 5182.6 3507.6 3960.6 3983.4 3999.6 4017.3 3469.2 3774.6 3785.9 3963.4 3996.0 3128.7 3382.7 3921.0 3928.9 3939.8 2995.5 3286.0 3903.5 3931.5 3940.8 2885.7 3414.3 3429.0 3443.7 3447.8 4513.3 4755.6 4848.9 4849.2 4997.7 4013.7 4081.3 4104.8 4136.9 4263.3 4460.8 4879.9 5048.0 5244.2 5430.6 3483.5 3604.2 3731.8 3747.9 3769.6 5646.6 5683.3 5684.7 5732.5 5736.0 3773.5 3776.2 3781.8 3791.7 3796.2 3416.9 3439.0 3675.6 3717.3 3813.7 3962.6 4240.7 4388.2 4454.4 4469.9 5212.8 5387.1 5431.8 5469.7 5482.2 1113.7 1234.4 1255.1 1256.1 1256.9 712.8 760.5 845.3 852.9 864.9 4241.4 4715.5 4740.9 4768.5 4771.8 4294.0 5210.0 5236.0 5254.5 5299.0 4331.0 4460.2 4696.0 4713.9 4786.5 2414.6 2486.6 2764.3 2784.9 2799.7 4645.0 5352.8 5469.2 5525.9 5527.9 5157.7 5326.4 5349.7 5421.4 5456.9 4592.0 4894.7 4923.8 5164.3 5449.4 4257.4 4265.6 4579.4 4782.9 5205.7 4411.0 4541.7 4936.6 5185.8 5446.4 5488.5 5778.6 5795.2 5816.5 5819.9 3145.7 3389.8 3743.0 3778.5 3787.0 4395.3 5171.9 5581.6 5595.3 5631.4 5422.7 5441.0 5443.7 5467.6 5471.8 4753.6 4785.6 5060.2 5180.9 5443.7 4338.8 4468.4 4910.9 5364.4 5367.4 5351.0 5411.6 5423.2 5434.0 5483.3 4538.3 4887.7 5301.3 5326.6 5338.5 08:35:06 INFO - PROCESS | 1641 | 08:35:06 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19422.79 Median:4382.76 stddev:28173.79 (642.8%) stddev-sans-first:28217.68 08:35:06 INFO - PROCESS | 1641 | Values: 681.8 717.6 781.7 789.6 793.6 13920.0 14542.1 14566.2 14611.9 14653.6 12500.4 12582.5 12695.6 12727.6 12810.7 648.2 781.3 813.4 816.5 820.7 656.5 664.4 796.6 825.8 828.4 856.8 858.1 858.8 862.6 864.5 853.9 854.3 854.8 856.6 856.7 498.5 506.9 602.6 619.8 641.9 13973.3 14020.3 14043.9 14049.2 14060.9 12809.0 12908.2 13058.3 13147.6 13158.1 11376.1 11831.5 11860.5 12167.5 12393.4 4317.4 4343.9 4421.6 4470.4 4472.7 78951.2 82679.0 87483.0 89509.0 89580.0 10155.5 10380.3 10475.4 10508.6 10579.4 19136.9 19222.4 19387.6 19419.5 19434.3 6959.8 7077.6 7160.1 7487.6 7522.9 4102.1 4141.0 4200.3 4224.8 4273.9 3223.3 3328.5 3349.7 3350.3 3353.9 618.5 626.9 627.3 632.3 636.3 549.5 604.9 620.6 624.4 633.9 8307.8 8544.8 8599.2 8697.7 8743.8 556.8 568.2 579.9 600.4 633.8 4054.0 4192.4 4199.2 4249.9 4314.1 82179.0 108582.0 108867.5 110114.0 113725.4 92506.5 92998.5 93945.0 94882.0 95910.5 68226.0 68463.0 69209.6 84475.0 84949.6 9220.6 9511.4 9560.7 9698.7 9751.1 46530.0 47701.0 49878.5 50057.7 51448.5 46620.8 55223.7 67128.7 68268.3 71578.6 11607.8 11754.7 11782.3 11885.8 11910.2 11805.5 13236.3 13935.4 13971.9 14134.2 12749.5 12839.1 13429.9 13788.9 13860.7 11555.8 11572.7 12432.8 12496.9 12712.1 12503.0 12697.3 12798.2 12820.6 13235.7 10045.0 10770.9 10840.3 10844.5 11005.2 10478.8 10812.6 11086.6 11189.6 11267.8 08:35:06 INFO - PROCESS | 1641 | -------- Summary: end -------- 08:35:06 INFO - PROCESS | 1641 | 08:35:07 INFO - TEST-INFO | 1641: exit 0 08:35:07 INFO - TEST-OK | dromaeo_css | took 1121097ms 08:35:07 INFO - TEST-START | kraken 08:35:07 INFO - operating with platform_type : mac_ 08:35:07 INFO - Initialising browser for kraken test... 08:35:07 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpjQ3NWI/profile http://localhost:49244/getInfo.html) 08:35:10 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 08:35:10 INFO - PROCESS | 1653 | colorDepth:24 08:35:10 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 08:35:10 INFO - PROCESS | 1653 | __metrics 08:35:10 INFO - PROCESS | 1653 | 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" 08:35:10 INFO - PROCESS | 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:11 INFO - TEST-INFO | 1653: exit 0 08:35:11 INFO - Browser initialized. 08:35:11 INFO - Running cycle 1/1 for kraken test... 08:35:11 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpjQ3NWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:23 INFO - PROCESS | 1654 | RSS: Main: 222846976 08:35:23 INFO - PROCESS | 1654 | 08:35:26 INFO - PROCESS | 1654 | 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) 08:35:27 INFO - PROCESS | 1654 | RSS: Main: 272084992 08:35:27 INFO - PROCESS | 1654 | 08:35:30 INFO - PROCESS | 1654 | 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) 08:35:30 INFO - PROCESS | 1654 | RSS: Main: 282980352 08:35:30 INFO - PROCESS | 1654 | 08:35:33 INFO - PROCESS | 1654 | 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) 08:35:34 INFO - PROCESS | 1654 | RSS: Main: 379912192 08:35:34 INFO - PROCESS | 1654 | 08:35:36 INFO - PROCESS | 1654 | 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) 08:35:37 INFO - PROCESS | 1654 | RSS: Main: 281862144 08:35:37 INFO - PROCESS | 1654 | 08:35:39 INFO - PROCESS | 1654 | 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) 08:35:39 INFO - PROCESS | 1654 | RSS: Main: 283119616 08:35:39 INFO - PROCESS | 1654 | 08:35:42 INFO - PROCESS | 1654 | 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) 08:35:43 INFO - PROCESS | 1654 | RSS: Main: 324591616 08:35:43 INFO - PROCESS | 1654 | 08:35:46 INFO - PROCESS | 1654 | 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) 08:35:46 INFO - PROCESS | 1654 | RSS: Main: 323887104 08:35:46 INFO - PROCESS | 1654 | 08:35:49 INFO - PROCESS | 1654 | 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) 08:35:50 INFO - PROCESS | 1654 | RSS: Main: 324640768 08:35:50 INFO - PROCESS | 1654 | 08:35:51 INFO - PROCESS | 1654 | 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) 08:35:52 INFO - PROCESS | 1654 | RSS: Main: 299159552 08:35:52 INFO - PROCESS | 1654 | 08:35:54 INFO - PROCESS | 1654 | 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) 08:35:54 INFO - PROCESS | 1654 | RSS: Main: 300859392 08:35:54 INFO - PROCESS | 1654 | 08:35:56 INFO - PROCESS | 1654 | 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) 08:35:57 INFO - PROCESS | 1654 | RSS: Main: 303349760 08:35:57 INFO - PROCESS | 1654 | 08:36:00 INFO - PROCESS | 1654 | 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) 08:36:01 INFO - PROCESS | 1654 | RSS: Main: 322912256 08:36:01 INFO - PROCESS | 1654 | 08:36:04 INFO - PROCESS | 1654 | 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) 08:36:04 INFO - PROCESS | 1654 | RSS: Main: 315846656 08:36:04 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | 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) 08:36:06 INFO - PROCESS | 1654 | RSS: Main: 359870464 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | __start_tp_report 08:36:06 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 08:36:06 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 08:36:06 INFO - PROCESS | 1654 | |i|pagename|runs| 08:36:06 INFO - PROCESS | 1654 | |0;ai-astar;117;115;114;113;114;114;113;113;113;114 08:36:06 INFO - PROCESS | 1654 | |1;audio-beat-detection;145;108;111;151;140;99;126;143;175;109 08:36:06 INFO - PROCESS | 1654 | |2;audio-dft;182;180;184;183;180;183;184;184;185;185 08:36:06 INFO - PROCESS | 1654 | |3;audio-fft;82;58;59;89;61;59;60;58;82;60 08:36:06 INFO - PROCESS | 1654 | |4;audio-oscillator;90;70;96;82;97;100;118;68;69;93 08:36:06 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;87;90;87;90;87;91;89;92;129 08:36:06 INFO - PROCESS | 1654 | |6;imaging-darkroom;94;95;93;103;96;95;94;94;94;96 08:36:06 INFO - PROCESS | 1654 | |7;imaging-desaturate;81;83;81;87;80;83;86;85;82;82 08:36:06 INFO - PROCESS | 1654 | |8;json-parse-financial;55;54;52;56;56;57;57;59;57;57 08:36:06 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;69;73;80;73;72;70;72;70;71;72 08:36:06 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;86;95;84;83;84;82;83;82;83;83 08:36:06 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;141;143;148;154;141;143;141;144;232;147 08:36:06 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;169;165;163;165;163;165;164;164;162;164 08:36:06 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;67;67;69;67;67;67;71;68;66;66 08:36:06 INFO - PROCESS | 1654 | __end_tp_report 08:36:06 INFO - PROCESS | 1654 | __start_cc_report 08:36:06 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2019 08:36:06 INFO - PROCESS | 1654 | __end_cc_report 08:36:06 INFO - PROCESS | 1654 | __startTimestamp1483288566622__endTimestamp 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | ------- Summary: start ------- 08:36:06 INFO - PROCESS | 1654 | Number of tests: 14 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:0.71 08:36:06 INFO - PROCESS | 1654 | Values: 117.0 115.0 114.0 113.0 114.0 114.0 113.0 113.0 113.0 114.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:144.00 stddev:24.08 (16.7%) stddev-sans-first:24.98 08:36:06 INFO - PROCESS | 1654 | Values: 145.0 108.0 111.0 151.0 140.0 99.0 126.0 143.0 175.0 109.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.00 Median:184.00 stddev:1.83 (1.0%) stddev-sans-first:1.90 08:36:06 INFO - PROCESS | 1654 | Values: 182.0 180.0 184.0 183.0 180.0 183.0 184.0 184.0 185.0 185.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.80 Median:60.50 stddev:12.28 (20.3%) stddev-sans-first:11.73 08:36:06 INFO - PROCESS | 1654 | Values: 82.0 58.0 59.0 89.0 61.0 59.0 60.0 58.0 82.0 60.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:86.00 stddev:16.12 (18.7%) stddev-sans-first:17.08 08:36:06 INFO - PROCESS | 1654 | Values: 90.0 70.0 96.0 82.0 97.0 100.0 118.0 68.0 69.0 93.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:89.50 stddev:12.73 (14.2%) stddev-sans-first:13.42 08:36:06 INFO - PROCESS | 1654 | Values: 89.0 87.0 90.0 87.0 90.0 87.0 91.0 89.0 92.0 129.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:94.50 stddev:2.84 (3.0%) stddev-sans-first:2.96 08:36:06 INFO - PROCESS | 1654 | Values: 94.0 95.0 93.0 103.0 96.0 95.0 94.0 94.0 94.0 96.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:83.00 Median:83.00 stddev:2.31 (2.8%) stddev-sans-first:2.33 08:36:06 INFO - PROCESS | 1654 | Values: 81.0 83.0 81.0 87.0 80.0 83.0 86.0 85.0 82.0 82.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.94 (3.4%) stddev-sans-first:2.03 08:36:06 INFO - PROCESS | 1654 | Values: 55.0 54.0 52.0 56.0 56.0 57.0 57.0 59.0 57.0 57.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:3.05 (4.2%) stddev-sans-first:3.00 08:36:06 INFO - PROCESS | 1654 | Values: 69.0 73.0 80.0 73.0 72.0 70.0 72.0 70.0 71.0 72.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:3.87 (4.6%) stddev-sans-first:4.06 08:36:06 INFO - PROCESS | 1654 | Values: 86.0 95.0 84.0 83.0 84.0 82.0 83.0 82.0 83.0 83.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:145.50 stddev:27.92 (19.2%) stddev-sans-first:29.25 08:36:06 INFO - PROCESS | 1654 | Values: 141.0 143.0 148.0 154.0 141.0 143.0 141.0 144.0 232.0 147.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.50 stddev:1.90 (1.2%) stddev-sans-first:1.05 08:36:06 INFO - PROCESS | 1654 | Values: 169.0 165.0 163.0 165.0 163.0 165.0 164.0 164.0 162.0 164.0 08:36:06 INFO - PROCESS | 1654 | 08:36:06 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 08:36:06 INFO - PROCESS | 1654 | Values: 67.0 67.0 69.0 67.0 67.0 67.0 71.0 68.0 66.0 66.0 08:36:06 INFO - PROCESS | 1654 | -------- Summary: end -------- 08:36:06 INFO - PROCESS | 1654 | 08:36:07 INFO - TEST-INFO | 1654: exit 0 08:36:07 INFO - TEST-OK | kraken | took 59972ms 08:36:07 INFO - SUITE-END | took 1181s 08:36:07 INFO - Completed test suite (00:19:41) 08:36:07 INFO - javascript benchmark 08:36:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2857.571364295356, 2986.9103926882203, 3171.619405671321, 3333.9333213335735, 3355.714764245039, 5640.858978525539, 5676.744546495407, 5709.971450142749, 5744.454276843699, 5761.222234998285, 5679.545636349082, 5705.372409035002, 5731.770729170828, 5763.711814409284, 5768.394318596539, 5083.1612783890705, 5244.0, 5267.631265811395, 5277.102892508264, 5302.284191634138, 5193.013327467788, 5206.349206349207, 5208.791648334081, 5339.679619222839, 5373.650712703681, 5247.2653828464045, 5279.736013199325, 5280.0, 5283.207518872162, 5294.735263236823, 5270.7628156733035, 5273.920891186635, 5278.656887302352, 5282.65662731925, 5294.497022782849, 5131.974340128276, 5215.348081489814, 5237.528622423962, 5240.52835244826, 5271.420143784219, 5797.507211886995, 5798.9130163047585, 5809.6804675742815, 5815.360310365856, 5819.854503637401, 6102.314311391842, 6148.231471066117, 6157.476614487774, 6164.815055548341, 6165.568410211287, 6220.346863579304, 6242.032484964792, 6245.594036387665, 6260.87478250437, 6295.779647712308, 5718.48533631971, 5761.827145185651, 5764.33710123337, 5765.740541675635, 5771.740271687784, 6282.560220784501, 6374.617522948638, 6376.39424254695, 6389.520785941073, 6394.968025159845, 5994.190784244159, 6008.098785182257, 6057.030875059969, 6067.089936509471, 6108.725107370179, 6187.443130118311, 6218.22272215973, 6277.591956522811, 6287.308396076428, 6299.338569450233, 6025.6083354581815, 6185.226846644169, 6229.844253893598, 6233.470155036782, 6239.532035097295, 6134.5092392608485, 6147.170132032208, 6168.982117950488, 6169.074638804215, 6184.412480814315, 4878.390201224847, 4908.605258436838, 4909.2881532177635, 4915.11527924977, 4949.901001980013, 4430.379746835446, 4440.71135376206, 4442.244818380883, 4449.644028477714, 4484.417025786692, 5616.66300022, 5654.5193658538665, 5678.630888992202, 5696.629719068247, 5766.913496297559, 6344.809655710336, 6347.333529979285, 6354.078658594478, 6354.459870910932, 6370.299267080617, 5678.886422271531, 5742.971285143631, 5748.19525266463, 5750.396208398141, 5813.970930145322, 4754.7147171169845, 5106.285120083191, 5416.214648875891, 5424.349078110652, 5427.213054107132, 6177.073438984008, 6258.718357673824, 6273.65494897785, 6302.086197501245, 6330.683465826598, 6300.401461861115, 6320.873582528416, 6327.272363678236, 6335.778247761306, 6343.0, 6268.717907694074, 6327.936720632919, 6330.841728956813, 6343.492520598434, 6344.777932772331, 5973.954557952427, 6065.848353791191, 6083.574149809471, 6100.145979562776, 6130.367562715148, 4871.878203044952, 6041.2750469943885, 6161.599496032743, 6241.96879015602, 6247.937520624736, 6054.90917636227, 6064.241969753781, 6117.401149625394, 6126.823043872828, 6147.66187859672, 6136.29432615255, 6142.78500252489, 6164.4143806338325, 6165.106059621419, 6183.196184495987, 5742.109972954198, 5974.163617093697, 5997.370276120944, 5997.520198384206, 6010.4891084258325, 5927.792527261525, 6027.126066720213, 6034.788782392595, 6102.816915492543, 6119.837693858789, 6051.304100028553, 6051.576389652682, 6086.934786412448, 6094.299155597163, 6102.267727872683], "value": 5693.983254608768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.7794446217683, 488.7482946282665, 502.19899260679216, 504.98485045448626, 555.1090499747902, 37856.24287514248, 39308.0, 39625.40561891567, 40983.59016409835, 41070.58929410705, 40652.59347406525, 41006.58993410065, 41221.17557648845, 41263.38104928428, 41265.460799312124, 9237.722868313927, 9398.060193980615, 9413.48225847578, 9414.388064775801, 9423.670171543998, 9331.720048398525, 9449.527523623825, 9456.148946594805, 9456.432614043179, 9489.0, 9465.432074075543, 9492.288078394113, 9496.192823609967, 9501.857472137888, 9505.0, 9396.718098457022, 9460.858087128732, 9473.857892131624, 9476.336656434052, 9487.620495180185, 9292.953535232347, 9361.578728957213, 9362.578683959238, 9370.0, 9382.624695012191, 38647.61352386468, 38916.80541597302, 38965.61034389676, 39132.80433597814, 39169.412458812854, 3168.778185527014, 3300.6534313897178, 3319.1204330852343, 3326.550915626384, 3538.5576802899636, 24005.0, 25170.622440663406, 26945.191644250703, 27630.44739105227, 28149.718502814914, 3141.371675912341, 3183.8248896310693, 3189.7926634768664, 3255.6744325567493, 3278.934421311584, 363654.9999999974, 363728.0, 364144.0, 364422.0, 364921.0, 30346.84826575897, 30832.69167308343, 31129.8443507781, 54151.18773218405, 54481.45518544843, 33289.0, 33293.83353083219, 33310.50034249488, 33362.332753344795, 33400.0, 14064.578062658136, 14245.501407450689, 14278.500252491112, 14288.49990250357, 14292.142471451747, 11979.28124312544, 12025.0, 12028.699282517831, 12047.39763011846, 12052.216605920587, 7602.581857997752, 7613.505122167041, 7683.807904802425, 7693.884591731128, 7708.113566939874, 2668.226214397842, 3176.285335799427, 3181.0, 3182.79311844734, 3215.1158431431077, 891.6789955615973, 1001.3291094966245, 1014.9647359693072, 1040.6721882606955, 1083.6694808083453, 27698.169054928385, 28333.858330708215, 28678.569821452278, 29123.12630621085, 29155.562666559596, 858.2576071697937, 1004.3120462483222, 1020.1532727835878, 1043.3270540501485, 1047.7747284333905, 13851.445942162401, 14294.856411487057, 14517.98374113802, 14539.92730036343, 14581.489647862274, 582908.0, 674269.0, 674417.0, 675311.0, 680569.0, 51635.741821291405, 52155.21767173496, 52180.0, 52180.95638087217, 52227.0, 1166.877477864812, 1206.9275843449245, 1254.8305978692943, 1335.966600834948, 1384.9861501385058, 27550.0, 27672.446551069268, 28836.855815720788, 28947.276318092216, 29467.705322946495, 45339.546604533534, 46132.769336153106, 46271.07457850757, 46371.53628463672, 46373.07253854837, 552023.0, 558501.0, 560023.0, 561062.0, 562687.0, 25353.619695704947, 26285.737142628328, 26395.60406593941, 26881.0, 26890.462190756465, 43371.13257734891, 43423.56576434321, 43528.34707479327, 43777.0, 44157.89605259894, 36733.0, 36931.26137477181, 37032.62967370292, 37060.0, 37470.812645936596, 36452.0, 36558.63441365552, 36682.63317366792, 37085.0, 37535.81232093822, 35607.28785424329, 35760.0, 36435.089122772144, 36503.817480912425, 36522.26955460929, 28463.0, 30776.46117694151, 32677.836610816794, 33271.33457330888, 33322.500162498065, 24336.90483928192, 24562.754372456046, 24745.133920312703, 24968.253492116215, 25347.746522534537], "value": 17663.105385395793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7774224496321, 365.4171596303895, 366.9596344402117, 380.10295702142946, 396.6667998880939, 14784.334704938277, 14884.92557537212, 16075.517734467956, 20386.796132038675, 20421.08105135269, 19589.314373996913, 19708.605827883435, 20170.69743953842, 20414.69377959328, 20484.487887802814, 5610.66336019838, 5683.571199875819, 5862.267216597926, 5862.912056319158, 5870.677112758796, 5072.6195535335, 5707.6575405475805, 5759.280089988752, 5760.279965004374, 5762.0, 5469.617126801126, 5698.487136157745, 5712.685802280873, 5713.77144914205, 5718.456746609087, 5636.2954630671165, 5754.4533269339345, 5756.992526307879, 5760.10718338654, 5762.164486149506, 5067.366579177603, 5071.18860982241, 5087.287779710843, 5098.439171691111, 5401.189821526763, 12812.743745125139, 12890.355482225945, 13055.0, 13058.542950996669, 13060.738785224337, 2140.518383363746, 2145.5923374558784, 2152.182170775111, 2175.9347219583437, 2311.91908283211, 9498.810023799486, 9699.127078562893, 10001.349912255753, 10084.445355505444, 10213.438260895648, 1789.8389144977014, 1802.7603213745917, 1806.2774890043956, 1834.706446968492, 1883.5102873253054, 116458.41770791177, 121284.0, 122312.0, 123992.0, 130573.0, 9425.811483770287, 11216.327020378803, 11453.427328633536, 11561.942190289163, 11585.536578536932, 13992.16047037181, 14517.128972261487, 14519.637009074857, 14530.927345363205, 14538.709225815424, 8108.878366824502, 8355.582220888931, 8357.12250213731, 8457.534835584102, 8458.87311690325, 8231.629576669064, 8234.917650823534, 8245.422820402515, 8417.663293468315, 8497.447665901696, 3962.821673024721, 4319.049809042006, 4408.911821763547, 4486.910261794746, 4510.278355463176, 1713.5544758362666, 1730.6538692261347, 1764.4882983934515, 1828.1773202059126, 1901.391554702482, 801.8476489466983, 864.4985908173245, 919.8160367926441, 941.7410212191702, 948.966786162481, 20217.49456263576, 20557.0, 20875.26936557213, 20887.895560522404, 21013.264535741175, 882.170759486081, 914.9908500915038, 943.3773709351932, 987.9259055570717, 994.9056038357893, 10421.166306695446, 10914.836277455845, 10989.285696429706, 10992.945035274772, 11016.834747478793, 580019.1988480705, 581154.0, 591885.0, 605520.0, 606042.0, 122198.38900805617, 122212.0, 124767.0, 125013.0, 126079.0, 797.7686470923484, 833.6957010691054, 876.2114097312469, 962.0235461007084, 978.4325091446943, 17294.654106918042, 18571.40716544005, 18679.90660046691, 19627.31304404339, 19726.210951561778, 39765.80117099396, 48990.265146022124, 50248.49751502585, 51785.482145178066, 54492.637684058216, 67050.3294967044, 68856.27859303557, 70780.64609676918, 77570.0, 79852.80220796577, 6308.369163083838, 7443.255674432514, 7995.960020199862, 8011.759647210593, 8160.183981601793, 9463.101005404476, 11810.704732381415, 12350.320732359807, 12684.87315126837, 12691.398263356174, 10868.924153442458, 10911.945440272748, 10913.618023369145, 11040.392778396945, 11276.492557834754, 8496.745097646834, 9040.502772347583, 10951.726206844893, 10982.835257471304, 11181.664550063511, 9344.672936447192, 10805.135589152691, 11047.779044419227, 11274.718132046764, 11368.317900925971, 7887.921120788718, 7923.643436045507, 8158.632861521127, 8282.627281772455, 8375.916240837514, 9050.637974481211, 10174.898251017692, 11189.72025699364, 11193.552257909918, 11244.044256237985], "value": 9065.950732377787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.5393001204623, 1490.8061951946247, 1634.861036811871, 1793.488855676131, 1807.0783900210888, 8039.276465118138, 8483.703070392537, 8484.787880302996, 8491.980962284519, 8495.447795893262, 7451.217622149664, 7674.808129796744, 7691.115521715004, 7934.246246606577, 8253.876191857127, 2305.3545007397956, 2344.367020904355, 2346.23747282134, 2347.7652234776556, 2353.0234952494693, 2325.058351367699, 2360.7757263060066, 2367.4673198530363, 2378.2389635316704, 2379.976200237993, 2044.4582185720797, 2118.682197670354, 2123.8088572028514, 2259.7853203945597, 2314.5023819878725, 2328.604137296664, 2341.4731685370825, 2342.0, 2342.7774361435636, 2347.753485883983, 2332.6151185054446, 2341.519988402373, 2362.9409264768346, 2370.620700687899, 2372.0630351011428, 8256.587170641444, 8274.255317021436, 8373.120822313631, 8375.162483751637, 8396.958015209884, 5058.494150584949, 5232.607554433433, 5236.581073514109, 5239.502247286502, 5239.79040838366, 3269.395161895033, 3459.290845376692, 3537.557805274341, 3539.2744487380023, 3546.1666508370513, 1021.6475316016036, 1057.7672911959357, 1095.3263742798201, 1095.6767753512734, 1097.1168209591276, 10929.672109836718, 10931.0, 10933.016028557468, 10968.23222374434, 10987.340759554372, 4607.861764147081, 4803.711777293373, 4804.855854324306, 4825.372701548777, 4837.105135549935, 8629.266512346396, 8675.6529738811, 8676.392652514389, 8690.304775617935, 8694.521801300863, 5116.0, 5116.283720279164, 5117.437081920985, 5120.334356533627, 5121.590272778169, 4615.561521655437, 4750.14497390473, 4796.160671882407, 4851.320815085891, 4858.149823780825, 3591.245838373971, 3647.6170002149925, 3684.0, 3725.441183822394, 3746.7751934883995, 989.7278248481581, 1075.676917391597, 1117.6255954255253, 1120.9887901120885, 1138.618562781461, 781.2148790465545, 873.8470767615769, 891.233539156325, 911.3256190419042, 912.5209265135724, 5746.626469279484, 5754.6547207167705, 5810.460228039573, 5860.179574859523, 5903.940960590339, 905.4386280506128, 912.6577533424966, 916.3768637326682, 920.8204400141908, 959.5633986536109, 3688.8524459021874, 3733.439984002367, 3746.213295208037, 3762.191128907298, 3779.7921114338974, 8646.827063458695, 9825.557849896772, 10038.0, 10110.342827716322, 10113.443760593238, 10161.593536258615, 10166.390016599027, 10179.694609161737, 10187.847182292271, 10188.235882308856, 7667.923320766721, 7806.492577982526, 7818.921810781933, 7841.451098423056, 7871.685132594632, 5458.454154584669, 5526.80656177048, 5564.888702226014, 5720.48515633595, 5791.826245212482, 9308.813823723623, 9343.626254949726, 9441.669541566287, 9515.0, 9531.714048578553, 9339.392939458914, 9473.57368918414, 9497.43015419077, 9559.713208603753, 9698.95150524271, 7033.788986330418, 7179.353858152583, 7213.278672132745, 7265.164506081868, 7273.0181425509, 7821.022372203474, 7833.216678332121, 7904.13054564009, 7910.288074073361, 7912.0, 6635.303293154149, 6976.825579360557, 7113.359797618239, 7165.426765858823, 7244.985702001829, 6897.655117244018, 7001.299870012958, 7003.159620845531, 7036.788896333118, 7052.929470705432, 6486.318936511599, 6633.900491492535, 6638.966805165944, 6644.667766611747, 6646.2356828965285, 4744.952550474451, 4871.95128048715, 4878.707277563358, 4895.388076490439, 4923.310736496965, 4753.429588449269, 4789.425268967746, 4801.639877009168, 4983.053219888355, 5002.9994001199175], "value": 4405.097489513494, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.5535653667206, 292.52464744789717, 296.38943775821804, 305.46848483638473, 312.83107122154024, 4800.727807131113, 4994.875128121799, 5027.597792176626, 5258.474152584739, 5275.208718692198, 4162.2321156430935, 4257.76582287974, 5072.619553533491, 5165.405978312495, 5182.559482443988, 3507.6492350764975, 3960.603939606045, 3983.382575700771, 3999.600039996006, 4017.2969730297227, 3469.1673998240367, 3774.603666615007, 3785.8864234072885, 3963.385675220331, 3995.9800200998952, 3128.6558478567454, 3382.697661400366, 3921.0, 3928.921421571567, 3939.803009849496, 2995.505741552641, 3286.047046356554, 3903.473031140788, 3931.5282166140246, 3940.8423663053586, 2885.6825749167574, 3414.2928535732135, 3429.0398688367295, 3443.6728510791436, 3447.827608619584, 4513.300438432048, 4755.571998520115, 4848.903021939576, 4849.224124140121, 4997.700137991732, 4013.7190396672245, 4081.3061779497557, 4104.8152833122585, 4136.896577585584, 4263.317869140954, 4460.821567137311, 4879.853604391874, 5048.027692722665, 5244.16093425054, 5430.56555475565, 3483.529723487322, 3604.2250916052913, 3731.7574357666663, 3747.850085996557, 3769.5853456119803, 5646.632968857052, 5683.261176047087, 5684.687342196177, 5732.541396688297, 5735.992402659078, 3773.471713960048, 3776.15036616759, 3781.7920014399474, 3791.6777073949024, 3796.202797412519, 3416.931661366759, 3439.0370696205105, 3675.6216418842932, 3717.3308804414924, 3813.7139714521522, 3962.5641179470235, 4240.681948853849, 4388.204203364131, 4454.354118652842, 4469.888252793706, 5212.791488340424, 5387.0841956867425, 5431.8098866539485, 5469.699166545799, 5482.23248745176, 1113.6881673131536, 1234.388977456147, 1255.0963306419546, 1256.0705078242036, 1256.8680288569751, 712.8182313510022, 760.5284723471373, 845.25617456639, 852.9019162796234, 864.9015749997468, 4241.4404515145725, 4715.4577223619035, 4740.857774266778, 4768.495156060293, 4771.761411929459, 4294.0, 5209.95800839826, 5235.973820130951, 5254.528731955059, 5299.0, 4331.0, 4460.1971645104195, 4695.976520117378, 4713.929291060636, 4786.473487916326, 2414.5995322712783, 2486.5772818620876, 2764.25365151412, 2784.9303767405977, 2799.7060308667296, 4645.0, 5352.839414817562, 5469.179623056573, 5525.861853453615, 5527.944720552823, 5157.690538567698, 5326.36083669962, 5349.732513374393, 5421.403645598981, 5456.854060647309, 4592.0, 4894.681845680019, 4923.8276660316715, 5164.328637277205, 5449.373322067933, 4257.361395790656, 4265.552117027667, 4579.404677391918, 4782.928256076231, 5205.657454145574, 4410.977945110254, 4541.659375546913, 4936.580390666833, 5185.847873132608, 5446.400895901368, 5488.533474654699, 5778.624389414675, 5795.217645617788, 5816.47651711348, 5819.941800582109, 3145.735070749057, 3389.8305084746394, 3743.0, 3778.5465744110884, 3786.981065094767, 4395.340698895191, 5171.870703232449, 5581.609287349846, 5595.251181708347, 5631.352394474688, 5422.674639521641, 5441.014029879145, 5443.673379597237, 5467.5625949923115, 5471.835844924659, 4753.595944344769, 4785.569298763128, 5060.165072762953, 5180.922286165635, 5443.673379597237, 4338.848140315074, 4468.396766436489, 4910.8772280693265, 5364.4099149094345, 5367.3827509836865, 5350.9732451337495, 5411.567074633941, 5423.213634023124, 5434.0, 5483.314585676791, 4538.319252112209, 4887.6783527824, 5301.310829592128, 5326.573874089986, 5338.54622357104], "value": 3843.309219639182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.8363592737743, 717.5674463568504, 781.6739772268994, 789.6091434739805, 793.626995312203, 13920.0, 14542.127472351653, 14566.198859062748, 14611.853881461195, 14653.633659158526, 12500.437480313385, 12582.496700131984, 12695.555655552058, 12727.554535591256, 12810.67973300668, 648.1768154443854, 781.2890269854448, 813.4102775487784, 816.4692949582759, 820.7332616899531, 656.4518626946506, 664.3555750921598, 796.5857753967933, 825.8307047055339, 828.4449418889328, 856.8243510080418, 858.0775666158904, 858.8368210040072, 862.5773371048173, 864.4899509289518, 853.9359548033922, 854.2695994924375, 854.786303424144, 856.6230858422306, 856.6530555125184, 498.5114587704034, 506.9391672999227, 602.6113157013701, 619.7799781077742, 641.9165508483914, 13973.301334933314, 14020.298985050707, 14043.859561404357, 14049.157050576998, 14060.92969535156, 12809.039322050883, 12908.16096953695, 13058.2817945013, 13147.60557183286, 13158.144720593227, 11376.146788990776, 11831.467583958742, 11860.52557897683, 12167.452464639113, 12393.442295096742, 4317.352397140423, 4343.9348409773875, 4421.579949904753, 4470.441194850644, 4472.664550158718, 78951.21048789553, 82679.0, 87483.0, 89509.0, 89580.0, 10155.492225388702, 10380.325278857, 10475.371477711362, 10508.632197873038, 10579.36523808574, 19136.904315478612, 19222.423327300203, 19387.61224775525, 19419.51451213731, 19434.319798806973, 6959.82600434983, 7077.5753454792875, 7160.069191005136, 7487.5507469552, 7522.924770752223, 4102.138550904344, 4141.0, 4200.306949353384, 4224.809883555247, 4273.87178384649, 3223.2747631782663, 3328.484084966834, 3349.732021438279, 3350.27968986669, 3353.9496907546404, 618.5113760129537, 626.9090981807703, 627.3130921640796, 632.34552238433, 636.3254949753276, 549.4615277028535, 604.8760004199129, 620.6307247187916, 624.3600309682612, 633.8542135308812, 8307.792305192419, 8544.829103417896, 8599.183077607617, 8697.695345698196, 8743.825123497621, 556.774506324939, 568.2130249604328, 579.9159121927297, 600.3726106219011, 633.8415396150963, 4053.959460405358, 4192.3711443283755, 4199.223143718361, 4249.87250382489, 4314.1371725655, 82179.0, 108582.0, 108867.45566272276, 110114.0, 113725.43137284426, 92506.53746731223, 92998.53500732454, 93945.0, 94882.0, 95910.52044739871, 68226.0, 68462.9730554042, 69209.61580768357, 84475.0, 84949.57525212334, 9220.631174753204, 9511.429314241168, 9560.713178604376, 9698.70903872885, 9751.073648003428, 46530.0, 47701.04597908092, 49878.50121498739, 50057.749711251214, 51448.48551514437, 46620.76689616666, 55223.723881380334, 67128.66435667986, 68268.3173168262, 71578.64210678914, 11607.825882611598, 11754.707697812739, 11782.293062416282, 11885.821712674144, 11910.166288359731, 11805.527778888749, 13236.279283693058, 13935.372908218951, 13971.930140349234, 14134.15195088298, 12749.49002039908, 12839.050707605438, 13429.932850336078, 13788.93105534466, 13860.722785544434, 11555.826662600235, 11572.6528204154, 12432.751344972869, 12496.937515312366, 12712.110152289251, 12503.0, 12697.301648409426, 12798.16811907223, 12820.551280705504, 13235.669108271984, 10045.0, 10770.873159710953, 10840.295380800222, 10844.45777711127, 11005.229633925548, 10478.79042419132, 10812.56749730002, 11086.556537738723, 11189.552417903193, 11267.7746445069], "value": 7071.460186879237, "unit": "score"}], "name": "dromaeo_css", "value": 6913.297260255761, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 111.0, 151.0, 140.0, 99.0, 126.0, 143.0, 175.0, 109.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 184.0, 183.0, 180.0, 183.0, 184.0, 184.0, 185.0, 185.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 89.0, 61.0, 59.0, 60.0, 58.0, 82.0, 60.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 96.0, 82.0, 97.0, 100.0, 118.0, 68.0, 69.0, 93.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 87.0, 90.0, 87.0, 91.0, 89.0, 92.0, 129.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 103.0, 96.0, 95.0, 94.0, 94.0, 94.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 81.0, 87.0, 80.0, 83.0, 86.0, 85.0, 82.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 52.0, 56.0, 56.0, 57.0, 57.0, 59.0, 57.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 80.0, 73.0, 72.0, 70.0, 72.0, 70.0, 71.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 95.0, 84.0, 83.0, 84.0, 82.0, 83.0, 82.0, 83.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 143.0, 148.0, 154.0, 141.0, 143.0, 141.0, 144.0, 232.0, 147.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 163.0, 165.0, 163.0, 165.0, 164.0, 164.0, 162.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 67.0, 67.0, 67.0, 71.0, 68.0, 66.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1452.3000000000002, "alertThreshold": 2.0}]} 08:36:07 INFO - Return code: 0 08:36:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:07 INFO - # TBPL SUCCESS # 08:36:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:07 INFO - 2017-01-01 08:36:07.932 screenresolution[1658:10038] starting screenresolution argv=screenresolution get 08:36:07 INFO - 2017-01-01 08:36:07.935 screenresolution[1658:10038] Display 0: 1600x1200x32@60 08:36:07 INFO - 2017-01-01 08:36:07.941 screenresolution[1659:10041] starting screenresolution argv=screenresolution list 08:36:07 INFO - Available Modes on Display 0 08:36:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:08 INFO - Intel Iris: 08:36:08 INFO - Chipset Model: Intel Iris 08:36:08 INFO - Type: GPU 08:36:08 INFO - Bus: Built-In 08:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:08 INFO - Vendor: Intel (0x8086) 08:36:08 INFO - Device ID: 0x0a2e 08:36:08 INFO - Revision ID: 0x0009 08:36:08 INFO - Displays: 08:36:08 INFO - Display: 08:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:08 INFO - Display Serial Number: 1600x1200 60 08:36:08 INFO - Main Display: Yes 08:36:08 INFO - Mirror: Off 08:36:08 INFO - Online: Yes 08:36:08 INFO - Rotation: Supported 08:36:08 INFO - Return code: 0 08:36:08 INFO - Running post-action listener: _resource_record_post_action 08:36:08 INFO - [mozharness: 2017-01-01 16:36:08.189352Z] Finished run-tests step (success) 08:36:08 INFO - Running post-run listener: _resource_record_post_run 08:36:08 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38839296; Write bytes: 658432000; Read time: 381; Write time: 2013 08:36:08 INFO - TinderboxPrint: CPU usage
53.5% 08:36:08 INFO - TinderboxPrint: I/O read bytes / time
38,839,296 / 381 08:36:08 INFO - TinderboxPrint: I/O write bytes / time
658,432,000 / 2,013 08:36:08 INFO - TinderboxPrint: CPU idle
2,256.4 (46.5%) 08:36:08 INFO - TinderboxPrint: CPU system
971.6 (20.0%) 08:36:08 INFO - TinderboxPrint: CPU user
1,625.7 (33.5%) 08:36:08 INFO - TinderboxPrint: Swap in / out
387,932,160 / 0 08:36:08 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344707584; Write bytes: 345458688; Read time: 26877; Write time: 642 08:36:08 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 36901888; Write bytes: 306104320; Read time: 361; Write time: 1345 08:36:08 INFO - Running post-run listener: _upload_blobber_files 08:36:08 INFO - Blob upload gear active. 08:36:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:08 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 08:36:08 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'] 08:36:08 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 08:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:10 INFO - (blobuploader) - INFO - Done attempting. 08:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:11 INFO - (blobuploader) - INFO - Done attempting. 08:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:14 INFO - (blobuploader) - INFO - Done attempting. 08:36:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:14 INFO - Return code: 0 08:36:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94b85b83bd58101c199e6a0fd693db75793fdffb584382cf82dfde19efc7875e013ef95f3aba345cdd8509b585281b67d608d808b96efb00319d38aedac3d9d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dacaa5c1445e88ee817dcbcd3611ab17a2fb6504a17999b9bf3907dc4d3e78d58f5ec9f27325a614d590b1d820b47ccefd8b0a92fb93f6c41d1ec96efce5a3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc0f32bee83cf12bcd4caa92c0bde892a063a3471c628f237b0f494157b6f8566944ff02eeca5ce1907525844d9107a374c086f6cd61807d5bc0426f356b890b"} 08:36:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:14 INFO - Contents: 08:36:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94b85b83bd58101c199e6a0fd693db75793fdffb584382cf82dfde19efc7875e013ef95f3aba345cdd8509b585281b67d608d808b96efb00319d38aedac3d9d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dacaa5c1445e88ee817dcbcd3611ab17a2fb6504a17999b9bf3907dc4d3e78d58f5ec9f27325a614d590b1d820b47ccefd8b0a92fb93f6c41d1ec96efce5a3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc0f32bee83cf12bcd4caa92c0bde892a063a3471c628f237b0f494157b6f8566944ff02eeca5ce1907525844d9107a374c086f6cd61807d5bc0426f356b890b"} 08:36:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:14 INFO - Copying logs to upload dir... 08:36:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.400244 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-01 08:36:14.296308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 08:36:14.300315) ========= 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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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/94b85b83bd58101c199e6a0fd693db75793fdffb584382cf82dfde19efc7875e013ef95f3aba345cdd8509b585281b67d608d808b96efb00319d38aedac3d9d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dacaa5c1445e88ee817dcbcd3611ab17a2fb6504a17999b9bf3907dc4d3e78d58f5ec9f27325a614d590b1d820b47ccefd8b0a92fb93f6c41d1ec96efce5a3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc0f32bee83cf12bcd4caa92c0bde892a063a3471c628f237b0f494157b6f8566944ff02eeca5ce1907525844d9107a374c086f6cd61807d5bc0426f356b890b"} build_url:https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010946 build_url: 'https://queue.taskcluster.net/v1/task/ZQIo2Kd4RSynyNNY9WdTxA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94b85b83bd58101c199e6a0fd693db75793fdffb584382cf82dfde19efc7875e013ef95f3aba345cdd8509b585281b67d608d808b96efb00319d38aedac3d9d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dacaa5c1445e88ee817dcbcd3611ab17a2fb6504a17999b9bf3907dc4d3e78d58f5ec9f27325a614d590b1d820b47ccefd8b0a92fb93f6c41d1ec96efce5a3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc0f32bee83cf12bcd4caa92c0bde892a063a3471c628f237b0f494157b6f8566944ff02eeca5ce1907525844d9107a374c086f6cd61807d5bc0426f356b890b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 08:36:14.334264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:36:14.334666) ========= 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.EU4JWmMdB1/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.Rf4ORj20cT/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.005285 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 08:36:14.383774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 08:36:14.384144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 08:36:14.384522) ========= ========= Total master_lag: 0.17 =========