builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0203 starttime: 1491440248.85 results: success (0) buildid: 20170405162619 builduid: 72fc840e39b84983959195dfab20d3b6 revision: 5ec9b3104a4cc38b1d28e6f49f0c0dc61642314e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:28.848513) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:28.848979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:28.849276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:28.876537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:28.876970) ========= 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.6cXQzRHTUl/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.W6oms7HsDs/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-04-05 17:57:28-- 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.7M=0.001s 2017-04-05 17:57:29 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:29.051020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:29.051357) ========= 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.6cXQzRHTUl/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.W6oms7HsDs/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.027220 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:29.101200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 17:57:29.101575) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5ec9b3104a4cc38b1d28e6f49f0c0dc61642314e --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-beta --rev 5ec9b3104a4cc38b1d28e6f49f0c0dc61642314e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6cXQzRHTUl/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.W6oms7HsDs/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-04-05 17:57:29,207 truncating revision to first 12 chars 2017-04-05 17:57:29,207 Setting DEBUG logging. 2017-04-05 17:57:29,207 attempt 1/10 2017-04-05 17:57:29,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5ec9b3104a4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 17:57:30,609 unpacking tar archive at: mozilla-beta-5ec9b3104a4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.674473 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 17:57:30.801058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:30.801408) ========= script_repo_revision: 5ec9b3104a4cc38b1d28e6f49f0c0dc61642314e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:30.801848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:30.802119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 17:57:30.822874) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-05 17:57:30.823302) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6cXQzRHTUl/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.W6oms7HsDs/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:57:31 INFO - MultiFileLogger online at 20170405 17:57:31 in /builds/slave/test 17:57:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:57:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:57:31 INFO - {'append_to_log': False, 17:57:31 INFO - 'base_work_dir': '/builds/slave/test', 17:57:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:57:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:57:31 INFO - 'branch': 'Mozilla-Beta', 17:57:31 INFO - 'buildbot_json_path': 'buildprops.json', 17:57:31 INFO - 'config_files': ('talos/mac_config.py',), 17:57:31 INFO - 'default_actions': ('clobber', 17:57:31 INFO - 'read-buildbot-config', 17:57:31 INFO - 'download-and-extract', 17:57:31 INFO - 'populate-webroot', 17:57:31 INFO - 'create-virtualenv', 17:57:31 INFO - 'install', 17:57:31 INFO - 'run-tests'), 17:57:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:57:31 INFO - 'download_minidump_stackwalk': True, 17:57:31 INFO - 'download_symbols': 'ondemand', 17:57:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:57:31 INFO - 'tooltool.py': '/tools/tooltool.py', 17:57:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:57:31 INFO - '/tools/misc-python/virtualenv.py')}, 17:57:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:57:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:57:31 INFO - 'installer_path': 'installer.exe', 17:57:31 INFO - 'log_level': 'info', 17:57:31 INFO - 'log_name': 'talos', 17:57:31 INFO - 'log_to_console': True, 17:57:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:57:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:57:31 INFO - 'opt_config_files': (), 17:57:31 INFO - 'pip_index': False, 17:57:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:57:31 INFO - 'cmd': ('bash', 17:57:31 INFO - '-c', 17:57:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:57:31 INFO - 'enabled': True, 17:57:31 INFO - 'halt_on_failure': False, 17:57:31 INFO - 'name': 'check_screen_resolution'},), 17:57:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:57:31 INFO - 'cmd': ('bash', 17:57:31 INFO - '-c', 17:57:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:57:31 INFO - 'enabled': True, 17:57:31 INFO - 'halt_on_failure': False, 17:57:31 INFO - 'name': 'check_screen_resolution'},), 17:57:31 INFO - 'run_cmd_checks_enabled': True, 17:57:31 INFO - 'sps_profile': False, 17:57:31 INFO - 'sps_profile_interval': 0, 17:57:31 INFO - 'suite': 'dromaeojs', 17:57:31 INFO - 'system_bits': '32', 17:57:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:57:31 INFO - 'title': 't-yosemite-r7-0203', 17:57:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:57:31 INFO - 'use_talos_json': True, 17:57:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:57:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:57:31 INFO - 'work_dir': 'build'} 17:57:31 INFO - [mozharness: 2017-04-06 00:57:31.036176Z] Running clobber step. 17:57:31 INFO - Running pre-action listener: _resource_record_pre_action 17:57:31 INFO - Running main action method: clobber 17:57:31 INFO - rmtree: /builds/slave/test/build 17:57:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:57:33 INFO - Running post-action listener: _resource_record_post_action 17:57:33 INFO - [mozharness: 2017-04-06 00:57:33.595679Z] Finished clobber step (success) 17:57:33 INFO - [mozharness: 2017-04-06 00:57:33.595802Z] Running read-buildbot-config step. 17:57:33 INFO - Running pre-action listener: _resource_record_pre_action 17:57:33 INFO - Running main action method: read_buildbot_config 17:57:33 INFO - Using buildbot properties: 17:57:33 INFO - { 17:57:33 INFO - "project": "", 17:57:33 INFO - "product": "firefox", 17:57:33 INFO - "script_repo_revision": "production", 17:57:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:57:33 INFO - "repository": "", 17:57:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:57:33 INFO - "buildid": "20170405162619", 17:57:33 INFO - "pgo_build": "False", 17:57:33 INFO - "basedir": "/builds/slave/test", 17:57:33 INFO - "buildnumber": 13, 17:57:33 INFO - "slavename": "t-yosemite-r7-0203", 17:57:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:57:33 INFO - "platform": "yosemite_r7", 17:57:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:57:33 INFO - "branch": "mozilla-beta", 17:57:33 INFO - "repo_path": "releases/mozilla-beta", 17:57:33 INFO - "revision": "5ec9b3104a4cc38b1d28e6f49f0c0dc61642314e", 17:57:33 INFO - "stage_platform": "macosx64", 17:57:33 INFO - "builduid": "72fc840e39b84983959195dfab20d3b6", 17:57:33 INFO - "slavebuilddir": "test" 17:57:33 INFO - } 17:57:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 17:57:33 INFO - Running post-action listener: _resource_record_post_action 17:57:33 INFO - [mozharness: 2017-04-06 00:57:33.599047Z] Finished read-buildbot-config step (success) 17:57:33 INFO - [mozharness: 2017-04-06 00:57:33.599156Z] Running download-and-extract step. 17:57:33 INFO - Running pre-action listener: _resource_record_pre_action 17:57:33 INFO - Running main action method: download_and_extract 17:57:33 INFO - mkdir: /builds/slave/test/build/tests 17:57: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')]} 17:57:33 INFO - trying https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 17:57:33 INFO - Downloading https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 17:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 17:57:34 INFO - Downloaded 1165 bytes. 17:57:34 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 17:57:34 INFO - Using the following test package requirements: 17:57:34 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 17:57:34 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:57:34 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 17:57:34 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:57:34 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 17:57:34 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:57:34 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:57:34 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 17:57:34 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 17:57:34 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:57:34 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 17:57:34 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:57:34 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 17:57:34 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:57:34 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 17:57:34 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:57:34 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 17:57:34 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 17:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 17:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 17:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 17:57:35 INFO - Expected file size: 16116429 17:57:35 INFO - Obtained file size: 16116429 17:57:42 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:57:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 17:57:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 17:57:42 INFO - Fetch https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 17:57:42 INFO - Expected file size: 16116429 17:57:42 INFO - Obtained file size: 16116429 17:57:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 17:57:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 17:57:49 INFO - Fetch https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 17:57:50 INFO - Expected file size: 14403663 17:57:50 INFO - Obtained file size: 14403663 17:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:50 INFO - trying https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:57:50 INFO - Downloading https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 17:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 17:57:52 INFO - Downloaded 58739505 bytes. 17:57:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:57:52 INFO - mkdir: /builds/slave/test/properties 17:57:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:57:52 INFO - Writing to file /builds/slave/test/properties/build_url 17:57:52 INFO - Contents: 17:57:52 INFO - build_url:https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:57:53 INFO - Running post-action listener: _resource_record_post_action 17:57:53 INFO - Running post-action listener: set_extra_try_arguments 17:57:53 INFO - [mozharness: 2017-04-06 00:57:53.343993Z] Finished download-and-extract step (success) 17:57:53 INFO - [mozharness: 2017-04-06 00:57:53.344108Z] Running populate-webroot step. 17:57:53 INFO - Running pre-action listener: _resource_record_pre_action 17:57:53 INFO - Running main action method: populate_webroot 17:57:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:57:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:57:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:57:53 INFO - '--tppagecycles', 17:57:53 INFO - '7'], 17:57:53 INFO - 'tests': ['tsvgm']}}, 17:57:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:57:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:57:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:57:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:57:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:57:53 INFO - 'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:57:53 INFO - 'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['damp', 'tps']}, 17:57:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:57:53 INFO - 'tests': ['damp', 'tps']}, 17:57:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['dromaeo_dom']}, 17:57:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:57:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['basic_compositor_video']}, 17:57:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:57:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['a11yr', 17:57:53 INFO - 'ts_paint', 17:57:53 INFO - 'tpaint', 17:57:53 INFO - 'sessionrestore', 17:57:53 INFO - 'sessionrestore_no_auto_restore', 17:57:53 INFO - 'tabpaint']}, 17:57:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:57:53 INFO - 'ts_paint', 17:57:53 INFO - 'tpaint', 17:57:53 INFO - 'sessionrestore', 17:57:53 INFO - 'sessionrestore_no_auto_restore', 17:57:53 INFO - 'tabpaint']}, 17:57:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:57:53 INFO - 'ts_paint', 17:57:53 INFO - 'tpaint', 17:57:53 INFO - 'sessionrestore', 17:57:53 INFO - 'sessionrestore_no_auto_restore', 17:57:53 INFO - 'tabpaint']}, 17:57:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:57:53 INFO - 'ts_paint', 17:57:53 INFO - 'tpaint', 17:57:53 INFO - 'sessionrestore', 17:57:53 INFO - 'sessionrestore_no_auto_restore', 17:57:53 INFO - 'tabpaint']}, 17:57:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['a11yr', 17:57:53 INFO - 'ts_paint', 17:57:53 INFO - 'tpaint', 17:57:53 INFO - 'sessionrestore', 17:57:53 INFO - 'sessionrestore_no_auto_restore', 17:57:53 INFO - 'tabpaint']}, 17:57:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['a11yr', 17:57:53 INFO - 'ts_paint', 17:57:53 INFO - 'tpaint', 17:57:53 INFO - 'sessionrestore', 17:57:53 INFO - 'sessionrestore_no_auto_restore', 17:57:53 INFO - 'tabpaint']}, 17:57:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['tsvgx', 17:57:53 INFO - 'tsvgr_opacity', 17:57:53 INFO - 'tart', 17:57:53 INFO - 'tscrollx', 17:57:53 INFO - 'cart', 17:57:53 INFO - 'tsvg_static']}, 17:57:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:57:53 INFO - 'tsvgr_opacity', 17:57:53 INFO - 'tart', 17:57:53 INFO - 'tscrollx', 17:57:53 INFO - 'cart', 17:57:53 INFO - 'tsvg_static']}, 17:57:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:57:53 INFO - 'talos_options': ['--disable-e10s'], 17:57:53 INFO - 'tests': ['tp5o']}, 17:57:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:57:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:57:53 INFO - 'talos_options': ['--disable-e10s', 17:57:53 INFO - '--xperf_path', 17:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:53 INFO - 'tests': ['tp5n']}, 17:57:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:57:53 INFO - 'talos_options': ['--xperf_path', 17:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:53 INFO - 'tests': ['tp5n']}}, 17:57:53 INFO - 'talos.zip': {'path': '', 17:57:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:57:53 INFO - Running post-action listener: _resource_record_post_action 17:57:53 INFO - [mozharness: 2017-04-06 00:57:53.362895Z] Finished populate-webroot step (success) 17:57:53 INFO - [mozharness: 2017-04-06 00:57:53.362993Z] Running create-virtualenv step. 17:57:53 INFO - Running pre-action listener: _resource_record_pre_action 17:57:53 INFO - Running main action method: create_virtualenv 17:57:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:57:53 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 17:57:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:57:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:57:53 INFO - Using real prefix '/tools/python27' 17:57:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:57 INFO - Installing pip.................done. 17:57:57 INFO - Return code: 0 17:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:57:57 INFO - Reading from file tmpfile_stdout 17:57:57 INFO - Output received: 17:57:57 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) 17:57:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57:57 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')]} 17:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:57 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')]} 17:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:57 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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:57:57 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 17:57:57 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 17:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:57 INFO - 'HOME': '/Users/cltbld', 17:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:57 INFO - 'LOGNAME': 'cltbld', 17:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:57 INFO - 'MOZ_NO_REMOTE': '1', 17:57:57 INFO - 'NO_EM_RESTART': '1', 17:57:57 INFO - 'PAGER': '/bin/cat', 17:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:57 INFO - 'PWD': '/builds/slave/test', 17:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:57 INFO - 'SHELL': '/bin/bash', 17:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:57:57 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:57 INFO - 'USER': 'cltbld', 17:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:57 INFO - 'XPC_FLAGS': '0x0', 17:57:57 INFO - 'XPC_SERVICE_NAME': '0', 17:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:57 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 17:57:57 INFO - Cleaning up... 17:57:57 INFO - Return code: 0 17:57:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:57:57 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')]} 17:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:57 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')]} 17:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:57 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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:57:57 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 17:57:57 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 17:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:57 INFO - 'HOME': '/Users/cltbld', 17:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:57 INFO - 'LOGNAME': 'cltbld', 17:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:57 INFO - 'MOZ_NO_REMOTE': '1', 17:57:57 INFO - 'NO_EM_RESTART': '1', 17:57:57 INFO - 'PAGER': '/bin/cat', 17:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:57 INFO - 'PWD': '/builds/slave/test', 17:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:57 INFO - 'SHELL': '/bin/bash', 17:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:57:57 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:57 INFO - 'USER': 'cltbld', 17:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:57 INFO - 'XPC_FLAGS': '0x0', 17:57:57 INFO - 'XPC_SERVICE_NAME': '0', 17:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:58 INFO - Downloading/unpacking psutil>=3.1.1 17:57:58 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 17:57:58 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 17:57:58 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 17:57:58 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 17:57:58 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 17:57:58 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 17:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:58:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:01 INFO - Installing collected packages: psutil 17:58:01 INFO - Running setup.py install for psutil 17:58:01 INFO - building 'psutil._psutil_osx' extension 17:58:01 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 17:58:02 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 17:58:02 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 17:58:02 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 17:58:02 INFO - building 'psutil._psutil_posix' extension 17:58:02 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 17:58:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:58:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:58:02 INFO - ^ 17:58:02 INFO - 1 warning generated. 17:58:02 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 17:58:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:02 INFO - Successfully installed psutil 17:58:02 INFO - Cleaning up... 17:58:02 INFO - Return code: 0 17:58:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:58:02 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')]} 17:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:02 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')]} 17:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:02 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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:02 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 17:58:02 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 17:58:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:02 INFO - 'HOME': '/Users/cltbld', 17:58:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:02 INFO - 'LOGNAME': 'cltbld', 17:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:02 INFO - 'MOZ_NO_REMOTE': '1', 17:58:02 INFO - 'NO_EM_RESTART': '1', 17:58:02 INFO - 'PAGER': '/bin/cat', 17:58:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:02 INFO - 'PWD': '/builds/slave/test', 17:58:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:02 INFO - 'SHELL': '/bin/bash', 17:58:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:02 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:02 INFO - 'USER': 'cltbld', 17:58:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:02 INFO - 'XPC_FLAGS': '0x0', 17:58:02 INFO - 'XPC_SERVICE_NAME': '0', 17:58:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:58:03 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 17:58:03 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 17:58:03 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 17:58:03 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 17:58:03 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 17:58:03 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 17:58:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:58:05 INFO - Installing collected packages: mozsystemmonitor 17:58:05 INFO - Running setup.py install for mozsystemmonitor 17:58:05 INFO - Successfully installed mozsystemmonitor 17:58:05 INFO - Cleaning up... 17:58:05 INFO - Return code: 0 17:58:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:05 INFO - 'HOME': '/Users/cltbld', 17:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:05 INFO - 'LOGNAME': 'cltbld', 17:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:05 INFO - 'MOZ_NO_REMOTE': '1', 17:58:05 INFO - 'NO_EM_RESTART': '1', 17:58:05 INFO - 'PAGER': '/bin/cat', 17:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:05 INFO - 'PWD': '/builds/slave/test', 17:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:05 INFO - 'SHELL': '/bin/bash', 17:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:05 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:05 INFO - 'USER': 'cltbld', 17:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:05 INFO - 'XPC_FLAGS': '0x0', 17:58:05 INFO - 'XPC_SERVICE_NAME': '0', 17:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:06 INFO - Downloading/unpacking jsonschema==2.5.1 17:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:58:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:58:08 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 17:58:08 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 17:58:08 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 17:58:08 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 17:58:08 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 17:58:08 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 17:58:09 INFO - Downloading functools32-3.2.3-2.tar.gz 17:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:58:09 INFO - warning: no files found matching '*.txt' 17:58:09 INFO - no previously-included directories found matching 'build' 17:58:09 INFO - no previously-included directories found matching 'dist' 17:58:09 INFO - no previously-included directories found matching '.git*' 17:58:09 INFO - Installing collected packages: jsonschema, functools32 17:58:09 INFO - Running setup.py install for functools32 17:58:09 INFO - warning: no files found matching '*.txt' 17:58:09 INFO - no previously-included directories found matching 'build' 17:58:09 INFO - no previously-included directories found matching 'dist' 17:58:09 INFO - no previously-included directories found matching '.git*' 17:58:09 INFO - Successfully installed jsonschema functools32 17:58:09 INFO - Cleaning up... 17:58:09 INFO - Return code: 0 17:58:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:09 INFO - 'HOME': '/Users/cltbld', 17:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:09 INFO - 'LOGNAME': 'cltbld', 17:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:09 INFO - 'MOZ_NO_REMOTE': '1', 17:58:09 INFO - 'NO_EM_RESTART': '1', 17:58:09 INFO - 'PAGER': '/bin/cat', 17:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:09 INFO - 'PWD': '/builds/slave/test', 17:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:09 INFO - 'SHELL': '/bin/bash', 17:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:09 INFO - 'USER': 'cltbld', 17:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:09 INFO - 'XPC_FLAGS': '0x0', 17:58:09 INFO - 'XPC_SERVICE_NAME': '0', 17:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:58:09 INFO - Cleaning up... 17:58:09 INFO - Return code: 0 17:58:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:09 INFO - 'HOME': '/Users/cltbld', 17:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:09 INFO - 'LOGNAME': 'cltbld', 17:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:09 INFO - 'MOZ_NO_REMOTE': '1', 17:58:09 INFO - 'NO_EM_RESTART': '1', 17:58:09 INFO - 'PAGER': '/bin/cat', 17:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:09 INFO - 'PWD': '/builds/slave/test', 17:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:09 INFO - 'SHELL': '/bin/bash', 17:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:09 INFO - 'USER': 'cltbld', 17:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:09 INFO - 'XPC_FLAGS': '0x0', 17:58:09 INFO - 'XPC_SERVICE_NAME': '0', 17:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:12 INFO - Downloading blobuploader-1.2.4.tar.gz 17:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:58:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:58:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:13 INFO - Downloading docopt-0.6.1.tar.gz 17:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:58:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:58:14 INFO - Running setup.py install for blobuploader 17:58:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:58:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:58:14 INFO - Running setup.py install for requests 17:58:14 INFO - Running setup.py install for docopt 17:58:14 INFO - Successfully installed blobuploader requests docopt 17:58:14 INFO - Cleaning up... 17:58:14 INFO - Return code: 0 17:58:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:14 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')]} 17:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:14 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')]} 17:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:14 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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:14 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 17:58:14 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 17:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:14 INFO - 'HOME': '/Users/cltbld', 17:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:14 INFO - 'LOGNAME': 'cltbld', 17:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:14 INFO - 'MOZ_NO_REMOTE': '1', 17:58:14 INFO - 'NO_EM_RESTART': '1', 17:58:14 INFO - 'PAGER': '/bin/cat', 17:58:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:14 INFO - 'PWD': '/builds/slave/test', 17:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:14 INFO - 'SHELL': '/bin/bash', 17:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:14 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:14 INFO - 'USER': 'cltbld', 17:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:14 INFO - 'XPC_FLAGS': '0x0', 17:58:14 INFO - 'XPC_SERVICE_NAME': '0', 17:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-hl3LQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-QpKN_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-JDAMvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-K77cun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-xfEDNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-L7zMKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-s862Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:15 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ZGGdFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-GnMFK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-y5bWSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-VruN1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-WujHe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-qpmacw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-S4iHhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-k3D7zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-vJcoZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-N0L8Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:58:16 INFO - Running setup.py install for manifestparser 17:58:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozcrash 17:58:17 INFO - Running setup.py install for mozdebug 17:58:17 INFO - Running setup.py install for mozdevice 17:58:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozfile 17:58:17 INFO - Running setup.py install for mozhttpd 17:58:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozinfo 17:58:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozInstall 17:58:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for mozleak 17:58:18 INFO - Running setup.py install for mozlog 17:58:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for moznetwork 17:58:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for mozprocess 17:58:18 INFO - Running setup.py install for mozprofile 17:58:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for mozrunner 17:58:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:58:19 INFO - Running setup.py install for mozscreenshot 17:58:19 INFO - Running setup.py install for moztest 17:58:19 INFO - Running setup.py install for mozversion 17:58:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:58:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:58:19 INFO - Cleaning up... 17:58:19 INFO - Return code: 0 17:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:19 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')]} 17:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:19 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')]} 17:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:19 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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:19 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 17:58:19 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 17:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:19 INFO - 'HOME': '/Users/cltbld', 17:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:19 INFO - 'LOGNAME': 'cltbld', 17:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:19 INFO - 'MOZ_NO_REMOTE': '1', 17:58:19 INFO - 'NO_EM_RESTART': '1', 17:58:19 INFO - 'PAGER': '/bin/cat', 17:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:19 INFO - 'PWD': '/builds/slave/test', 17:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:19 INFO - 'SHELL': '/bin/bash', 17:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:19 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:19 INFO - 'USER': 'cltbld', 17:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:19 INFO - 'XPC_FLAGS': '0x0', 17:58:19 INFO - 'XPC_SERVICE_NAME': '0', 17:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:19 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-kPVcfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:19 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)) 17:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:19 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-rHKGLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:19 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)) 17:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:19 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-7dFn1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-XkGGVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-PC5lNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-H1KyIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-sf0b90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-xUnrTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-pklwJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ldMBEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-H5bTbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58:20 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)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:20 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-f2JZZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:21 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-U98xXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58:21 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)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:21 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-zA2lVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58:21 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)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:21 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-W7sr5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:21 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)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:21 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-6gjkvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:21 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-JRdJn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:21 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)) 17:58:21 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)) 17:58:21 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)) 17:58:21 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)) 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:24 INFO - Downloading blessings-1.6.tar.gz 17:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:58:24 INFO - Installing collected packages: blessings 17:58:24 INFO - Running setup.py install for blessings 17:58:24 INFO - Successfully installed blessings 17:58:24 INFO - Cleaning up... 17:58:24 INFO - Return code: 0 17:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:24 INFO - Reading from file tmpfile_stdout 17:58:24 INFO - Current package versions: 17:58:24 INFO - blessings == 1.6 17:58:24 INFO - blobuploader == 1.2.4 17:58:24 INFO - docopt == 0.6.1 17:58:24 INFO - functools32 == 3.2.3-2 17:58:24 INFO - jsonschema == 2.5.1 17:58:24 INFO - manifestparser == 1.1 17:58:24 INFO - mozInstall == 1.12 17:58:24 INFO - mozcrash == 1.0 17:58:24 INFO - mozdebug == 0.1 17:58:24 INFO - mozdevice == 0.49 17:58:24 INFO - mozfile == 1.2 17:58:24 INFO - mozhttpd == 0.7 17:58:24 INFO - mozinfo == 0.9 17:58:24 INFO - mozleak == 0.1 17:58:24 INFO - mozlog == 3.4 17:58:24 INFO - moznetwork == 0.27 17:58:24 INFO - mozprocess == 0.24 17:58:24 INFO - mozprofile == 0.28 17:58:24 INFO - mozrunner == 6.13 17:58:24 INFO - mozscreenshot == 0.1 17:58:24 INFO - mozsystemmonitor == 0.3 17:58:24 INFO - moztest == 0.8 17:58:24 INFO - mozversion == 1.4 17:58:24 INFO - psutil == 3.1.1 17:58:24 INFO - requests == 1.2.3 17:58:24 INFO - wsgiref == 0.1.2 17:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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')]} 17:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:25 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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:25 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 17:58:25 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 17:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:25 INFO - 'HOME': '/Users/cltbld', 17:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:25 INFO - 'LOGNAME': 'cltbld', 17:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:25 INFO - 'MOZ_NO_REMOTE': '1', 17:58:25 INFO - 'NO_EM_RESTART': '1', 17:58:25 INFO - 'PAGER': '/bin/cat', 17:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:25 INFO - 'PWD': '/builds/slave/test', 17:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:25 INFO - 'SHELL': '/bin/bash', 17:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:25 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:25 INFO - 'USER': 'cltbld', 17:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:25 INFO - 'XPC_FLAGS': '0x0', 17:58:25 INFO - 'XPC_SERVICE_NAME': '0', 17:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 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)) 17:58:25 INFO - Cleaning up... 17:58:25 INFO - Return code: 0 17:58:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:58: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')]} 17:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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')]} 17:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:26 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 0x1042e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7685a2370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, '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.6cXQzRHTUl/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.W6oms7HsDs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:58:26 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 17:58:26 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 17:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:26 INFO - 'HOME': '/Users/cltbld', 17:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:26 INFO - 'LOGNAME': 'cltbld', 17:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:26 INFO - 'MOZ_NO_REMOTE': '1', 17:58:26 INFO - 'NO_EM_RESTART': '1', 17:58:26 INFO - 'PAGER': '/bin/cat', 17:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:26 INFO - 'PWD': '/builds/slave/test', 17:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:26 INFO - 'SHELL': '/bin/bash', 17:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:26 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:26 INFO - 'USER': 'cltbld', 17:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:26 INFO - 'XPC_FLAGS': '0x0', 17:58:26 INFO - 'XPC_SERVICE_NAME': '0', 17:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:58:26 INFO - Cleaning up... 17:58:26 INFO - Return code: 0 17:58:26 INFO - Running post-action listener: _resource_record_post_action 17:58:26 INFO - Running post-action listener: _start_resource_monitoring 17:58:26 INFO - Starting resource monitoring. 17:58:26 INFO - [mozharness: 2017-04-06 00:58:26.616036Z] Finished create-virtualenv step (success) 17:58:26 INFO - [mozharness: 2017-04-06 00:58:26.616945Z] Running install step. 17:58:26 INFO - Running pre-action listener: _resource_record_pre_action 17:58:26 INFO - Running main action method: install 17:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:26 INFO - Reading from file tmpfile_stdout 17:58:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:58:26 INFO - Reading from file tmpfile_stdout 17:58:26 INFO - Output received: 17:58:26 INFO - Usage: mozinstall [options] installer 17:58:26 INFO - Options: 17:58:26 INFO - -h, --help show this help message and exit 17:58:26 INFO - -d DEST, --destination=DEST 17:58:26 INFO - Directory to install application into. [default: 17:58:26 INFO - "/builds/slave/test"] 17:58:26 INFO - --app=APP Application being installed. [default: firefox] 17:58:26 INFO - mkdir: /builds/slave/test/build/application 17:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:58:41 INFO - Reading from file tmpfile_stdout 17:58:41 INFO - Output received: 17:58:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:58:41 INFO - Running post-action listener: _resource_record_post_action 17:58:41 INFO - [mozharness: 2017-04-06 00:58:41.786522Z] Finished install step (success) 17:58:41 INFO - [mozharness: 2017-04-06 00:58:41.786658Z] Running run-tests step. 17:58:41 INFO - Running pre-action listener: _resource_record_pre_action 17:58:41 INFO - Running main action method: run_tests 17:58:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:58:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:58:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:58:41 INFO - 2017-04-05 17:58:41.801 screenresolution[1620:7211] starting screenresolution argv=screenresolution get 17:58:41 INFO - 2017-04-05 17:58:41.804 screenresolution[1620:7211] Display 0: 1600x1200x32@60 17:58:41 INFO - 2017-04-05 17:58:41.810 screenresolution[1621:7213] starting screenresolution argv=screenresolution list 17:58:41 INFO - Available Modes on Display 0 17:58:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:58:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:58:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:58:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:58:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:58:42 INFO - Intel Iris: 17:58:42 INFO - Chipset Model: Intel Iris 17:58:42 INFO - Type: GPU 17:58:42 INFO - Bus: Built-In 17:58:42 INFO - VRAM (Dynamic, Max): 1536 MB 17:58:42 INFO - Vendor: Intel (0x8086) 17:58:42 INFO - Device ID: 0x0a2e 17:58:42 INFO - Revision ID: 0x0009 17:58:42 INFO - Displays: 17:58:42 INFO - Display: 17:58:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:58:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:58:42 INFO - Display Serial Number: 1600x1200 60 17:58:42 INFO - Main Display: Yes 17:58:42 INFO - Mirror: Off 17:58:42 INFO - Online: Yes 17:58:42 INFO - Rotation: Supported 17:58:42 INFO - Return code: 0 17:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:58:42 INFO - Python 2.7.3 17:58:42 INFO - Return code: 0 17:58:42 INFO - grabbing minidump binary from tooltool 17:58: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')]} 17:58:42 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 0x1040c0d30>, '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 0x103fe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040b5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:58:42 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 17:58:42 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 17:58:42 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 17:58:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:58:42 INFO - Return code: 0 17:58:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:58:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:58:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:58:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:58:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 17:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --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 17:58:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cXQzRHTUl/Render', 17:58:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:42 INFO - 'HOME': '/Users/cltbld', 17:58:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:42 INFO - 'LOGNAME': 'cltbld', 17:58:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:58:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:42 INFO - 'MOZ_NO_REMOTE': '1', 17:58:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:58:42 INFO - 'NO_EM_RESTART': '1', 17:58:42 INFO - 'PAGER': '/bin/cat', 17:58:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:42 INFO - 'PWD': '/builds/slave/test', 17:58:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:58:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:42 INFO - 'SHELL': '/bin/bash', 17:58:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6oms7HsDs/Listeners', 17:58:42 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:58:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:42 INFO - 'USER': 'cltbld', 17:58:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:42 INFO - 'XPC_FLAGS': '0x0', 17:58:42 INFO - 'XPC_SERVICE_NAME': '0', 17:58:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 17:58:42 INFO - mozversion application_buildid: 20170405162619 17:58:42 INFO - mozversion application_changeset: 5ec9b3104a4cc38b1d28e6f49f0c0dc61642314e 17:58:42 INFO - mozversion application_display_name: Firefox 17:58:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:58:42 INFO - mozversion application_name: Firefox 17:58:42 INFO - mozversion application_remotingname: firefox 17:58:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:58:42 INFO - mozversion application_vendor: Mozilla 17:58:42 INFO - mozversion application_version: 53.0 17:58:42 INFO - mozversion platform_buildid: 20170405162619 17:58:42 INFO - mozversion platform_changeset: 5ec9b3104a4cc38b1d28e6f49f0c0dc61642314e 17:58:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:58:42 INFO - mozversion platform_version: 53.0 17:58:42 INFO - using testdate: 1491440322 17:58:42 INFO - actual date: 1491440322 17:58:42 INFO - starting webserver on 'localhost:49236' 17:58:42 INFO - SUITE-START | Running 2 tests 17:58:42 INFO - TEST-START | dromaeo_css 17:58:42 INFO - operating with platform_type : mac_ 17:58:42 INFO - Initialising browser for dromaeo_css test... 17:58:42 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpKNhAai/profile http://localhost:49236/getInfo.html) 17:58:44 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 17:58:44 INFO - PROCESS | 1631 | colorDepth:24 17:58:44 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 17:58:44 INFO - PROCESS | 1631 | __metrics 17:58:44 INFO - PROCESS | 1631 | 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" 17:58:44 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:45 INFO - TEST-INFO | 1631: exit 0 17:58:45 INFO - Browser initialized. 17:58:45 INFO - Running cycle 1/1 for dromaeo_css test... 17:58:45 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpKNhAai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:57 INFO - PROCESS | 1634 | RSS: Main: 167530496 17:58:57 INFO - PROCESS | 1634 | 18:02:00 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 18:02:01 INFO - PROCESS | 1634 | RSS: Main: 292212736 18:02:01 INFO - PROCESS | 1634 | 18:05:04 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 18:05:05 INFO - PROCESS | 1634 | RSS: Main: 310251520 18:05:05 INFO - PROCESS | 1634 | 18:08:07 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 18:08:08 INFO - PROCESS | 1634 | RSS: Main: 277176320 18:08:08 INFO - PROCESS | 1634 | 18:11:10 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 18:11:10 INFO - PROCESS | 1634 | RSS: Main: 286310400 18:11:10 INFO - PROCESS | 1634 | 18:14:14 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 18:14:14 INFO - PROCESS | 1634 | RSS: Main: 268165120 18:14:14 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 18:17:18 INFO - PROCESS | 1634 | RSS: Main: 477782016 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | __start_tp_report 18:17:18 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 18:17:18 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 18:17:18 INFO - PROCESS | 1634 | |i|pagename|runs| 18:17:18 INFO - PROCESS | 1634 | |0;dojo.html;2925.6781754007056;3116.922076948076;3456.170519075423;3459.515667806506;3490.7556471047037;5649.915251271234;5678.063119585264;5687.715614219288;5706.828795136143;5718.942810571898;5688.089905615102;5739.569532285074;5746.913796293059;5753.913691294634;5775.191473193746;5173.637845350827;5214.400343960455;5220.034293655676;5225.529702326789;5274.868128296804;5167.302414174076;5169.974150129244;5179.015986962484;5305.1776974569;5320.14877619581;4368.89077773055;4720.929186062194;5250.474952504738;5266.052110620087;5277.736113194344;5253.57971362292;5276.4459731728;5280.867978300535;5285.418603953582;5286.1013627683005;5120.641555091145;5203.401608814959;5205.635605507616;5228.712420816853;5235.3717553893775;5706.229658996024;5800.245968024172;5816.41835816415;5820.214271073393;5856.238688970449;5164.225366195101;6219.87560248797;6230.065490176465;6241.282252540925;6273.184486016834;6145.832291864532;6164.660943648098;6345.397187267248;6361.236651601791;6379.011253255753;5786.161006654053;5807.709614519299;5812.244408226946;5815.534757219454;5919.822405327847;6251.156093927261;6261.749530018839;6271.216097987752;6272.686365681698;6279.717412716439;6225.595336303126;6227.875442491125;6239.407256310643;6240.906386404207;6242.09489624002;6155.630662160284;6209.285932117774;6232.906506402408;6252.781152659635;6275.529335299871;6270.592411493239;6280.057991301342;6281.8743625127245;6286.717097730613;6292.748290068346;6270.717817698214;6292.622442653455;6333.46165575922;6334.873302533923;6341.4609758170145;4904.730239836772;4981.178105612534;4983.352164218629;4994.475580064113;5050.090983622983;4477.70894891831;4487.102579484116;4516.864494065183;4532.297493888453;4538.52345503724;5872.618279811799;5877.471027607536;5882.823515294548;5903.498202652737;5935.228420305419;6133.365267548864;6151.831152081179;6274.717637706314;6314.0844577536;6328;5797.072468405119;5848.473637372572;5852.648841069549;5857.326407463111;5903.439173278532;5348.705821179795;5472.480114389126;5499.312585926759;5501.834944951658;5510;6206.689665516797;6368.267649220214;6372.7132279047555;6390.712417941297;6393.488520918316;6113.65874523782;6256.968715156395;6296.905546416716;6303.495720342454;6367.52243581724;6386.776462823779;6394.776182833579;6395.552311338161;6414.775482858077;6415.615063096229;5154.974225128851;6229.813105606839;6238.500919926486;6243.531735119794;6263.56155069159;6144.863200307957;6148.907766383419;6173.84565385851;6265.310815810166;6289.433950944437;6216.689165541795;6220.066989951543;6228.968855155696;6229.159063526366;6232.158658581034;6210.223722034746;6219.720112594853;6220.284667263322;6238.376162383725;6241.625502469867;5685.545156387562;5710.057840456278;5959.374265702038;6000.399960003964;6009.879802404015;5146.845594632167;6182.752689892354;6204.534659900435;6207.472364849038;6223.284322302993;5919.171316015847;6035.78874739382;6038.51691864641;6062.393760624079;6080.391960803884 18:17:18 INFO - PROCESS | 1634 | |1;ext.html;478.5429914431718;518.411602830787;541.9810306639268;544.9400565937749;565.4345654345655;25213.873930630343;40714.79642601786;42826.78586607066;42887.35668964968;44959.77520112403;44233;44686.32970505445;44718.55281447185;44731.55268447314;44846.55153448464;9014.414063085911;9421.057894210559;9630.229581633452;9634.662786802463;9637.75905602362;8917;11747.41262936854;11998.880011199864;12017.339046352447;12106.213096148766;11798.882011179865;11863.7627247455;11874.465649045771;11883.405829708523;11897.52409903607;11869.940650296736;11934.582289619822;11952.40237988097;11957.043436525057;11960.34218118003;11403.258788178742;11473;11486.827697584544;11496.252743571724;11511.654650360419;40812.38781418281;41015;41039;41110.794446027576;41124.12131150821;3913.9217215655526;3953.2291203215095;3962.9894376933985;3976.1451287973223;3995.720299579031;29771.553426698618;31679.891203807987;32084.518732219036;32258.35483290321;32374.19064523406;3133.185371803325;3265.755068369882;3280.70473657372;3326.451135562629;3410.1474631342167;486099;490645.54677226744;491746;491842;492182;62191.689041554506;62376.376236237964;62570.68714656398;62614.373856260856;62720.059199111136;65092.67453662701;65370.34629653738;65443.345566544675;65444;65499.67250163814;17539.947603143595;17730.822691773174;17754.112294385228;17787.021713805865;17856.821431785775;12357.3203473808;12674.366281686063;13716.588502344946;13801.309934503235;13812.37844297009;17780.9331440114;18135.63728725418;18183.909080454512;18268.360607378945;18321.541961450803;6282.937170628326;7297.781066568012;7367.300106489982;7381.926180738231;7404.666789994463;894.5884892949186;902.566767951387;904.1681652879366;934.9345545811727;940.0787228516092;29900.700992990227;30245.848770756445;30277.545836812464;31030.844845775628;31056.378872422876;1093.0818112785298;1097.3210987189614;1117.6255954255416;1135.8523391958993;1263.210493441599;15155.84558345911;15720.842791571939;15954.76067858983;15962.525272094172;16014.759778603331;233860;234766;234786;235017;235457;53034.46965530373;53474.73262633662;60419.39580604226;60816.78366432647;60937;1348.1910853488025;1394.546772299007;1396.9790453143414;1397.2524699285834;1459.0516164493165;30162.024104079203;31696.36607267888;31868.712023110056;32071.679283206868;32172.19569510781;51272.230916537024;51748;51966.960660785815;51973;52062.47937520577;564001;566904;568750;569887;570018;39106.4134037984;39634.603653964245;39800.40299395569;39935;40010.1997960045;46398.84002899955;47028.529714703785;47091;47590.76204618955;48320.75839620779;32260.870869519455;32334.514982274814;32748;33172.004839854846;33515.66484335125;31865.522017170224;31908.840455797574;32895;33027.504587431686;33617.49573756347;37968;38647.42028869513;38727.80636096802;38800.41799373068;38827.22345553017;28804.567931480626;32402;32944.1763955903;33508;33732;23902.88048559746;24165.984547505468;25221.74778252194;25667.35831604225;25686.486270274865 18:17:18 INFO - PROCESS | 1634 | |2;jquery.html;393.6437524040744;400.9097952960584;401.3357892687603;408.7261534771704;427.6130102257458;20626.17495300186;21198.89400552999;21491;21851.344459666198;22057.66913496297;22315.99578018989;22593.661095083586;22843.314700558967;22863.199788007423;23030.76969230307;5821.912671309923;6182.969085154568;6183.134361189437;6184.938150618504;6185.41238582334;5872.17789509469;5977.10343448484;6017.879642407149;6043.365446628107;6063.787767428119;5983.940160598382;5985.4912332451795;5986.461218490335;5992.370801065891;5995.880082398349;5073.289739436482;5714.51426628737;5931.4661680448535;5936.46571808535;5951.761929522814;5052.141136006888;5256.316678831766;5259.027079990214;5265.104932161542;5268.5521730652945;26585.46829063427;26981.595276070875;27025.1892443227;27321.86339068292;27335.906563737426;2503.486785209028;2763.9358846843907;2790.9720902790914;2825.025366248641;2827.2366461055603;13341.799873001914;14219.644508887257;15041.323140458706;15213.847861521464;15446.5366039019;1855.9721604175948;1894.5737209127974;1931.9227230910747;2031.492126968258;2046.4883779055235;136798;140954;149320.99999999892;151203;152129;9532.380395274286;10555.419451930064;11892.405379730979;11898.583549575724;12069.57756478519;14224.928875355765;14930.10419374841;15079;16047.197640117947;16060.43788467398;7221.566705997657;8539.530325832138;8816.118388161132;8935.329850261256;9033.277337812959;8584.828303433897;8592.097829727914;8602.268807151462;8717.738467845975;8777.561121943878;4749.097671442415;4811.27830825379;4826.517348265145;4897.510248975145;4898.14282500561;1988.3438465306415;2015.6976453531795;2025.7163997040427;2025.756909170909;2029.1376165129761;1057.9471026448646;1058.4601853054996;1065.3927261460892;1076.1175835814713;1116.213069785799;18613.697041207255;19596.804031959782;21653.458663533536;22021;22107.889460552917;1084.9240553161203;1087.5649740104022;1105.6075093341908;1110.0231796019452;1121.8485504456958;10325.690229293134;11390.487428065591;11537.307761534335;11546.13403994687;11563.017143542726;741513;764790;788261;798107;800168;109153.90846091596;141656;142840;155978;163505;894.3962825093037;992.2954702161546;1006.5671761142779;1043.7599352149048;1067.5783065689166;18290.908545457187;19224.615507690047;19420;19421.126049327533;19438.4168474946;58919.705401474435;60128;60192.49518761891;60899.69550152221;61913.690431547555;85468.1453185485;88295;89113;90787.54606227191;92040.69898252597;8231.670733170606;8275.821155253181;8284.378671599534;8577.31381489467;8578.742637720878;9310.975792662937;12050.348923236874;12915.741685166056;13371.53199638008;13429.395677194354;11203.327800332007;11325.32048077118;11412.771744564896;11650.592229272273;11651.184417090722;9120.631905214272;10555.102816260396;10715.517801698787;10761.784764304826;10776;10219.182465402899;11546.653600392001;11662.416879155839;11664.766704666028;11838.408079596158;7232.42140628759;7463.552186868806;7588.165301816685;7792.922070779219;8590.91409085901;8216.83566328682;10326.380417174994;11538.07695384384;11789.76420471603;11806.82289765637 18:17:18 INFO - PROCESS | 1634 | |3;mootools.html;1215.5320201722334;1480.2080886725605;1498.6478177628255;1513.447591629055;1516.3025008496084;7585.355244804191;7946.721864734735;8188.549629770368;8328.458650187733;8435.325173986083;8306.252437280644;8400.117987611304;8400.327973762085;8402.91597084029;8402.91597084029;2351.7413084560685;2386.2125498585424;2388.1880160745345;2391.282615215437;2393.8324317297797;2108.314797690749;2189.4964158243615;2350.7766762157653;2423.4547226873988;2428.162284012013;2293.805026572735;2301.746807851135;2313.248194336839;2314.467672435341;2315.1781117703226;2335.988320058397;2374.6794182785275;2376.1327115602853;2379.559781440439;2380;2340.1224540797202;2360.9409764755846;2374.905003799846;2406.639004149374;2406.7713567211085;8449.915500845036;8495.915040849573;8498.150184981452;8504.744857654281;8506.574671266411;5154.098032844237;5290.074237008546;5290.1800220965815;5292.629515933886;5293.841184764463;2914.2714321419644;3447.844846981892;3581.2837432513343;3584.7849129052343;3586.444101164324;1181.4565299962028;1239.6776838022179;1243.5461056714234;1279.2644229568036;1294.0812023463352;10688.038076573068;10795.2443328967;10815.945920270347;10818.08046316064;10827.83758243627;4521.163584736834;4664.183767840615;4697.600703940135;4776.689515181502;4785.59322457588;9621.51892405377;9625.422474651543;9627.037296270457;9633.518324083769;9641.42151470914;5341.599380046434;5345.812896548602;5348.358197016383;5352.732363381815;5361.222622719683;4368.27923392643;4810.254410566367;4840.927386089212;4890;4902.044101400193;3682.742208045465;3761.3041587306434;3765.7740535567955;3766.9246615067545;3768.4158955361963;1254.5609036837216;1255.7990721484518;1287.1569122224957;1289.3553223388305;1294.838145231846;800.415696541528;809.1018968944467;814.287498438866;818.0428898189133;832.2676045080291;4906.509349065065;5433.945660543344;5526.830284925989;5691.516221121168;5753.165790960371;882.5984177199359;1019.37308555238;1025.8922813104516;1031.6234574380296;1069.7486090768664;3695.316366472211;3785.7539259948016;3808.733388662767;3871.341871881787;3948.2893079245437;9750.317477776487;10073.395596264247;10166.847497287547;10203.693889183336;10246.282760206863;10060.597576096874;10082.395056296646;10109.949450252701;10138.087572118397;10173.796524069625;7214.74748383804;7798.649060792278;7809.2190780921455;7810.843783124305;7914.2481464261955;4759.23852183649;5446.537044351116;5594.944050559442;5724.627899186539;5756.7409466574945;8992.595333210153;9093.4998575079;9206.401583897024;9265.53672316395;9390.24878009744;9375.156235938799;9415.62337506492;9451.385659932082;9520.666776662783;9527.47598882068;7767.53394796314;7907.090684571118;7907.56508392044;7910.7231246906085;7923.326517246099;7223.566586004857;7469.029026226556;7471.701131954661;7534.35957943581;7693.307602315818;6074.757009719562;6603.042558829039;6994.440444764305;7128.572285662877;7166.104236970379;6825.69284382194;6896.310368963063;6919.584824910521;6935.133108361455;6948.583085014915;6330.873382532415;6449.064885591469;6470.514711396759;6471.741130354733;6473.093766872547;4871.9269210962575;4959.504049595012;4974.726390048582;5027.069992051483;5065.29085927963;4944.975275123601;4970.502949705001;5080.847574572768;5154.14956532183;5172.431032586337 18:17:18 INFO - PROCESS | 1634 | |4;prototype.html;313.6158206197408;371.10193332136225;377.99055023624413;387.4188716924613;387.9107805204801;4795.496472870351;5274.5780337573;5377.462253774625;5406.945930540694;5442.265294185288;4469.888252793682;5121.641485096045;5199.948000519994;5310.867228319285;5398.352197736277;4019.4975628046495;4193.266178418779;4225.880141762435;4265.459668475174;4278.229918614656;3710.6289371062812;4196.244675958326;4208.621224089831;4252.617264446199;4315.892102697442;3187.2191313128315;3688.2070354873695;3842.6175771022004;4236.173946080516;4246.447961764966;3418.4017796885446;3817.224990379473;3896.337622604164;4038.5557588665224;4064.4309796628495;2996.4119016921068;3130.733887619555;3302.3560405720896;3532.275883443888;3569.964300356989;4601.493835678073;5157.595986648794;5233.764480598382;5256.894862102775;5324.387695415038;4409.625181859546;4539.591436770706;4589.898424378159;4691.132140554008;4723.551262630044;5579.609427340088;5676.659400435987;5711.485966263056;5728.68492232927;5739.827805165852;3899.220155968789;3930.0328252169716;3937.7243592948507;3937.8818635440985;3941.369380899071;5288.550473209782;5752.194692743019;5887.646741195542;5914.733836977346;5973.492253158487;3334.333133373335;3518.3315170117594;3928.842846286174;3954.9209015819524;3960.3366586033935;3608.1881576645046;4015.5181378234797;4036.3138266494766;4041.78746376086;4066.1664358806966;3963.5441924178513;4398.582134697199;4454.599086082203;4647.9767601161775;4688.64835137366;5302.814401495929;5340.19897015443;5357.892842143136;5664.51851592611;5689.886202276014;1138.7722455508765;1264.4562837979756;1307.4508706343167;1314.6450458376185;1314.6516173214106;776.755322073545;810.6473683947502;818.8157664525553;823.9453499520623;844.9662013519513;4379.540148284448;4398.120375924827;4996.976224629031;5058.898822023539;5102.795888164506;5080.644354895196;5439.864003399946;5586.720663966786;5602;5704.315482142087;5197.688138711689;5230;5464.562834973192;5472.589555783332;5498.45015498455;2714.9185524434297;2840.602315675807;2903.4756752704575;2929.253040474708;2929.5312749959903;4874.6344024197615;5256.868578285574;5664.291963504562;5802.6808525531505;5875.853103672357;5486.533644640251;5630.8029218977135;5905.966455870205;5925.644461332334;5940.287165540077;5087.949120508748;5299.867503312448;6011.729472173675;6087.786927457606;6105.419985101408;4847.606675327214;5678.16091954023;5863.970680146572;5879.031653633866;5880.588358814842;5155.742212889416;5247.763850626808;5570.080936645408;5585.469380408855;5737.741801618854;5543.420125264281;5804.751978324681;6019;6077.848053798691;6117.816465506042;3909.9247706880838;3931.331673615435;3947.131631041166;3963.8577686318445;3968.464257325224;5812.57058335584;5849.61977471463;5892.381299963442;5922.318933322551;5927.496162826208;4821.373221481185;5130.640855140254;5614.24207731951;5755.971220143872;5760.222369979999;4867.953390021163;5375.844193498417;5440.972795135999;5572.526335261548;5655.943440565542;5351.919721204263;5491.36849262324;5590.552755779447;5595.916061259003;5631.605787594829;4153.169366126847;4701.989072349461;5253.737313134405;5553.583481239004;5737.741801618854;4449.57729015743;4652.744099074584;5520.730232046732;5559.777608895599;5602.52378547828 18:17:18 INFO - PROCESS | 1634 | |5;yui.html;750.4409215134725;754;788.8934993775839;792.4136139256948;825.8059356051327;15244.009139405945;15640.84359156408;17629.647407051867;18263.45209643713;18263.81736182638;16528.83471165288;16579.751303730452;16636.001839889614;16674.833251667478;16680;712.4122598855938;892.6384814150264;914.3142643017736;917.655879045358;918.1690570034096;738.5273425007972;880.1682410122437;897.1387468030698;914.5427286356821;916.8578870275085;962.033156677538;962.5043102802063;963.9228861691048;964.0504103458088;965.3146266151041;956.067833861986;957.3585697582602;957.952102394881;959.52023988006;959.822432849925;677.109600874848;702.4099756204813;709.8296408861887;711.5481669140081;711.5837235217404;13543.39054742539;15365.923170384076;15657.686846263012;15783.368665253376;16234.75647865283;14433.566992990227;14433.98768475372;14559;14560.70878582433;14634.707305853823;11594.594189203423;11803.822942655866;11919.523219071227;12086.456109475095;12597.93701031489;3867.9613203867884;3958.7030972677167;3987.8205480753436;3998.5001874765653;4001;102659.48670256676;108117;108460.4576977118;109523.45238273837;112185;10746.032857042903;10853.891461085446;11368.147388945863;11460.94269528647;11832.112591555668;23569.882150589136;23727.644085338732;23732.525349492913;23739.287821365386;23761.524769504515;7865.646045927947;7870.016247969004;7888.881666775003;8024.558649274346;8120.715774947848;4365.519792822787;4453.599176074169;4453.75504347264;4660.464046634613;4716.504766999485;3747.569029561581;3792.943105853414;3793.71013855285;3814.2180852925085;3852.749571277858;693.4140651149871;695.3602685529326;696.4080531548144;711.1359697966994;714.0931017607609;616.017452163798;691.7578847403369;710.0556260173956;731.9634018299064;771.7723271634882;10258.794824103625;10646.361218326925;10749.516271767789;11140.777184456265;11147.777044459066;687.9670573455427;706.5795851468368;723.4646361692415;731.6305265840823;735.481485552684;4936.7284799336385;5128.230765385222;5140.665856719376;5150.536451719288;5150.871228219325;83882;106699;108143;110602.89397106087;113105.43447282875;72447.63776181085;73336;95602.52198738961;97457;100854;59222;62483.68758156271;77068.61465692635;79095.60452197702;79213.60393197997;9449.244060475008;10889;11144.88855111471;11376.033037191932;11481.138914581274;50202.24696629627;51401.45795626137;52310.215346769066;52929;53859.19211211757;68793.65603171953;69815.30184698291;70255.29744702487;72089.19777005617;72256;13167;13229.603111906657;13468.93265533666;13611.115277507326;13869.237191954539;14570.562883113524;14635.634109147357;14877.107373557188;14898.553043408716;15654.608634784221;13281.468741250628;13320.666983325107;13660.86339136596;14286.571402857931;14428.567142985727;13362.465501379836;13800.585982420544;14071.366788494746;14116.082454640415;14571.781423278448;13291.601251962456;13439.395227214995;14187.290635467978;14262.028186458081;14425.42298308056;9495.14543691071;10008.749781255527;10100;10357.171426285728;10733.195010374096;9838.557264922953;10227.642032528825;10289.53697083648;11471.655850324503;11494.54021839117 18:17:18 INFO - PROCESS | 1634 | __end_tp_report 18:17:18 INFO - PROCESS | 1634 | __start_cc_report 18:17:18 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1252 18:17:18 INFO - PROCESS | 1634 | __end_cc_report 18:17:18 INFO - PROCESS | 1634 | __startTimestamp1491441438703__endTimestamp 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | ------- Summary: start ------- 18:17:18 INFO - PROCESS | 1634 | Number of tests: 6 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5770.18 Median:6000.40 stddev:668.38 (11.1%) stddev-sans-first:632.09 18:17:18 INFO - PROCESS | 1634 | Values: 2925.7 3116.9 3456.2 3459.5 3490.8 5649.9 5678.1 5687.7 5706.8 5718.9 5688.1 5739.6 5746.9 5753.9 5775.2 5173.6 5214.4 5220.0 5225.5 5274.9 5167.3 5170.0 5179.0 5305.2 5320.1 4368.9 4720.9 5250.5 5266.1 5277.7 5253.6 5276.4 5280.9 5285.4 5286.1 5120.6 5203.4 5205.6 5228.7 5235.4 5706.2 5800.2 5816.4 5820.2 5856.2 5164.2 6219.9 6230.1 6241.3 6273.2 6145.8 6164.7 6345.4 6361.2 6379.0 5786.2 5807.7 5812.2 5815.5 5919.8 6251.2 6261.7 6271.2 6272.7 6279.7 6225.6 6227.9 6239.4 6240.9 6242.1 6155.6 6209.3 6232.9 6252.8 6275.5 6270.6 6280.1 6281.9 6286.7 6292.7 6270.7 6292.6 6333.5 6334.9 6341.5 4904.7 4981.2 4983.4 4994.5 5050.1 4477.7 4487.1 4516.9 4532.3 4538.5 5872.6 5877.5 5882.8 5903.5 5935.2 6133.4 6151.8 6274.7 6314.1 6328.0 5797.1 5848.5 5852.6 5857.3 5903.4 5348.7 5472.5 5499.3 5501.8 5510.0 6206.7 6368.3 6372.7 6390.7 6393.5 6113.7 6257.0 6296.9 6303.5 6367.5 6386.8 6394.8 6395.6 6414.8 6415.6 5155.0 6229.8 6238.5 6243.5 6263.6 6144.9 6148.9 6173.8 6265.3 6289.4 6216.7 6220.1 6229.0 6229.2 6232.2 6210.2 6219.7 6220.3 6238.4 6241.6 5685.5 5710.1 5959.4 6000.4 6009.9 5146.8 6182.8 6204.5 6207.5 6223.3 5919.2 6035.8 6038.5 6062.4 6080.4 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:59359.60 Median:33511.83 stddev:121065.14 (361.3%) stddev-sans-first:121324.05 18:17:18 INFO - PROCESS | 1634 | Values: 478.5 518.4 542.0 544.9 565.4 25213.9 40714.8 42826.8 42887.4 44959.8 44233.0 44686.3 44718.6 44731.6 44846.6 9014.4 9421.1 9630.2 9634.7 9637.8 8917.0 11747.4 11998.9 12017.3 12106.2 11798.9 11863.8 11874.5 11883.4 11897.5 11869.9 11934.6 11952.4 11957.0 11960.3 11403.3 11473.0 11486.8 11496.3 11511.7 40812.4 41015.0 41039.0 41110.8 41124.1 3913.9 3953.2 3963.0 3976.1 3995.7 29771.6 31679.9 32084.5 32258.4 32374.2 3133.2 3265.8 3280.7 3326.5 3410.1 486099.0 490645.5 491746.0 491842.0 492182.0 62191.7 62376.4 62570.7 62614.4 62720.1 65092.7 65370.3 65443.3 65444.0 65499.7 17539.9 17730.8 17754.1 17787.0 17856.8 12357.3 12674.4 13716.6 13801.3 13812.4 17780.9 18135.6 18183.9 18268.4 18321.5 6282.9 7297.8 7367.3 7381.9 7404.7 894.6 902.6 904.2 934.9 940.1 29900.7 30245.8 30277.5 31030.8 31056.4 1093.1 1097.3 1117.6 1135.9 1263.2 15155.8 15720.8 15954.8 15962.5 16014.8 233860.0 234766.0 234786.0 235017.0 235457.0 53034.5 53474.7 60419.4 60816.8 60937.0 1348.2 1394.5 1397.0 1397.3 1459.1 30162.0 31696.4 31868.7 32071.7 32172.2 51272.2 51748.0 51967.0 51973.0 52062.5 564001.0 566904.0 568750.0 569887.0 570018.0 39106.4 39634.6 39800.4 39935.0 40010.2 46398.8 47028.5 47091.0 47590.8 48320.8 32260.9 32334.5 32748.0 33172.0 33515.7 31865.5 31908.8 32895.0 33027.5 33617.5 37968.0 38647.4 38727.8 38800.4 38827.2 28804.6 32402.0 32944.2 33508.0 33732.0 23902.9 24166.0 25221.7 25667.4 25686.5 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:42056.12 Median:22718.49 stddev:129567.79 (570.3%) stddev-sans-first:129893.50 18:17:18 INFO - PROCESS | 1634 | Values: 393.6 400.9 401.3 408.7 427.6 20626.2 21198.9 21491.0 21851.3 22057.7 22316.0 22593.7 22843.3 22863.2 23030.8 5821.9 6183.0 6183.1 6184.9 6185.4 5872.2 5977.1 6017.9 6043.4 6063.8 5983.9 5985.5 5986.5 5992.4 5995.9 5073.3 5714.5 5931.5 5936.5 5951.8 5052.1 5256.3 5259.0 5265.1 5268.6 26585.5 26981.6 27025.2 27321.9 27335.9 2503.5 2763.9 2791.0 2825.0 2827.2 13341.8 14219.6 15041.3 15213.8 15446.5 1856.0 1894.6 1931.9 2031.5 2046.5 136798.0 140954.0 149321.0 151203.0 152129.0 9532.4 10555.4 11892.4 11898.6 12069.6 14224.9 14930.1 15079.0 16047.2 16060.4 7221.6 8539.5 8816.1 8935.3 9033.3 8584.8 8592.1 8602.3 8717.7 8777.6 4749.1 4811.3 4826.5 4897.5 4898.1 1988.3 2015.7 2025.7 2025.8 2029.1 1057.9 1058.5 1065.4 1076.1 1116.2 18613.7 19596.8 21653.5 22021.0 22107.9 1084.9 1087.6 1105.6 1110.0 1121.8 10325.7 11390.5 11537.3 11546.1 11563.0 741513.0 764790.0 788261.0 798107.0 800168.0 109153.9 141656.0 142840.0 155978.0 163505.0 894.4 992.3 1006.6 1043.8 1067.6 18290.9 19224.6 19420.0 19421.1 19438.4 58919.7 60128.0 60192.5 60899.7 61913.7 85468.1 88295.0 89113.0 90787.5 92040.7 8231.7 8275.8 8284.4 8577.3 8578.7 9311.0 12050.3 12915.7 13371.5 13429.4 11203.3 11325.3 11412.8 11650.6 11651.2 9120.6 10555.1 10715.5 10761.8 10776.0 10219.2 11546.7 11662.4 11664.8 11838.4 7232.4 7463.6 7588.2 7792.9 8590.9 8216.8 10326.4 11538.1 11789.8 11806.8 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5472.10 Median:5046.18 stddev:2973.75 (58.9%) stddev-sans-first:2964.88 18:17:18 INFO - PROCESS | 1634 | Values: 1215.5 1480.2 1498.6 1513.4 1516.3 7585.4 7946.7 8188.5 8328.5 8435.3 8306.3 8400.1 8400.3 8402.9 8402.9 2351.7 2386.2 2388.2 2391.3 2393.8 2108.3 2189.5 2350.8 2423.5 2428.2 2293.8 2301.7 2313.2 2314.5 2315.2 2336.0 2374.7 2376.1 2379.6 2380.0 2340.1 2360.9 2374.9 2406.6 2406.8 8449.9 8495.9 8498.2 8504.7 8506.6 5154.1 5290.1 5290.2 5292.6 5293.8 2914.3 3447.8 3581.3 3584.8 3586.4 1181.5 1239.7 1243.5 1279.3 1294.1 10688.0 10795.2 10815.9 10818.1 10827.8 4521.2 4664.2 4697.6 4776.7 4785.6 9621.5 9625.4 9627.0 9633.5 9641.4 5341.6 5345.8 5348.4 5352.7 5361.2 4368.3 4810.3 4840.9 4890.0 4902.0 3682.7 3761.3 3765.8 3766.9 3768.4 1254.6 1255.8 1287.2 1289.4 1294.8 800.4 809.1 814.3 818.0 832.3 4906.5 5433.9 5526.8 5691.5 5753.2 882.6 1019.4 1025.9 1031.6 1069.7 3695.3 3785.8 3808.7 3871.3 3948.3 9750.3 10073.4 10166.8 10203.7 10246.3 10060.6 10082.4 10109.9 10138.1 10173.8 7214.7 7798.6 7809.2 7810.8 7914.2 4759.2 5446.5 5594.9 5724.6 5756.7 8992.6 9093.5 9206.4 9265.5 9390.2 9375.2 9415.6 9451.4 9520.7 9527.5 7767.5 7907.1 7907.6 7910.7 7923.3 7223.6 7469.0 7471.7 7534.4 7693.3 6074.8 6603.0 6994.4 7128.6 7166.1 6825.7 6896.3 6919.6 6935.1 6948.6 6330.9 6449.1 6470.5 6471.7 6473.1 4871.9 4959.5 4974.7 5027.1 5065.3 4945.0 4970.5 5080.8 5154.1 5172.4 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4547.49 Median:5156.67 stddev:1407.34 (27.3%) stddev-sans-first:1374.95 18:17:18 INFO - PROCESS | 1634 | Values: 313.6 371.1 378.0 387.4 387.9 4795.5 5274.6 5377.5 5406.9 5442.3 4469.9 5121.6 5199.9 5310.9 5398.4 4019.5 4193.3 4225.9 4265.5 4278.2 3710.6 4196.2 4208.6 4252.6 4315.9 3187.2 3688.2 3842.6 4236.2 4246.4 3418.4 3817.2 3896.3 4038.6 4064.4 2996.4 3130.7 3302.4 3532.3 3570.0 4601.5 5157.6 5233.8 5256.9 5324.4 4409.6 4539.6 4589.9 4691.1 4723.6 5579.6 5676.7 5711.5 5728.7 5739.8 3899.2 3930.0 3937.7 3937.9 3941.4 5288.6 5752.2 5887.6 5914.7 5973.5 3334.3 3518.3 3928.8 3954.9 3960.3 3608.2 4015.5 4036.3 4041.8 4066.2 3963.5 4398.6 4454.6 4648.0 4688.6 5302.8 5340.2 5357.9 5664.5 5689.9 1138.8 1264.5 1307.5 1314.6 1314.7 776.8 810.6 818.8 823.9 845.0 4379.5 4398.1 4997.0 5058.9 5102.8 5080.6 5439.9 5586.7 5602.0 5704.3 5197.7 5230.0 5464.6 5472.6 5498.5 2714.9 2840.6 2903.5 2929.3 2929.5 4874.6 5256.9 5664.3 5802.7 5875.9 5486.5 5630.8 5906.0 5925.6 5940.3 5087.9 5299.9 6011.7 6087.8 6105.4 4847.6 5678.2 5864.0 5879.0 5880.6 5155.7 5247.8 5570.1 5585.5 5737.7 5543.4 5804.8 6019.0 6077.8 6117.8 3909.9 3931.3 3947.1 3963.9 3968.5 5812.6 5849.6 5892.4 5922.3 5927.5 4821.4 5130.6 5614.2 5756.0 5760.2 4868.0 5375.8 5441.0 5572.5 5655.9 5351.9 5491.4 5590.6 5595.9 5631.6 4153.2 4702.0 5253.7 5553.6 5737.7 4449.6 4652.7 5520.7 5559.8 5602.5 18:17:18 INFO - PROCESS | 1634 | 18:17:18 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20844.97 Median:3833.48 stddev:29571.37 (771.4%) stddev-sans-first:29615.83 18:17:18 INFO - PROCESS | 1634 | Values: 750.4 754.0 788.9 792.4 825.8 15244.0 15640.8 17629.6 18263.5 18263.8 16528.8 16579.8 16636.0 16674.8 16680.0 712.4 892.6 914.3 917.7 918.2 738.5 880.2 897.1 914.5 916.9 962.0 962.5 963.9 964.1 965.3 956.1 957.4 958.0 959.5 959.8 677.1 702.4 709.8 711.5 711.6 13543.4 15365.9 15657.7 15783.4 16234.8 14433.6 14434.0 14559.0 14560.7 14634.7 11594.6 11803.8 11919.5 12086.5 12597.9 3868.0 3958.7 3987.8 3998.5 4001.0 102659.5 108117.0 108460.5 109523.5 112185.0 10746.0 10853.9 11368.1 11460.9 11832.1 23569.9 23727.6 23732.5 23739.3 23761.5 7865.6 7870.0 7888.9 8024.6 8120.7 4365.5 4453.6 4453.8 4660.5 4716.5 3747.6 3792.9 3793.7 3814.2 3852.7 693.4 695.4 696.4 711.1 714.1 616.0 691.8 710.1 732.0 771.8 10258.8 10646.4 10749.5 11140.8 11147.8 688.0 706.6 723.5 731.6 735.5 4936.7 5128.2 5140.7 5150.5 5150.9 83882.0 106699.0 108143.0 110602.9 113105.4 72447.6 73336.0 95602.5 97457.0 100854.0 59222.0 62483.7 77068.6 79095.6 79213.6 9449.2 10889.0 11144.9 11376.0 11481.1 50202.2 51401.5 52310.2 52929.0 53859.2 68793.7 69815.3 70255.3 72089.2 72256.0 13167.0 13229.6 13468.9 13611.1 13869.2 14570.6 14635.6 14877.1 14898.6 15654.6 13281.5 13320.7 13660.9 14286.6 14428.6 13362.5 13800.6 14071.4 14116.1 14571.8 13291.6 13439.4 14187.3 14262.0 14425.4 9495.1 10008.7 10100.0 10357.2 10733.2 9838.6 10227.6 10289.5 11471.7 11494.5 18:17:18 INFO - PROCESS | 1634 | -------- Summary: end -------- 18:17:18 INFO - PROCESS | 1634 | 18:17:19 INFO - TEST-INFO | 1634: exit 0 18:17:19 INFO - TEST-OK | dromaeo_css | took 1116989ms 18:17:19 INFO - TEST-START | kraken 18:17:19 INFO - operating with platform_type : mac_ 18:17:19 INFO - Initialising browser for kraken test... 18:17:19 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpd65_aL/profile http://localhost:49236/getInfo.html) 18:17:21 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 18:17:21 INFO - PROCESS | 1643 | colorDepth:24 18:17:21 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 18:17:21 INFO - PROCESS | 1643 | __metrics 18:17:21 INFO - PROCESS | 1643 | 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" 18:17:21 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:17:22 INFO - TEST-INFO | 1643: exit 0 18:17:22 INFO - Browser initialized. 18:17:22 INFO - Running cycle 1/1 for kraken test... 18:17:22 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpd65_aL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:34 INFO - PROCESS | 1645 | RSS: Main: 163983360 18:17:34 INFO - PROCESS | 1645 | 18:17:37 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 18:17:37 INFO - PROCESS | 1645 | RSS: Main: 213929984 18:17:37 INFO - PROCESS | 1645 | 18:17:40 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 18:17:41 INFO - PROCESS | 1645 | RSS: Main: 227811328 18:17:41 INFO - PROCESS | 1645 | 18:17:44 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 18:17:44 INFO - PROCESS | 1645 | RSS: Main: 324624384 18:17:44 INFO - PROCESS | 1645 | 18:17:46 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 18:17:47 INFO - PROCESS | 1645 | RSS: Main: 227811328 18:17:47 INFO - PROCESS | 1645 | 18:17:49 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:17:49 INFO - PROCESS | 1645 | RSS: Main: 229453824 18:17:49 INFO - PROCESS | 1645 | 18:17:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 18:17:53 INFO - PROCESS | 1645 | RSS: Main: 270630912 18:17:53 INFO - PROCESS | 1645 | 18:17:56 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 18:17:57 INFO - PROCESS | 1645 | RSS: Main: 268816384 18:17:57 INFO - PROCESS | 1645 | 18:18:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 18:18:00 INFO - PROCESS | 1645 | RSS: Main: 267251712 18:18:00 INFO - PROCESS | 1645 | 18:18:02 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:18:02 INFO - PROCESS | 1645 | RSS: Main: 244346880 18:18:02 INFO - PROCESS | 1645 | 18:18:04 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:18:05 INFO - PROCESS | 1645 | RSS: Main: 247922688 18:18:05 INFO - PROCESS | 1645 | 18:18:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:18:08 INFO - PROCESS | 1645 | RSS: Main: 256434176 18:18:08 INFO - PROCESS | 1645 | 18:18:11 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:18:11 INFO - PROCESS | 1645 | RSS: Main: 270508032 18:18:11 INFO - PROCESS | 1645 | 18:18:14 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:18:15 INFO - PROCESS | 1645 | RSS: Main: 264204288 18:18:15 INFO - PROCESS | 1645 | 18:18:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 18:18:17 INFO - PROCESS | 1645 | RSS: Main: 309063680 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | __start_tp_report 18:18:17 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 18:18:17 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 18:18:17 INFO - PROCESS | 1645 | |i|pagename|runs| 18:18:17 INFO - PROCESS | 1645 | |0;ai-astar;103;115;114;114;114;114;113;114;113;114 18:18:17 INFO - PROCESS | 1645 | |1;audio-beat-detection;140;107;107;142;108;106;105;104;125;106 18:18:17 INFO - PROCESS | 1645 | |2;audio-dft;185;184;182;185;186;183;183;186;185;184 18:18:17 INFO - PROCESS | 1645 | |3;audio-fft;81;60;72;111;70;58;61;57;73;58 18:18:17 INFO - PROCESS | 1645 | |4;audio-oscillator;90;71;86;69;66;70;80;68;68;81 18:18:17 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;90;86;134;122;89;87;89;87;90;87 18:18:17 INFO - PROCESS | 1645 | |6;imaging-darkroom;134;127;95;95;95;96;95;100;142;95 18:18:17 INFO - PROCESS | 1645 | |7;imaging-desaturate;88;89;94;142;133;86;87;91;87;87 18:18:17 INFO - PROCESS | 1645 | |8;json-parse-financial;54;52;51;54;55;55;55;54;54;55 18:18:17 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;64;68;75;73;71;69;67;68;69;69 18:18:17 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;85;82;82;82;83;77;86;103;99;90 18:18:17 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;135;142;123;147;138;152;145;154;173;131 18:18:17 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;162;165;197;163;161;163;158;161;161;168 18:18:17 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;64;63;66;64;66;63;63;64;63;63 18:18:17 INFO - PROCESS | 1645 | __end_tp_report 18:18:17 INFO - PROCESS | 1645 | __start_cc_report 18:18:17 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1961 18:18:17 INFO - PROCESS | 1645 | __end_cc_report 18:18:17 INFO - PROCESS | 1645 | __startTimestamp1491441497204__endTimestamp 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | ------- Summary: start ------- 18:18:17 INFO - PROCESS | 1645 | Number of tests: 14 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.49 (3.1%) stddev-sans-first:0.60 18:18:17 INFO - PROCESS | 1645 | Values: 103.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:115.00 Median:107.50 stddev:14.96 (13.9%) stddev-sans-first:12.84 18:18:17 INFO - PROCESS | 1645 | Values: 140.0 107.0 107.0 142.0 108.0 106.0 105.0 104.0 125.0 106.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.34 (0.7%) stddev-sans-first:1.39 18:18:17 INFO - PROCESS | 1645 | Values: 185.0 184.0 182.0 185.0 186.0 183.0 183.0 186.0 185.0 184.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:70.10 Median:65.50 stddev:16.51 (25.2%) stddev-sans-first:17.03 18:18:17 INFO - PROCESS | 1645 | Values: 81.0 60.0 72.0 111.0 70.0 58.0 61.0 57.0 73.0 58.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:75.50 stddev:8.58 (11.4%) stddev-sans-first:7.16 18:18:17 INFO - PROCESS | 1645 | Values: 90.0 71.0 86.0 69.0 66.0 70.0 80.0 68.0 68.0 81.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:88.00 stddev:17.10 (19.4%) stddev-sans-first:18.00 18:18:17 INFO - PROCESS | 1645 | Values: 90.0 86.0 134.0 122.0 89.0 87.0 89.0 87.0 90.0 87.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:95.00 stddev:18.98 (20.0%) stddev-sans-first:17.52 18:18:17 INFO - PROCESS | 1645 | Values: 134.0 127.0 95.0 95.0 95.0 96.0 95.0 100.0 142.0 95.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:87.50 stddev:20.85 (23.8%) stddev-sans-first:21.77 18:18:17 INFO - PROCESS | 1645 | Values: 88.0 89.0 94.0 142.0 133.0 86.0 87.0 91.0 87.0 87.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.37 (2.5%) stddev-sans-first:1.45 18:18:17 INFO - PROCESS | 1645 | Values: 54.0 52.0 51.0 54.0 55.0 55.0 55.0 54.0 54.0 55.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:3.09 (4.5%) stddev-sans-first:2.62 18:18:17 INFO - PROCESS | 1645 | Values: 64.0 68.0 75.0 73.0 71.0 69.0 67.0 68.0 69.0 69.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:84.00 stddev:8.20 (9.8%) stddev-sans-first:8.67 18:18:17 INFO - PROCESS | 1645 | Values: 85.0 82.0 82.0 82.0 83.0 77.0 86.0 103.0 99.0 90.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:146.00 stddev:13.93 (9.5%) stddev-sans-first:14.39 18:18:17 INFO - PROCESS | 1645 | Values: 135.0 142.0 123.0 147.0 138.0 152.0 145.0 154.0 173.0 131.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:163.00 stddev:11.25 (6.9%) stddev-sans-first:11.84 18:18:17 INFO - PROCESS | 1645 | Values: 162.0 165.0 197.0 163.0 161.0 163.0 158.0 161.0 161.0 168.0 18:18:17 INFO - PROCESS | 1645 | 18:18:17 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 18:18:17 INFO - PROCESS | 1645 | Values: 64.0 63.0 66.0 64.0 66.0 63.0 63.0 64.0 63.0 63.0 18:18:17 INFO - PROCESS | 1645 | -------- Summary: end -------- 18:18:17 INFO - PROCESS | 1645 | 18:18:18 INFO - TEST-INFO | 1645: exit 0 18:18:18 INFO - TEST-OK | kraken | took 58704ms 18:18:18 INFO - SUITE-END | took 1175s 18:18:18 INFO - Completed test suite (00:19:35) 18:18:18 INFO - javascript benchmark 18:18:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2925.6781754007056, 3116.922076948076, 3456.170519075423, 3459.515667806506, 3490.7556471047037, 5649.915251271234, 5678.063119585264, 5687.715614219288, 5706.828795136143, 5718.942810571898, 5688.089905615102, 5739.569532285074, 5746.913796293059, 5753.913691294634, 5775.191473193746, 5173.637845350827, 5214.400343960455, 5220.034293655676, 5225.529702326789, 5274.868128296804, 5167.302414174076, 5169.974150129244, 5179.015986962484, 5305.1776974569, 5320.14877619581, 4368.89077773055, 4720.929186062194, 5250.474952504738, 5266.052110620087, 5277.736113194344, 5253.57971362292, 5276.4459731728, 5280.867978300535, 5285.418603953582, 5286.1013627683005, 5120.641555091145, 5203.401608814959, 5205.635605507616, 5228.712420816853, 5235.3717553893775, 5706.229658996024, 5800.245968024172, 5816.41835816415, 5820.214271073393, 5856.238688970449, 5164.225366195101, 6219.87560248797, 6230.065490176465, 6241.282252540925, 6273.184486016834, 6145.832291864532, 6164.660943648098, 6345.397187267248, 6361.236651601791, 6379.011253255753, 5786.161006654053, 5807.709614519299, 5812.244408226946, 5815.534757219454, 5919.822405327847, 6251.156093927261, 6261.749530018839, 6271.216097987752, 6272.686365681698, 6279.717412716439, 6225.595336303126, 6227.875442491125, 6239.407256310643, 6240.906386404207, 6242.09489624002, 6155.630662160284, 6209.285932117774, 6232.906506402408, 6252.781152659635, 6275.529335299871, 6270.592411493239, 6280.057991301342, 6281.8743625127245, 6286.717097730613, 6292.748290068346, 6270.717817698214, 6292.622442653455, 6333.46165575922, 6334.873302533923, 6341.4609758170145, 4904.730239836772, 4981.178105612534, 4983.352164218629, 4994.475580064113, 5050.090983622983, 4477.70894891831, 4487.102579484116, 4516.864494065183, 4532.297493888453, 4538.52345503724, 5872.618279811799, 5877.471027607536, 5882.823515294548, 5903.498202652737, 5935.228420305419, 6133.365267548864, 6151.831152081179, 6274.717637706314, 6314.0844577536, 6328.0, 5797.072468405119, 5848.473637372572, 5852.648841069549, 5857.326407463111, 5903.439173278532, 5348.705821179795, 5472.480114389126, 5499.312585926759, 5501.834944951658, 5510.0, 6206.689665516797, 6368.267649220214, 6372.7132279047555, 6390.712417941297, 6393.488520918316, 6113.65874523782, 6256.968715156395, 6296.905546416716, 6303.495720342454, 6367.52243581724, 6386.776462823779, 6394.776182833579, 6395.552311338161, 6414.775482858077, 6415.615063096229, 5154.974225128851, 6229.813105606839, 6238.500919926486, 6243.531735119794, 6263.56155069159, 6144.863200307957, 6148.907766383419, 6173.84565385851, 6265.310815810166, 6289.433950944437, 6216.689165541795, 6220.066989951543, 6228.968855155696, 6229.159063526366, 6232.158658581034, 6210.223722034746, 6219.720112594853, 6220.284667263322, 6238.376162383725, 6241.625502469867, 5685.545156387562, 5710.057840456278, 5959.374265702038, 6000.399960003964, 6009.879802404015, 5146.845594632167, 6182.752689892354, 6204.534659900435, 6207.472364849038, 6223.284322302993, 5919.171316015847, 6035.78874739382, 6038.51691864641, 6062.393760624079, 6080.391960803884], "value": 5726.340104461274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.5429914431718, 518.411602830787, 541.9810306639268, 544.9400565937749, 565.4345654345655, 25213.873930630343, 40714.79642601786, 42826.78586607066, 42887.35668964968, 44959.77520112403, 44233.0, 44686.32970505445, 44718.55281447185, 44731.55268447314, 44846.55153448464, 9014.414063085911, 9421.057894210559, 9630.229581633452, 9634.662786802463, 9637.75905602362, 8917.0, 11747.41262936854, 11998.880011199864, 12017.339046352447, 12106.213096148766, 11798.882011179865, 11863.7627247455, 11874.465649045771, 11883.405829708523, 11897.52409903607, 11869.940650296736, 11934.582289619822, 11952.40237988097, 11957.043436525057, 11960.34218118003, 11403.258788178742, 11473.0, 11486.827697584544, 11496.252743571724, 11511.654650360419, 40812.38781418281, 41015.0, 41039.0, 41110.794446027576, 41124.12131150821, 3913.9217215655526, 3953.2291203215095, 3962.9894376933985, 3976.1451287973223, 3995.720299579031, 29771.553426698618, 31679.891203807987, 32084.518732219036, 32258.35483290321, 32374.19064523406, 3133.185371803325, 3265.755068369882, 3280.70473657372, 3326.451135562629, 3410.1474631342167, 486099.0, 490645.54677226744, 491746.0, 491842.0, 492182.0, 62191.689041554506, 62376.376236237964, 62570.68714656398, 62614.373856260856, 62720.059199111136, 65092.67453662701, 65370.34629653738, 65443.345566544675, 65444.0, 65499.67250163814, 17539.947603143595, 17730.822691773174, 17754.112294385228, 17787.021713805865, 17856.821431785775, 12357.3203473808, 12674.366281686063, 13716.588502344946, 13801.309934503235, 13812.37844297009, 17780.9331440114, 18135.63728725418, 18183.909080454512, 18268.360607378945, 18321.541961450803, 6282.937170628326, 7297.781066568012, 7367.300106489982, 7381.926180738231, 7404.666789994463, 894.5884892949186, 902.566767951387, 904.1681652879366, 934.9345545811727, 940.0787228516092, 29900.700992990227, 30245.848770756445, 30277.545836812464, 31030.844845775628, 31056.378872422876, 1093.0818112785298, 1097.3210987189614, 1117.6255954255416, 1135.8523391958993, 1263.210493441599, 15155.84558345911, 15720.842791571939, 15954.76067858983, 15962.525272094172, 16014.759778603331, 233860.0, 234766.0, 234786.0, 235017.0, 235457.0, 53034.46965530373, 53474.73262633662, 60419.39580604226, 60816.78366432647, 60937.0, 1348.1910853488025, 1394.546772299007, 1396.9790453143414, 1397.2524699285834, 1459.0516164493165, 30162.024104079203, 31696.36607267888, 31868.712023110056, 32071.679283206868, 32172.19569510781, 51272.230916537024, 51748.0, 51966.960660785815, 51973.0, 52062.47937520577, 564001.0, 566904.0, 568750.0, 569887.0, 570018.0, 39106.4134037984, 39634.603653964245, 39800.40299395569, 39935.0, 40010.1997960045, 46398.84002899955, 47028.529714703785, 47091.0, 47590.76204618955, 48320.75839620779, 32260.870869519455, 32334.514982274814, 32748.0, 33172.004839854846, 33515.66484335125, 31865.522017170224, 31908.840455797574, 32895.0, 33027.504587431686, 33617.49573756347, 37968.0, 38647.42028869513, 38727.80636096802, 38800.41799373068, 38827.22345553017, 28804.567931480626, 32402.0, 32944.1763955903, 33508.0, 33732.0, 23902.88048559746, 24165.984547505468, 25221.74778252194, 25667.35831604225, 25686.486270274865], "value": 20169.657260760683, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.6437524040744, 400.9097952960584, 401.3357892687603, 408.7261534771704, 427.6130102257458, 20626.17495300186, 21198.89400552999, 21491.0, 21851.344459666198, 22057.66913496297, 22315.99578018989, 22593.661095083586, 22843.314700558967, 22863.199788007423, 23030.76969230307, 5821.912671309923, 6182.969085154568, 6183.134361189437, 6184.938150618504, 6185.41238582334, 5872.17789509469, 5977.10343448484, 6017.879642407149, 6043.365446628107, 6063.787767428119, 5983.940160598382, 5985.4912332451795, 5986.461218490335, 5992.370801065891, 5995.880082398349, 5073.289739436482, 5714.51426628737, 5931.4661680448535, 5936.46571808535, 5951.761929522814, 5052.141136006888, 5256.316678831766, 5259.027079990214, 5265.104932161542, 5268.5521730652945, 26585.46829063427, 26981.595276070875, 27025.1892443227, 27321.86339068292, 27335.906563737426, 2503.486785209028, 2763.9358846843907, 2790.9720902790914, 2825.025366248641, 2827.2366461055603, 13341.799873001914, 14219.644508887257, 15041.323140458706, 15213.847861521464, 15446.5366039019, 1855.9721604175948, 1894.5737209127974, 1931.9227230910747, 2031.492126968258, 2046.4883779055235, 136798.0, 140954.0, 149320.99999999892, 151203.0, 152129.0, 9532.380395274286, 10555.419451930064, 11892.405379730979, 11898.583549575724, 12069.57756478519, 14224.928875355765, 14930.10419374841, 15079.0, 16047.197640117947, 16060.43788467398, 7221.566705997657, 8539.530325832138, 8816.118388161132, 8935.329850261256, 9033.277337812959, 8584.828303433897, 8592.097829727914, 8602.268807151462, 8717.738467845975, 8777.561121943878, 4749.097671442415, 4811.27830825379, 4826.517348265145, 4897.510248975145, 4898.14282500561, 1988.3438465306415, 2015.6976453531795, 2025.7163997040427, 2025.756909170909, 2029.1376165129761, 1057.9471026448646, 1058.4601853054996, 1065.3927261460892, 1076.1175835814713, 1116.213069785799, 18613.697041207255, 19596.804031959782, 21653.458663533536, 22021.0, 22107.889460552917, 1084.9240553161203, 1087.5649740104022, 1105.6075093341908, 1110.0231796019452, 1121.8485504456958, 10325.690229293134, 11390.487428065591, 11537.307761534335, 11546.13403994687, 11563.017143542726, 741513.0, 764790.0, 788261.0, 798107.0, 800168.0, 109153.90846091596, 141656.0, 142840.0, 155978.0, 163505.0, 894.3962825093037, 992.2954702161546, 1006.5671761142779, 1043.7599352149048, 1067.5783065689166, 18290.908545457187, 19224.615507690047, 19420.0, 19421.126049327533, 19438.4168474946, 58919.705401474435, 60128.0, 60192.49518761891, 60899.69550152221, 61913.690431547555, 85468.1453185485, 88295.0, 89113.0, 90787.54606227191, 92040.69898252597, 8231.670733170606, 8275.821155253181, 8284.378671599534, 8577.31381489467, 8578.742637720878, 9310.975792662937, 12050.348923236874, 12915.741685166056, 13371.53199638008, 13429.395677194354, 11203.327800332007, 11325.32048077118, 11412.771744564896, 11650.592229272273, 11651.184417090722, 9120.631905214272, 10555.102816260396, 10715.517801698787, 10761.784764304826, 10776.0, 10219.182465402899, 11546.653600392001, 11662.416879155839, 11664.766704666028, 11838.408079596158, 7232.42140628759, 7463.552186868806, 7588.165301816685, 7792.922070779219, 8590.91409085901, 8216.83566328682, 10326.380417174994, 11538.07695384384, 11789.76420471603, 11806.82289765637], "value": 10168.072902756163, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.5320201722334, 1480.2080886725605, 1498.6478177628255, 1513.447591629055, 1516.3025008496084, 7585.355244804191, 7946.721864734735, 8188.549629770368, 8328.458650187733, 8435.325173986083, 8306.252437280644, 8400.117987611304, 8400.327973762085, 8402.91597084029, 8402.91597084029, 2351.7413084560685, 2386.2125498585424, 2388.1880160745345, 2391.282615215437, 2393.8324317297797, 2108.314797690749, 2189.4964158243615, 2350.7766762157653, 2423.4547226873988, 2428.162284012013, 2293.805026572735, 2301.746807851135, 2313.248194336839, 2314.467672435341, 2315.1781117703226, 2335.988320058397, 2374.6794182785275, 2376.1327115602853, 2379.559781440439, 2380.0, 2340.1224540797202, 2360.9409764755846, 2374.905003799846, 2406.639004149374, 2406.7713567211085, 8449.915500845036, 8495.915040849573, 8498.150184981452, 8504.744857654281, 8506.574671266411, 5154.098032844237, 5290.074237008546, 5290.1800220965815, 5292.629515933886, 5293.841184764463, 2914.2714321419644, 3447.844846981892, 3581.2837432513343, 3584.7849129052343, 3586.444101164324, 1181.4565299962028, 1239.6776838022179, 1243.5461056714234, 1279.2644229568036, 1294.0812023463352, 10688.038076573068, 10795.2443328967, 10815.945920270347, 10818.08046316064, 10827.83758243627, 4521.163584736834, 4664.183767840615, 4697.600703940135, 4776.689515181502, 4785.59322457588, 9621.51892405377, 9625.422474651543, 9627.037296270457, 9633.518324083769, 9641.42151470914, 5341.599380046434, 5345.812896548602, 5348.358197016383, 5352.732363381815, 5361.222622719683, 4368.27923392643, 4810.254410566367, 4840.927386089212, 4890.0, 4902.044101400193, 3682.742208045465, 3761.3041587306434, 3765.7740535567955, 3766.9246615067545, 3768.4158955361963, 1254.5609036837216, 1255.7990721484518, 1287.1569122224957, 1289.3553223388305, 1294.838145231846, 800.415696541528, 809.1018968944467, 814.287498438866, 818.0428898189133, 832.2676045080291, 4906.509349065065, 5433.945660543344, 5526.830284925989, 5691.516221121168, 5753.165790960371, 882.5984177199359, 1019.37308555238, 1025.8922813104516, 1031.6234574380296, 1069.7486090768664, 3695.316366472211, 3785.7539259948016, 3808.733388662767, 3871.341871881787, 3948.2893079245437, 9750.317477776487, 10073.395596264247, 10166.847497287547, 10203.693889183336, 10246.282760206863, 10060.597576096874, 10082.395056296646, 10109.949450252701, 10138.087572118397, 10173.796524069625, 7214.74748383804, 7798.649060792278, 7809.2190780921455, 7810.843783124305, 7914.2481464261955, 4759.23852183649, 5446.537044351116, 5594.944050559442, 5724.627899186539, 5756.7409466574945, 8992.595333210153, 9093.4998575079, 9206.401583897024, 9265.53672316395, 9390.24878009744, 9375.156235938799, 9415.62337506492, 9451.385659932082, 9520.666776662783, 9527.47598882068, 7767.53394796314, 7907.090684571118, 7907.56508392044, 7910.7231246906085, 7923.326517246099, 7223.566586004857, 7469.029026226556, 7471.701131954661, 7534.35957943581, 7693.307602315818, 6074.757009719562, 6603.042558829039, 6994.440444764305, 7128.572285662877, 7166.104236970379, 6825.69284382194, 6896.310368963063, 6919.584824910521, 6935.133108361455, 6948.583085014915, 6330.873382532415, 6449.064885591469, 6470.514711396759, 6471.741130354733, 6473.093766872547, 4871.9269210962575, 4959.504049595012, 4974.726390048582, 5027.069992051483, 5065.29085927963, 4944.975275123601, 4970.502949705001, 5080.847574572768, 5154.14956532183, 5172.431032586337], "value": 4454.630776654501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.6158206197408, 371.10193332136225, 377.99055023624413, 387.4188716924613, 387.9107805204801, 4795.496472870351, 5274.5780337573, 5377.462253774625, 5406.945930540694, 5442.265294185288, 4469.888252793682, 5121.641485096045, 5199.948000519994, 5310.867228319285, 5398.352197736277, 4019.4975628046495, 4193.266178418779, 4225.880141762435, 4265.459668475174, 4278.229918614656, 3710.6289371062812, 4196.244675958326, 4208.621224089831, 4252.617264446199, 4315.892102697442, 3187.2191313128315, 3688.2070354873695, 3842.6175771022004, 4236.173946080516, 4246.447961764966, 3418.4017796885446, 3817.224990379473, 3896.337622604164, 4038.5557588665224, 4064.4309796628495, 2996.4119016921068, 3130.733887619555, 3302.3560405720896, 3532.275883443888, 3569.964300356989, 4601.493835678073, 5157.595986648794, 5233.764480598382, 5256.894862102775, 5324.387695415038, 4409.625181859546, 4539.591436770706, 4589.898424378159, 4691.132140554008, 4723.551262630044, 5579.609427340088, 5676.659400435987, 5711.485966263056, 5728.68492232927, 5739.827805165852, 3899.220155968789, 3930.0328252169716, 3937.7243592948507, 3937.8818635440985, 3941.369380899071, 5288.550473209782, 5752.194692743019, 5887.646741195542, 5914.733836977346, 5973.492253158487, 3334.333133373335, 3518.3315170117594, 3928.842846286174, 3954.9209015819524, 3960.3366586033935, 3608.1881576645046, 4015.5181378234797, 4036.3138266494766, 4041.78746376086, 4066.1664358806966, 3963.5441924178513, 4398.582134697199, 4454.599086082203, 4647.9767601161775, 4688.64835137366, 5302.814401495929, 5340.19897015443, 5357.892842143136, 5664.51851592611, 5689.886202276014, 1138.7722455508765, 1264.4562837979756, 1307.4508706343167, 1314.6450458376185, 1314.6516173214106, 776.755322073545, 810.6473683947502, 818.8157664525553, 823.9453499520623, 844.9662013519513, 4379.540148284448, 4398.120375924827, 4996.976224629031, 5058.898822023539, 5102.795888164506, 5080.644354895196, 5439.864003399946, 5586.720663966786, 5602.0, 5704.315482142087, 5197.688138711689, 5230.0, 5464.562834973192, 5472.589555783332, 5498.45015498455, 2714.9185524434297, 2840.602315675807, 2903.4756752704575, 2929.253040474708, 2929.5312749959903, 4874.6344024197615, 5256.868578285574, 5664.291963504562, 5802.6808525531505, 5875.853103672357, 5486.533644640251, 5630.8029218977135, 5905.966455870205, 5925.644461332334, 5940.287165540077, 5087.949120508748, 5299.867503312448, 6011.729472173675, 6087.786927457606, 6105.419985101408, 4847.606675327214, 5678.16091954023, 5863.970680146572, 5879.031653633866, 5880.588358814842, 5155.742212889416, 5247.763850626808, 5570.080936645408, 5585.469380408855, 5737.741801618854, 5543.420125264281, 5804.751978324681, 6019.0, 6077.848053798691, 6117.816465506042, 3909.9247706880838, 3931.331673615435, 3947.131631041166, 3963.8577686318445, 3968.464257325224, 5812.57058335584, 5849.61977471463, 5892.381299963442, 5922.318933322551, 5927.496162826208, 4821.373221481185, 5130.640855140254, 5614.24207731951, 5755.971220143872, 5760.222369979999, 4867.953390021163, 5375.844193498417, 5440.972795135999, 5572.526335261548, 5655.943440565542, 5351.919721204263, 5491.36849262324, 5590.552755779447, 5595.916061259003, 5631.605787594829, 4153.169366126847, 4701.989072349461, 5253.737313134405, 5553.583481239004, 5737.741801618854, 4449.57729015743, 4652.744099074584, 5520.730232046732, 5559.777608895599, 5602.52378547828], "value": 4107.462723125324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.4409215134725, 754.0, 788.8934993775839, 792.4136139256948, 825.8059356051327, 15244.009139405945, 15640.84359156408, 17629.647407051867, 18263.45209643713, 18263.81736182638, 16528.83471165288, 16579.751303730452, 16636.001839889614, 16674.833251667478, 16680.0, 712.4122598855938, 892.6384814150264, 914.3142643017736, 917.655879045358, 918.1690570034096, 738.5273425007972, 880.1682410122437, 897.1387468030698, 914.5427286356821, 916.8578870275085, 962.033156677538, 962.5043102802063, 963.9228861691048, 964.0504103458088, 965.3146266151041, 956.067833861986, 957.3585697582602, 957.952102394881, 959.52023988006, 959.822432849925, 677.109600874848, 702.4099756204813, 709.8296408861887, 711.5481669140081, 711.5837235217404, 13543.39054742539, 15365.923170384076, 15657.686846263012, 15783.368665253376, 16234.75647865283, 14433.566992990227, 14433.98768475372, 14559.0, 14560.70878582433, 14634.707305853823, 11594.594189203423, 11803.822942655866, 11919.523219071227, 12086.456109475095, 12597.93701031489, 3867.9613203867884, 3958.7030972677167, 3987.8205480753436, 3998.5001874765653, 4001.0, 102659.48670256676, 108117.0, 108460.4576977118, 109523.45238273837, 112185.0, 10746.032857042903, 10853.891461085446, 11368.147388945863, 11460.94269528647, 11832.112591555668, 23569.882150589136, 23727.644085338732, 23732.525349492913, 23739.287821365386, 23761.524769504515, 7865.646045927947, 7870.016247969004, 7888.881666775003, 8024.558649274346, 8120.715774947848, 4365.519792822787, 4453.599176074169, 4453.75504347264, 4660.464046634613, 4716.504766999485, 3747.569029561581, 3792.943105853414, 3793.71013855285, 3814.2180852925085, 3852.749571277858, 693.4140651149871, 695.3602685529326, 696.4080531548144, 711.1359697966994, 714.0931017607609, 616.017452163798, 691.7578847403369, 710.0556260173956, 731.9634018299064, 771.7723271634882, 10258.794824103625, 10646.361218326925, 10749.516271767789, 11140.777184456265, 11147.777044459066, 687.9670573455427, 706.5795851468368, 723.4646361692415, 731.6305265840823, 735.481485552684, 4936.7284799336385, 5128.230765385222, 5140.665856719376, 5150.536451719288, 5150.871228219325, 83882.0, 106699.0, 108143.0, 110602.89397106087, 113105.43447282875, 72447.63776181085, 73336.0, 95602.52198738961, 97457.0, 100854.0, 59222.0, 62483.68758156271, 77068.61465692635, 79095.60452197702, 79213.60393197997, 9449.244060475008, 10889.0, 11144.88855111471, 11376.033037191932, 11481.138914581274, 50202.24696629627, 51401.45795626137, 52310.215346769066, 52929.0, 53859.19211211757, 68793.65603171953, 69815.30184698291, 70255.29744702487, 72089.19777005617, 72256.0, 13167.0, 13229.603111906657, 13468.93265533666, 13611.115277507326, 13869.237191954539, 14570.562883113524, 14635.634109147357, 14877.107373557188, 14898.553043408716, 15654.608634784221, 13281.468741250628, 13320.666983325107, 13660.86339136596, 14286.571402857931, 14428.567142985727, 13362.465501379836, 13800.585982420544, 14071.366788494746, 14116.082454640415, 14571.781423278448, 13291.601251962456, 13439.395227214995, 14187.290635467978, 14262.028186458081, 14425.42298308056, 9495.14543691071, 10008.749781255527, 10100.0, 10357.171426285728, 10733.195010374096, 9838.557264922953, 10227.642032528825, 10289.53697083648, 11471.655850324503, 11494.54021839117], "value": 7810.862557654805, "unit": "score"}], "name": "dromaeo_css", "value": 7427.188579469111, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 107.0, 107.0, 142.0, 108.0, 106.0, 105.0, 104.0, 125.0, 106.0], "value": 115.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 185.0, 186.0, 183.0, 183.0, 186.0, 185.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 72.0, 111.0, 70.0, 58.0, 61.0, 57.0, 73.0, 58.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 86.0, 69.0, 66.0, 70.0, 80.0, 68.0, 68.0, 81.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 134.0, 122.0, 89.0, 87.0, 89.0, 87.0, 90.0, 87.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 95.0, 95.0, 95.0, 96.0, 95.0, 100.0, 142.0, 95.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 94.0, 142.0, 133.0, 86.0, 87.0, 91.0, 87.0, 87.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 75.0, 73.0, 71.0, 69.0, 67.0, 68.0, 69.0, 69.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 82.0, 82.0, 83.0, 77.0, 86.0, 103.0, 99.0, 90.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 123.0, 147.0, 138.0, 152.0, 145.0, 154.0, 173.0, 131.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 197.0, 163.0, 161.0, 163.0, 158.0, 161.0, 161.0, 168.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 64.0, 66.0, 63.0, 63.0, 64.0, 63.0, 63.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1442.9, "alertThreshold": 2.0}]} 18:18:18 INFO - Return code: 0 18:18:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:18:18 INFO - # TBPL SUCCESS # 18:18:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:18:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:18:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:18:18 INFO - 2017-04-05 18:18:18.548 screenresolution[1649:9517] starting screenresolution argv=screenresolution get 18:18:18 INFO - 2017-04-05 18:18:18.550 screenresolution[1649:9517] Display 0: 1600x1200x32@60 18:18:18 INFO - 2017-04-05 18:18:18.556 screenresolution[1650:9520] starting screenresolution argv=screenresolution list 18:18:18 INFO - Available Modes on Display 0 18:18:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:18:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:18:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:18:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:18:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:18:18 INFO - Intel Iris: 18:18:18 INFO - Chipset Model: Intel Iris 18:18:18 INFO - Type: GPU 18:18:18 INFO - Bus: Built-In 18:18:18 INFO - VRAM (Dynamic, Max): 1536 MB 18:18:18 INFO - Vendor: Intel (0x8086) 18:18:18 INFO - Device ID: 0x0a2e 18:18:18 INFO - Revision ID: 0x0009 18:18:18 INFO - Displays: 18:18:18 INFO - Display: 18:18:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:18:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:18:18 INFO - Display Serial Number: 1600x1200 60 18:18:18 INFO - Main Display: Yes 18:18:18 INFO - Mirror: Off 18:18:18 INFO - Online: Yes 18:18:18 INFO - Rotation: Supported 18:18:18 INFO - Return code: 0 18:18:18 INFO - Running post-action listener: _resource_record_post_action 18:18:18 INFO - [mozharness: 2017-04-06 01:18:18.793737Z] Finished run-tests step (success) 18:18:18 INFO - Running post-run listener: _resource_record_post_run 18:18:18 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 38618112; Write bytes: 423320576; Read time: 245; Write time: 1387 18:18:18 INFO - TinderboxPrint: CPU usage
53.5% 18:18:18 INFO - TinderboxPrint: I/O read bytes / time
38,618,112 / 245 18:18:18 INFO - TinderboxPrint: I/O write bytes / time
423,320,576 / 1,387 18:18:18 INFO - TinderboxPrint: CPU idle
2,216.4 (46.5%) 18:18:18 INFO - TinderboxPrint: CPU system
948.9 (19.9%) 18:18:18 INFO - TinderboxPrint: CPU user
1,600.3 (33.6%) 18:18:18 INFO - TinderboxPrint: Swap in / out
160,038,912 / 0 18:18:18 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121520640; Write bytes: 117684224; Read time: 11133; Write time: 265 18:18:18 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34862080; Write bytes: 295461888; Read time: 223; Write time: 1086 18:18:19 INFO - Running post-run listener: _upload_blobber_files 18:18:19 INFO - Blob upload gear active. 18:18:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:18:19 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 18:18:19 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:18:19 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:18:19 INFO - (blobuploader) - INFO - Open directory for files ... 18:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:18:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:20 INFO - (blobuploader) - INFO - Done attempting. 18:18:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:18:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:18:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:21 INFO - (blobuploader) - INFO - Done attempting. 18:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:22 INFO - (blobuploader) - INFO - Done attempting. 18:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:18:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:24 INFO - (blobuploader) - INFO - Done attempting. 18:18:24 INFO - (blobuploader) - INFO - Iteration through files over. 18:18:24 INFO - Return code: 0 18:18:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:18:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:18:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fe0d33eea1c76ebd428f8f17f70d62dc6a0bdf95d597825ccc88e59162550a8e7da2447bc7e2fea9f748bf6a6a80dd2d05770e81e7ac55f737915cff00bb043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43448613686b0ca93911939c7759795d4b10bd985af63638a111a78e5ab1ca080bf9cc66083c2784d54bd476247d0d4df76239975d7bb4e4706bca6a35f2643a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670f16018af7e2a6bb1326e8beec3e619540c6ed26284083e8409225e6e1f665f4747b4440255ceeb33f8916e317911bb25effbc0a9eeeb8ad2de6467b08421b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/98df49aed44490f92488d27bb7c30ad3e5eaed1ca572be572f5b8ca9b92768e440a5d4bed3267eec6002eb9fbb9abd4a823812545840582a37c3f60eaafdb81f"} 18:18:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:18:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:18:24 INFO - Contents: 18:18:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fe0d33eea1c76ebd428f8f17f70d62dc6a0bdf95d597825ccc88e59162550a8e7da2447bc7e2fea9f748bf6a6a80dd2d05770e81e7ac55f737915cff00bb043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43448613686b0ca93911939c7759795d4b10bd985af63638a111a78e5ab1ca080bf9cc66083c2784d54bd476247d0d4df76239975d7bb4e4706bca6a35f2643a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670f16018af7e2a6bb1326e8beec3e619540c6ed26284083e8409225e6e1f665f4747b4440255ceeb33f8916e317911bb25effbc0a9eeeb8ad2de6467b08421b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/98df49aed44490f92488d27bb7c30ad3e5eaed1ca572be572f5b8ca9b92768e440a5d4bed3267eec6002eb9fbb9abd4a823812545840582a37c3f60eaafdb81f"} 18:18:24 INFO - Running post-run listener: copy_logs_to_upload_dir 18:18:24 INFO - Copying logs to upload dir... 18:18:24 INFO - mkdir: /builds/slave/test/build/upload/logs 18:18:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.924607 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-05 18:18:24.793973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 18:18:24.797782) ========= 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.6cXQzRHTUl/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.W6oms7HsDs/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-Beta/sha512/8fe0d33eea1c76ebd428f8f17f70d62dc6a0bdf95d597825ccc88e59162550a8e7da2447bc7e2fea9f748bf6a6a80dd2d05770e81e7ac55f737915cff00bb043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43448613686b0ca93911939c7759795d4b10bd985af63638a111a78e5ab1ca080bf9cc66083c2784d54bd476247d0d4df76239975d7bb4e4706bca6a35f2643a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670f16018af7e2a6bb1326e8beec3e619540c6ed26284083e8409225e6e1f665f4747b4440255ceeb33f8916e317911bb25effbc0a9eeeb8ad2de6467b08421b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/98df49aed44490f92488d27bb7c30ad3e5eaed1ca572be572f5b8ca9b92768e440a5d4bed3267eec6002eb9fbb9abd4a823812545840582a37c3f60eaafdb81f"} build_url:https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010900 build_url: 'https://queue.taskcluster.net/v1/task/cwBhWoEsR0Otd5DoejDbXA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fe0d33eea1c76ebd428f8f17f70d62dc6a0bdf95d597825ccc88e59162550a8e7da2447bc7e2fea9f748bf6a6a80dd2d05770e81e7ac55f737915cff00bb043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43448613686b0ca93911939c7759795d4b10bd985af63638a111a78e5ab1ca080bf9cc66083c2784d54bd476247d0d4df76239975d7bb4e4706bca6a35f2643a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670f16018af7e2a6bb1326e8beec3e619540c6ed26284083e8409225e6e1f665f4747b4440255ceeb33f8916e317911bb25effbc0a9eeeb8ad2de6467b08421b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/98df49aed44490f92488d27bb7c30ad3e5eaed1ca572be572f5b8ca9b92768e440a5d4bed3267eec6002eb9fbb9abd4a823812545840582a37c3f60eaafdb81f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 18:18:24.834421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 18:18:24.834893) ========= 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.6cXQzRHTUl/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.W6oms7HsDs/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.005075 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 18:18:24.884882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 18:18:24.885416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 18:18:24.885902) ========= ========= Total master_lag: 0.19 =========