builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0337 starttime: 1484927430.65 results: success (0) buildid: 20170120062625 builduid: f223be0a07974b3294a1a354ae88bf08 revision: 3cedab21a7e65e6a1c4c2294ecfb5502575a46e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:30.649354) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:30.649851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:30.650141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:30.677227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:30.677756) ========= 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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-20 07:50:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.9M=0.001s 2017-01-20 07:50:31 (17.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.328266 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:31.267663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:31.268004) ========= 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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.031924 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:31.323126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-20 07:50:31.323486) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3cedab21a7e65e6a1c4c2294ecfb5502575a46e3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3cedab21a7e65e6a1c4c2294ecfb5502575a46e3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-20 07:50:31,412 truncating revision to first 12 chars 2017-01-20 07:50:31,412 Setting DEBUG logging. 2017-01-20 07:50:31,412 attempt 1/10 2017-01-20 07:50:31,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3cedab21a7e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 07:50:32,509 unpacking tar archive at: mozilla-central-3cedab21a7e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373911 ========= master_lag: 3.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-20 07:50:36.235770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:36.236106) ========= script_repo_revision: 3cedab21a7e65e6a1c4c2294ecfb5502575a46e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:36.236516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:36.236803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 07:50:36.258782) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-20 07:50:36.259188) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:50:36 INFO - MultiFileLogger online at 20170120 07:50:36 in /builds/slave/test 07:50:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:50:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:50:36 INFO - {'append_to_log': False, 07:50:36 INFO - 'base_work_dir': '/builds/slave/test', 07:50:36 INFO - 'blob_upload_branch': 'Firefox', 07:50:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:50:36 INFO - 'branch': 'Firefox', 07:50:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:50:36 INFO - 'config_files': ('talos/mac_config.py',), 07:50:36 INFO - 'default_actions': ('clobber', 07:50:36 INFO - 'read-buildbot-config', 07:50:36 INFO - 'download-and-extract', 07:50:36 INFO - 'populate-webroot', 07:50:36 INFO - 'create-virtualenv', 07:50:36 INFO - 'install', 07:50:36 INFO - 'run-tests'), 07:50:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:50:36 INFO - 'download_minidump_stackwalk': True, 07:50:36 INFO - 'download_symbols': 'ondemand', 07:50:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:50:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:50:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:50:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:50:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:50:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:50:36 INFO - 'installer_path': 'installer.exe', 07:50:36 INFO - 'log_level': 'info', 07:50:36 INFO - 'log_name': 'talos', 07:50:36 INFO - 'log_to_console': True, 07:50:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:50:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:50:36 INFO - 'opt_config_files': (), 07:50:36 INFO - 'pip_index': False, 07:50:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:50:36 INFO - 'cmd': ('bash', 07:50:36 INFO - '-c', 07:50:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:50:36 INFO - 'enabled': True, 07:50:36 INFO - 'halt_on_failure': False, 07:50:36 INFO - 'name': 'check_screen_resolution'},), 07:50:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:50:36 INFO - 'cmd': ('bash', 07:50:36 INFO - '-c', 07:50:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:50:36 INFO - 'enabled': True, 07:50:36 INFO - 'halt_on_failure': False, 07:50:36 INFO - 'name': 'check_screen_resolution'},), 07:50:36 INFO - 'run_cmd_checks_enabled': True, 07:50:36 INFO - 'sps_profile': False, 07:50:36 INFO - 'sps_profile_interval': 0, 07:50:36 INFO - 'suite': 'dromaeojs', 07:50:36 INFO - 'system_bits': '32', 07:50:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:50:36 INFO - 'title': 't-yosemite-r7-0337', 07:50:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:50:36 INFO - 'use_talos_json': True, 07:50:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:50:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:50:36 INFO - 'work_dir': 'build'} 07:50:36 INFO - [mozharness: 2017-01-20 15:50:36.456488Z] Running clobber step. 07:50:36 INFO - Running pre-action listener: _resource_record_pre_action 07:50:36 INFO - Running main action method: clobber 07:50:36 INFO - rmtree: /builds/slave/test/build 07:50:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:50:38 INFO - Running post-action listener: _resource_record_post_action 07:50:38 INFO - [mozharness: 2017-01-20 15:50:38.990499Z] Finished clobber step (success) 07:50:38 INFO - [mozharness: 2017-01-20 15:50:38.990740Z] Running read-buildbot-config step. 07:50:38 INFO - Running pre-action listener: _resource_record_pre_action 07:50:38 INFO - Running main action method: read_buildbot_config 07:50:38 INFO - Using buildbot properties: 07:50:38 INFO - { 07:50:38 INFO - "project": "", 07:50:38 INFO - "product": "firefox", 07:50:38 INFO - "script_repo_revision": "production", 07:50:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:50:38 INFO - "repository": "", 07:50:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:50:38 INFO - "buildid": "20170120062625", 07:50:38 INFO - "pgo_build": "False", 07:50:38 INFO - "basedir": "/builds/slave/test", 07:50:38 INFO - "buildnumber": 68, 07:50:38 INFO - "slavename": "t-yosemite-r7-0337", 07:50:38 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:50:38 INFO - "platform": "yosemite_r7", 07:50:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:50:38 INFO - "branch": "mozilla-central", 07:50:38 INFO - "repo_path": "mozilla-central", 07:50:38 INFO - "revision": "3cedab21a7e65e6a1c4c2294ecfb5502575a46e3", 07:50:38 INFO - "stage_platform": "macosx64", 07:50:38 INFO - "builduid": "f223be0a07974b3294a1a354ae88bf08", 07:50:38 INFO - "slavebuilddir": "test" 07:50:38 INFO - } 07:50:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:50:38 INFO - Running post-action listener: _resource_record_post_action 07:50:38 INFO - [mozharness: 2017-01-20 15:50:38.998533Z] Finished read-buildbot-config step (success) 07:50:38 INFO - [mozharness: 2017-01-20 15:50:38.998750Z] Running download-and-extract step. 07:50:38 INFO - Running pre-action listener: _resource_record_pre_action 07:50:38 INFO - Running main action method: download_and_extract 07:50:38 INFO - mkdir: /builds/slave/test/build/tests 07:50:38 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')]} 07:50:39 INFO - trying https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:50:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:50:40 INFO - Downloaded 1199 bytes. 07:50:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:50:40 INFO - Using the following test package requirements: 07:50:40 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:50:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:50:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:50:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'jsshell-mac.zip'], 07:50:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:50:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:50:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:50:40 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:50:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:50:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:40 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:50:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:50:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:50:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:50:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:50:41 INFO - Expected file size: 16345418 07:50:41 INFO - Obtained file size: 16345418 07:50:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:50:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:50:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:50:47 INFO - Fetch https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:50:48 INFO - Expected file size: 16345418 07:50:48 INFO - Obtained file size: 16345418 07:50:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:50:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:50:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:50:56 INFO - Expected file size: 14403476 07:50:56 INFO - Obtained file size: 14403476 07:50:56 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')]} 07:50:56 INFO - trying https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:50:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:50:58 INFO - Downloaded 69963854 bytes. 07:50:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:50:58 INFO - mkdir: /builds/slave/test/properties 07:50:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:50:58 INFO - Writing to file /builds/slave/test/properties/build_url 07:50:58 INFO - Contents: 07:50:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:50:59 INFO - Running post-action listener: _resource_record_post_action 07:50:59 INFO - Running post-action listener: set_extra_try_arguments 07:50:59 INFO - [mozharness: 2017-01-20 15:50:59.279960Z] Finished download-and-extract step (success) 07:50:59 INFO - [mozharness: 2017-01-20 15:50:59.280087Z] Running populate-webroot step. 07:50:59 INFO - Running pre-action listener: _resource_record_pre_action 07:50:59 INFO - Running main action method: populate_webroot 07:50:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:50:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:50:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:50:59 INFO - '--tppagecycles', 07:50:59 INFO - '7'], 07:50:59 INFO - 'tests': ['tsvgm']}}, 07:50:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:50:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:50:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:50:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:50:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:50:59 INFO - 'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:50:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:50:59 INFO - 'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['damp', 'tps']}, 07:50:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:50:59 INFO - 'tests': ['damp', 'tps']}, 07:50:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['dromaeo_dom']}, 07:50:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:50:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['basic_compositor_video']}, 07:50:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:50:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['a11yr', 07:50:59 INFO - 'ts_paint', 07:50:59 INFO - 'tpaint', 07:50:59 INFO - 'sessionrestore', 07:50:59 INFO - 'sessionrestore_no_auto_restore', 07:50:59 INFO - 'tabpaint']}, 07:50:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:50:59 INFO - 'ts_paint', 07:50:59 INFO - 'tpaint', 07:50:59 INFO - 'sessionrestore', 07:50:59 INFO - 'sessionrestore_no_auto_restore', 07:50:59 INFO - 'tabpaint']}, 07:50:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:50:59 INFO - 'ts_paint', 07:50:59 INFO - 'tpaint', 07:50:59 INFO - 'sessionrestore', 07:50:59 INFO - 'sessionrestore_no_auto_restore', 07:50:59 INFO - 'tabpaint']}, 07:50:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:50:59 INFO - 'ts_paint', 07:50:59 INFO - 'tpaint', 07:50:59 INFO - 'sessionrestore', 07:50:59 INFO - 'sessionrestore_no_auto_restore', 07:50:59 INFO - 'tabpaint']}, 07:50:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['a11yr', 07:50:59 INFO - 'ts_paint', 07:50:59 INFO - 'tpaint', 07:50:59 INFO - 'sessionrestore', 07:50:59 INFO - 'sessionrestore_no_auto_restore', 07:50:59 INFO - 'tabpaint']}, 07:50:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['a11yr', 07:50:59 INFO - 'ts_paint', 07:50:59 INFO - 'tpaint', 07:50:59 INFO - 'sessionrestore', 07:50:59 INFO - 'sessionrestore_no_auto_restore', 07:50:59 INFO - 'tabpaint']}, 07:50:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['tsvgx', 07:50:59 INFO - 'tsvgr_opacity', 07:50:59 INFO - 'tart', 07:50:59 INFO - 'tscrollx', 07:50:59 INFO - 'cart', 07:50:59 INFO - 'tsvg_static']}, 07:50:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:50:59 INFO - 'tsvgr_opacity', 07:50:59 INFO - 'tart', 07:50:59 INFO - 'tscrollx', 07:50:59 INFO - 'cart', 07:50:59 INFO - 'tsvg_static']}, 07:50:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:50:59 INFO - 'talos_options': ['--disable-e10s'], 07:50:59 INFO - 'tests': ['tp5o']}, 07:50:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:50:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:50:59 INFO - 'talos_options': ['--disable-e10s', 07:50:59 INFO - '--xperf_path', 07:50:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:59 INFO - 'tests': ['tp5n']}, 07:50:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:50:59 INFO - 'talos_options': ['--xperf_path', 07:50:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:59 INFO - 'tests': ['tp5n']}}, 07:50:59 INFO - 'talos.zip': {'path': '', 07:50:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:50:59 INFO - Running post-action listener: _resource_record_post_action 07:50:59 INFO - [mozharness: 2017-01-20 15:50:59.299010Z] Finished populate-webroot step (success) 07:50:59 INFO - [mozharness: 2017-01-20 15:50:59.299113Z] Running create-virtualenv step. 07:50:59 INFO - Running pre-action listener: _resource_record_pre_action 07:50:59 INFO - Running main action method: create_virtualenv 07:50:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:50:59 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 07:50:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:50:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:50:59 INFO - Using real prefix '/tools/python27' 07:50:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:51:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:51:02 INFO - Installing pip.................done. 07:51:02 INFO - Return code: 0 07:51:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:51:03 INFO - Reading from file tmpfile_stdout 07:51:03 INFO - Output received: 07:51:03 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) 07:51:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:51:03 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')]} 07:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:03 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')]} 07:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:03 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 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:03 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 07:51:03 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 07:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:03 INFO - 'HOME': '/Users/cltbld', 07:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:03 INFO - 'LOGNAME': 'cltbld', 07:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:03 INFO - 'MOZ_NO_REMOTE': '1', 07:51:03 INFO - 'NO_EM_RESTART': '1', 07:51:03 INFO - 'PAGER': '/bin/cat', 07:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:03 INFO - 'PWD': '/builds/slave/test', 07:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:03 INFO - 'SHELL': '/bin/bash', 07:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:03 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:03 INFO - 'USER': 'cltbld', 07:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:03 INFO - 'XPC_FLAGS': '0x0', 07:51:03 INFO - 'XPC_SERVICE_NAME': '0', 07:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:03 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 07:51:03 INFO - Cleaning up... 07:51:03 INFO - Return code: 0 07:51:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:51:03 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')]} 07:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:03 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')]} 07:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:03 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 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:03 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 07:51:03 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 07:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:03 INFO - 'HOME': '/Users/cltbld', 07:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:03 INFO - 'LOGNAME': 'cltbld', 07:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:03 INFO - 'MOZ_NO_REMOTE': '1', 07:51:03 INFO - 'NO_EM_RESTART': '1', 07:51:03 INFO - 'PAGER': '/bin/cat', 07:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:03 INFO - 'PWD': '/builds/slave/test', 07:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:03 INFO - 'SHELL': '/bin/bash', 07:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:03 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:03 INFO - 'USER': 'cltbld', 07:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:03 INFO - 'XPC_FLAGS': '0x0', 07:51:03 INFO - 'XPC_SERVICE_NAME': '0', 07:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:03 INFO - Downloading/unpacking psutil>=3.1.1 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:51:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:07 INFO - Installing collected packages: psutil 07:51:07 INFO - Running setup.py install for psutil 07:51:07 INFO - building 'psutil._psutil_osx' extension 07:51:07 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 07:51:07 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 07:51:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:51:08 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 07:51:08 INFO - building 'psutil._psutil_posix' extension 07:51:08 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 07:51:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:51:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:51:08 INFO - ^ 07:51:08 INFO - 1 warning generated. 07:51:08 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 07:51:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:08 INFO - Successfully installed psutil 07:51:08 INFO - Cleaning up... 07:51:08 INFO - Return code: 0 07:51:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:51:08 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')]} 07:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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')]} 07:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:08 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 07:51:08 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 07:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:08 INFO - 'HOME': '/Users/cltbld', 07:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:08 INFO - 'LOGNAME': 'cltbld', 07:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:08 INFO - 'MOZ_NO_REMOTE': '1', 07:51:08 INFO - 'NO_EM_RESTART': '1', 07:51:08 INFO - 'PAGER': '/bin/cat', 07:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:08 INFO - 'PWD': '/builds/slave/test', 07:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:08 INFO - 'SHELL': '/bin/bash', 07:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:08 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:08 INFO - 'USER': 'cltbld', 07:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:08 INFO - 'XPC_FLAGS': '0x0', 07:51:08 INFO - 'XPC_SERVICE_NAME': '0', 07:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:51:11 INFO - Installing collected packages: mozsystemmonitor 07:51:11 INFO - Running setup.py install for mozsystemmonitor 07:51:11 INFO - Successfully installed mozsystemmonitor 07:51:11 INFO - Cleaning up... 07:51:11 INFO - Return code: 0 07:51:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:51:11 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')]} 07:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:11 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')]} 07:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:11 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 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:11 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 07:51:11 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 07:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:11 INFO - 'HOME': '/Users/cltbld', 07:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:11 INFO - 'LOGNAME': 'cltbld', 07:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:11 INFO - 'MOZ_NO_REMOTE': '1', 07:51:11 INFO - 'NO_EM_RESTART': '1', 07:51:11 INFO - 'PAGER': '/bin/cat', 07:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:11 INFO - 'PWD': '/builds/slave/test', 07:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:11 INFO - 'SHELL': '/bin/bash', 07:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:11 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:11 INFO - 'USER': 'cltbld', 07:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:11 INFO - 'XPC_FLAGS': '0x0', 07:51:11 INFO - 'XPC_SERVICE_NAME': '0', 07:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:12 INFO - Downloading/unpacking jsonschema==2.5.1 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:51:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:51:14 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 07:51:14 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 07:51:14 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 07:51:14 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 07:51:14 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 07:51:14 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 07:51:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:51:15 INFO - warning: no files found matching '*.txt' 07:51:15 INFO - no previously-included directories found matching 'build' 07:51:15 INFO - no previously-included directories found matching 'dist' 07:51:15 INFO - no previously-included directories found matching '.git*' 07:51:15 INFO - Installing collected packages: jsonschema, functools32 07:51:15 INFO - Running setup.py install for functools32 07:51:15 INFO - warning: no files found matching '*.txt' 07:51:15 INFO - no previously-included directories found matching 'build' 07:51:15 INFO - no previously-included directories found matching 'dist' 07:51:15 INFO - no previously-included directories found matching '.git*' 07:51:15 INFO - Successfully installed jsonschema functools32 07:51:15 INFO - Cleaning up... 07:51:15 INFO - Return code: 0 07:51:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:51:15 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')]} 07:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:15 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')]} 07:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:15 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 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:15 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 07:51:15 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 07:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:15 INFO - 'HOME': '/Users/cltbld', 07:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:15 INFO - 'LOGNAME': 'cltbld', 07:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:15 INFO - 'MOZ_NO_REMOTE': '1', 07:51:15 INFO - 'NO_EM_RESTART': '1', 07:51:15 INFO - 'PAGER': '/bin/cat', 07:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:15 INFO - 'PWD': '/builds/slave/test', 07:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:15 INFO - 'SHELL': '/bin/bash', 07:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:15 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:15 INFO - 'USER': 'cltbld', 07:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:15 INFO - 'XPC_FLAGS': '0x0', 07:51:15 INFO - 'XPC_SERVICE_NAME': '0', 07:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:51:15 INFO - Cleaning up... 07:51:15 INFO - Return code: 0 07:51:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:51:15 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')]} 07:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:15 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')]} 07:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:15 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 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:15 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 07:51:15 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 07:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:15 INFO - 'HOME': '/Users/cltbld', 07:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:15 INFO - 'LOGNAME': 'cltbld', 07:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:15 INFO - 'MOZ_NO_REMOTE': '1', 07:51:15 INFO - 'NO_EM_RESTART': '1', 07:51:15 INFO - 'PAGER': '/bin/cat', 07:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:15 INFO - 'PWD': '/builds/slave/test', 07:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:15 INFO - 'SHELL': '/bin/bash', 07:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:15 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:15 INFO - 'USER': 'cltbld', 07:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:15 INFO - 'XPC_FLAGS': '0x0', 07:51:15 INFO - 'XPC_SERVICE_NAME': '0', 07:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:16 INFO - Downloading/unpacking blobuploader==1.2.4 07:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:18 INFO - Downloading blobuploader-1.2.4.tar.gz 07:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:51:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:51:18 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 07:51:18 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 07:51:18 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 07:51:18 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 07:51:18 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 07:51:18 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 07:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:51:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:19 INFO - Downloading docopt-0.6.1.tar.gz 07:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:51:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:51:20 INFO - Running setup.py install for blobuploader 07:51:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:51:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:51:20 INFO - Running setup.py install for requests 07:51:20 INFO - Running setup.py install for docopt 07:51:20 INFO - Successfully installed blobuploader requests docopt 07:51:20 INFO - Cleaning up... 07:51:20 INFO - Return code: 0 07:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:20 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')]} 07:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:21 INFO - 'HOME': '/Users/cltbld', 07:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:21 INFO - 'LOGNAME': 'cltbld', 07:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:21 INFO - 'MOZ_NO_REMOTE': '1', 07:51:21 INFO - 'NO_EM_RESTART': '1', 07:51:21 INFO - 'PAGER': '/bin/cat', 07:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:21 INFO - 'PWD': '/builds/slave/test', 07:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:21 INFO - 'SHELL': '/bin/bash', 07:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:21 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:21 INFO - 'USER': 'cltbld', 07:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:21 INFO - 'XPC_FLAGS': '0x0', 07:51:21 INFO - 'XPC_SERVICE_NAME': '0', 07:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:21 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-vQIFj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Zh9NE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-K2vLBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-kNR9B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-FzQklq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-tk3HqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ihyQ_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-AhFwQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-cBJgid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4SmzkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-hvOXvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-zzbP4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4TPMHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Y71sXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-R79OML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-1yYT01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-rOkVpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:51:23 INFO - Running setup.py install for manifestparser 07:51:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:51:23 INFO - Running setup.py install for mozcrash 07:51:23 INFO - Running setup.py install for mozdebug 07:51:24 INFO - Running setup.py install for mozdevice 07:51:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Running setup.py install for mozfile 07:51:24 INFO - Running setup.py install for mozhttpd 07:51:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Running setup.py install for mozinfo 07:51:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Running setup.py install for mozInstall 07:51:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:51:24 INFO - Running setup.py install for mozleak 07:51:24 INFO - Running setup.py install for mozlog 07:51:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:51:25 INFO - Running setup.py install for moznetwork 07:51:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:51:25 INFO - Running setup.py install for mozprocess 07:51:25 INFO - Running setup.py install for mozprofile 07:51:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:51:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:51:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:51:25 INFO - Running setup.py install for mozrunner 07:51:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:51:25 INFO - Running setup.py install for mozscreenshot 07:51:25 INFO - Running setup.py install for moztest 07:51:26 INFO - Running setup.py install for mozversion 07:51:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:51:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:51:26 INFO - Cleaning up... 07:51:26 INFO - Return code: 0 07:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:26 INFO - 'HOME': '/Users/cltbld', 07:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:26 INFO - 'LOGNAME': 'cltbld', 07:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:26 INFO - 'MOZ_NO_REMOTE': '1', 07:51:26 INFO - 'NO_EM_RESTART': '1', 07:51:26 INFO - 'PAGER': '/bin/cat', 07:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:26 INFO - 'PWD': '/builds/slave/test', 07:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:26 INFO - 'SHELL': '/bin/bash', 07:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:26 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:26 INFO - 'USER': 'cltbld', 07:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:26 INFO - 'XPC_FLAGS': '0x0', 07:51:26 INFO - 'XPC_SERVICE_NAME': '0', 07:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:26 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ZLARCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:26 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-hFn1Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:27 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)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-170kqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-_ll7uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:27 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)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-zEsc8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-U6Zjhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-dP2qa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-sj4iIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-jmZa1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Mg8FAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:27 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-40aJMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:28 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)) 07:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:28 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-QE_ucW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:28 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)) 07:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:28 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-S5N93B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:28 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-0LleTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:28 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)) 07:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:28 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-e3rO8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:28 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-wr5ehb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:28 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)) 07:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:28 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Z9t3ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:51:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:31 INFO - Downloading blessings-1.6.tar.gz 07:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:51:31 INFO - Installing collected packages: blessings 07:51:31 INFO - Running setup.py install for blessings 07:51:31 INFO - Successfully installed blessings 07:51:31 INFO - Cleaning up... 07:51:32 INFO - Return code: 0 07:51:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:51:32 INFO - Reading from file tmpfile_stdout 07:51:32 INFO - Current package versions: 07:51:32 INFO - blessings == 1.6 07:51:32 INFO - blobuploader == 1.2.4 07:51:32 INFO - docopt == 0.6.1 07:51:32 INFO - functools32 == 3.2.3-2 07:51:32 INFO - jsonschema == 2.5.1 07:51:32 INFO - manifestparser == 1.1 07:51:32 INFO - mozInstall == 1.12 07:51:32 INFO - mozcrash == 1.0 07:51:32 INFO - mozdebug == 0.1 07:51:32 INFO - mozdevice == 0.49 07:51:32 INFO - mozfile == 1.2 07:51:32 INFO - mozhttpd == 0.7 07:51:32 INFO - mozinfo == 0.9 07:51:32 INFO - mozleak == 0.1 07:51:32 INFO - mozlog == 3.4 07:51:32 INFO - moznetwork == 0.27 07:51:32 INFO - mozprocess == 0.24 07:51:32 INFO - mozprofile == 0.28 07:51:32 INFO - mozrunner == 6.13 07:51:32 INFO - mozscreenshot == 0.1 07:51:32 INFO - mozsystemmonitor == 0.3 07:51:32 INFO - moztest == 0.8 07:51:32 INFO - mozversion == 1.4 07:51:32 INFO - psutil == 3.1.1 07:51:32 INFO - requests == 1.2.3 07:51:32 INFO - wsgiref == 0.1.2 07:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:32 INFO - 'HOME': '/Users/cltbld', 07:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:32 INFO - 'LOGNAME': 'cltbld', 07:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:32 INFO - 'MOZ_NO_REMOTE': '1', 07:51:32 INFO - 'NO_EM_RESTART': '1', 07:51:32 INFO - 'PAGER': '/bin/cat', 07:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:32 INFO - 'PWD': '/builds/slave/test', 07:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:32 INFO - 'SHELL': '/bin/bash', 07:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:32 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:32 INFO - 'USER': 'cltbld', 07:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:32 INFO - 'XPC_FLAGS': '0x0', 07:51:32 INFO - 'XPC_SERVICE_NAME': '0', 07:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:51:32 INFO - Cleaning up... 07:51:32 INFO - Return code: 0 07:51:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1dbc1f720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, '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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 07:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:32 INFO - 'HOME': '/Users/cltbld', 07:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:32 INFO - 'LOGNAME': 'cltbld', 07:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:32 INFO - 'MOZ_NO_REMOTE': '1', 07:51:32 INFO - 'NO_EM_RESTART': '1', 07:51:32 INFO - 'PAGER': '/bin/cat', 07:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:32 INFO - 'PWD': '/builds/slave/test', 07:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:32 INFO - 'SHELL': '/bin/bash', 07:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:32 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:32 INFO - 'USER': 'cltbld', 07:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:32 INFO - 'XPC_FLAGS': '0x0', 07:51:32 INFO - 'XPC_SERVICE_NAME': '0', 07:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:51:32 INFO - Cleaning up... 07:51:32 INFO - Return code: 0 07:51:32 INFO - Running post-action listener: _resource_record_post_action 07:51:32 INFO - Running post-action listener: _start_resource_monitoring 07:51:32 INFO - Starting resource monitoring. 07:51:32 INFO - [mozharness: 2017-01-20 15:51:32.869381Z] Finished create-virtualenv step (success) 07:51:32 INFO - [mozharness: 2017-01-20 15:51:32.870352Z] Running install step. 07:51:32 INFO - Running pre-action listener: _resource_record_pre_action 07:51:32 INFO - Running main action method: install 07:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:51:33 INFO - Reading from file tmpfile_stdout 07:51:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:51:33 INFO - Reading from file tmpfile_stdout 07:51:33 INFO - Output received: 07:51:33 INFO - Usage: mozinstall [options] installer 07:51:33 INFO - Options: 07:51:33 INFO - -h, --help show this help message and exit 07:51:33 INFO - -d DEST, --destination=DEST 07:51:33 INFO - Directory to install application into. [default: 07:51:33 INFO - "/builds/slave/test"] 07:51:33 INFO - --app=APP Application being installed. [default: firefox] 07:51:33 INFO - mkdir: /builds/slave/test/build/application 07:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:51:55 INFO - Reading from file tmpfile_stdout 07:51:55 INFO - Output received: 07:51:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:51:55 INFO - Running post-action listener: _resource_record_post_action 07:51:55 INFO - [mozharness: 2017-01-20 15:51:55.119367Z] Finished install step (success) 07:51:55 INFO - [mozharness: 2017-01-20 15:51:55.119553Z] Running run-tests step. 07:51:55 INFO - Running pre-action listener: _resource_record_pre_action 07:51:55 INFO - Running main action method: run_tests 07:51:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:51:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:51:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:51:55 INFO - 2017-01-20 07:51:55.134 screenresolution[1627:7461] starting screenresolution argv=screenresolution get 07:51:55 INFO - 2017-01-20 07:51:55.137 screenresolution[1627:7461] Display 0: 1600x1200x32@60 07:51:55 INFO - 2017-01-20 07:51:55.142 screenresolution[1628:7463] starting screenresolution argv=screenresolution list 07:51:55 INFO - Available Modes on Display 0 07:51:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:51:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:51:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:51:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:51:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:51:55 INFO - Intel Iris: 07:51:55 INFO - Chipset Model: Intel Iris 07:51:55 INFO - Type: GPU 07:51:55 INFO - Bus: Built-In 07:51:55 INFO - VRAM (Dynamic, Max): 1536 MB 07:51:55 INFO - Vendor: Intel (0x8086) 07:51:55 INFO - Device ID: 0x0a2e 07:51:55 INFO - Revision ID: 0x0009 07:51:55 INFO - Displays: 07:51:55 INFO - Display: 07:51:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:51:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:51:55 INFO - Display Serial Number: 1600x1200 60 07:51:55 INFO - Main Display: Yes 07:51:55 INFO - Mirror: Off 07:51:55 INFO - Online: Yes 07:51:55 INFO - Rotation: Supported 07:51:55 INFO - Return code: 0 07:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:51:55 INFO - Python 2.7.3 07:51:55 INFO - Return code: 0 07:51:55 INFO - grabbing minidump binary from tooltool 07:51:55 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')]} 07:51:55 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 0x104e96d30>, '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 0x104dbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e8bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:51:55 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 07:51:55 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 07:51:55 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 07:51:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:51:55 INFO - Return code: 0 07:51:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:51:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:51:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:51:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:51:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 07:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0337 --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 07:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe25ohoS3k/Render', 07:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:55 INFO - 'HOME': '/Users/cltbld', 07:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:55 INFO - 'LOGNAME': 'cltbld', 07:51:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:51:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:55 INFO - 'MOZ_NO_REMOTE': '1', 07:51:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:51:55 INFO - 'NO_EM_RESTART': '1', 07:51:55 INFO - 'PAGER': '/bin/cat', 07:51:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:55 INFO - 'PWD': '/builds/slave/test', 07:51:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:55 INFO - 'SHELL': '/bin/bash', 07:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BnKsOlj1Vr/Listeners', 07:51:55 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 07:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:55 INFO - 'USER': 'cltbld', 07:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:55 INFO - 'XPC_FLAGS': '0x0', 07:51:55 INFO - 'XPC_SERVICE_NAME': '0', 07:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 07:51:55 INFO - mozversion application_buildid: 20170120062625 07:51:55 INFO - mozversion application_changeset: 3cedab21a7e65e6a1c4c2294ecfb5502575a46e3 07:51:55 INFO - mozversion application_display_name: Nightly 07:51:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:51:55 INFO - mozversion application_name: Firefox 07:51:55 INFO - mozversion application_remotingname: firefox 07:51:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:51:55 INFO - mozversion application_vendor: Mozilla 07:51:55 INFO - mozversion application_version: 53.0a1 07:51:55 INFO - mozversion platform_buildid: 20170120062625 07:51:55 INFO - mozversion platform_changeset: 3cedab21a7e65e6a1c4c2294ecfb5502575a46e3 07:51:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:51:55 INFO - mozversion platform_version: 53.0a1 07:51:55 INFO - using testdate: 1484927515 07:51:55 INFO - actual date: 1484927515 07:51:55 INFO - starting webserver on 'localhost:49235' 07:51:55 INFO - SUITE-START | Running 2 tests 07:51:55 INFO - TEST-START | dromaeo_css 07:51:55 INFO - operating with platform_type : mac_ 07:51:55 INFO - Initialising browser for dromaeo_css test... 07:51:55 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpHZYsVn/profile http://localhost:49235/getInfo.html) 07:51:58 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 07:51:58 INFO - PROCESS | 1638 | colorDepth:24 07:51:58 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 07:51:58 INFO - PROCESS | 1638 | __metrics 07:51:58 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 07:51:58 INFO - PROCESS | 1638 | 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" 07:51:58 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:51:59 INFO - TEST-INFO | 1638: exit 0 07:51:59 INFO - Browser initialized. 07:51:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:51:59 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpHZYsVn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:11 INFO - PROCESS | 1640 | RSS: Main: 235630592 07:52:11 INFO - PROCESS | 1640 | 07:55:15 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 07:55:16 INFO - PROCESS | 1640 | RSS: Main: 344776704 07:55:16 INFO - PROCESS | 1640 | 07:57:00 INFO - PROCESS | 1640 | ************************* 07:57:00 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 07:57:00 INFO - PROCESS | 1640 | 07:57:00 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:57:00 INFO - PROCESS | 1640 | Full stack: 07:57:00 INFO - PROCESS | 1640 | ************************* 07:58:19 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 07:58:19 INFO - PROCESS | 1640 | RSS: Main: 369889280 07:58:19 INFO - PROCESS | 1640 | 08:01:22 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 08:01:23 INFO - PROCESS | 1640 | RSS: Main: 343793664 08:01:23 INFO - PROCESS | 1640 | 08:04:25 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 08:04:25 INFO - PROCESS | 1640 | RSS: Main: 337485824 08:04:25 INFO - PROCESS | 1640 | 08:07:29 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 08:07:30 INFO - PROCESS | 1640 | RSS: Main: 332070912 08:07:30 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 08:10:33 INFO - PROCESS | 1640 | RSS: Main: 491118592 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | __start_tp_report 08:10:33 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 08:10:33 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 08:10:33 INFO - PROCESS | 1640 | |i|pagename|runs| 08:10:33 INFO - PROCESS | 1640 | |0;dojo.html;2601.427685909099;3368.949465758014;3379.72962163027;3390.7626466147367;3401.0477066421404;5611.382747897728;5701.657900525966;5707;5712.143178523218;5715.171300161474;5672.801451949183;5719.256496655439;5790.855228619276;5794.985877471436;5837.620554663955;5130.846074617767;5135.12702840518;5163.302954101205;5209.453007434222;5261.39493958194;5279.894402111955;5317;5323.627346085776;5326;5334.5999050071205;5119.513646203604;5301.310829592167;5313.787448502056;5321.813736519222;5339.866503337409;5185.170372740344;5194.246834209056;5211.296474975868;5223.059849227137;5230.476952304777;5194.532492075694;5207.3490813648295;5221.347331583552;5237.423883372826;5276;5698.316202055738;5728.22668939692;5745.454181852718;5767.538596912237;5806.970965145148;6134.803982731532;6173.81478555644;6190.84522886927;6238.781642642532;6295.905561416583;6285.560010799246;6288.496920246369;6293.811185664437;6302.55882088254;6326.114343991799;5837.678927658934;5859.472647461706;5902.911456328158;5919.200907877382;5942.168096466498;6128.044828652092;6173.753049878044;6234.127222188898;6268.122462855204;6319.05214217871;6120.6299886969155;6162.630242185483;6198.876022479525;6199;6206.162168107247;6147.354527774609;6206.503479721611;6209.223847019122;6219.751209951642;6221.47117495018;5201.245819356172;6141.455323060903;6152.384761523812;6177.011678131477;6185.536084793658;6186.690665466709;6218.347073557211;6247.312795592481;6403.455706264926;6436.678166091677;4935.432425271068;4951.653384263067;4955.90088198234;5022.321986531844;5038.64729468941;4437.778111094497;4467.352233926063;4489.6408287336935;4505.932411013838;4510.120526497301;5917.142014407887;5968.820935371946;5970.462658360769;6009.909851352233;6026.276846778414;6216.906746398808;6238.1266622672865;6248.9062664060075;6250.624962502265;6253.74985000604;5839.970800145972;5933.851653708605;5962.5826192167;5976.103584462278;6045.395460454008;5425.104857698436;5425.511703946585;5443.591730620219;5465.6447330923365;5487.725613719298;6337.841553961188;6340.71466784005;6344.619322840645;6357.205349331426;6369.363063693593;6183.227096612924;6228.22147231596;6253.343398943228;6259.998400255937;6273.74905003813;6171.59884607499;6232;6243.37566243372;6262.5929314594405;6324.335944725922;6171.290301615192;6219.0982307566055;6246.281677606951;6265;6282.246130464374;6107.328193898757;6181.443670069715;6249.9062514063235;6272.435480806749;6279.152314437675;5524.861878453071;6028.638281703112;6152.046432802923;6173.969130154321;6220.72006759706;6100.993336099494;6103.731658266399;6119.472088496418;6145.047517634774;6170.259568851767;5849.181114644039;6052.485538729257;6052.606580572248;6058.90911636317;6092;6046.818595442144;6084.33072362031;6099.3900609938655;6128.9693551531955;6150.815475535741;6066.211392518944;6079.574429789872;6082.939170608237;6087.756489740361;6097.634141951497 08:10:33 INFO - PROCESS | 1640 | |1;ext.html;443.2840961846618;448.8922658561946;526.4183077699141;528.1786821492577;534.6337758635335;27482.312942176457;34228;35540.64459355409;42487.575124248746;44491;42069.36895946556;42558;42668.57331426685;42677.78661106698;42772.57227427725;8204.794880128014;9218.585163667634;9430.952845235764;9431.386959847589;9472.573734181979;8397.664093436286;8597.312215022783;11148.498317575728;11410.429478526083;11429.371384573846;11381.544738210461;11392.974632283092;11416;11436.542538298458;11460.828087578693;8432.747017589481;11318.660440186808;11420.486078126463;11423.828642570368;11424.143189260756;8414.074451810297;9614.010185772895;11043.779124417548;11306.491207895664;11520.251183673117;34585.48121778175;41310.967225819295;41620.791896040326;41628.75113746592;41648.95877603054;4047.251258517184;4058.641362607711;4075.1442197138635;4077.1641813428473;4213.325867861158;29732;30111.397772044656;30367.848160759055;30915.536266956013;31156.376872462424;3143.7327827134723;3223.5164725291393;3311.7350611950988;3327.6505966873374;3357.278185190196;462880;464545;464842.9999999966;464961;466019.66990165174;60510.69744651249;60523.69738151369;60540.39459605436;60957.390426095175;60960;64013;64335.356646432934;64474;64498.67750661311;64627.921509811276;15656.765148522782;16171.838281617269;16179;16221.59446013859;16222.026678399334;10699.679009629723;11318.717032074264;12568.622941311774;12576.308303043237;12604.369781510888;14099.224542650047;14495.275236238145;16023.679526409407;16389;16391.754123688155;5325.4142044375085;6131.417515336036;6168.691565421711;6178.69106544671;6259.655718935411;725.5465334166146;848.6181218451721;866.445474896067;867.5965675960582;913.5980168725739;29772.553411698842;30110.54834177489;30256.84871575672;30305.257825149678;30606.54090188649;939.7650587353162;1046.1317106801337;1062.675883855416;1091.3779145886926;1103.0844399148848;14627.414903403745;15057.397704091714;15548.92225538865;15713.907866435648;16004.439844605384;575603;575849;579299;579724;580580;59230;59568.70215648981;59575.40424595698;59968.10047849286;60069.39930600725;1424.1882127187612;1451.3468938977503;1465.0916431812345;1472.506710252056;1473.3075454536352;29026.27434314159;29183;29235.561466578445;29867.402651947275;30321.393572127992;49944.750276248385;50384.24423633575;50386.49613503818;50386.992260155326;50678;419659;421053;422295;422599;422614;38613.613863861;39094.80452597719;39499.60500395074;39621.2075758489;39743.40384894171;45600.7719961398;45606.08787824158;46373.536264636925;46851;47124.76437617927;38016.42975355427;38366;38630;39401.01497462586;39737.82097432256;37350;37865.24269514539;38371.80814096023;38955.2208955825;39214.607853921094;32097.679023210403;37288.254234915694;37849.4322585156;38099.61900380961;38244.61755382411;31052;33528.83235583904;33740.49389259212;33963.830180848934;34091;24206.878965605763;24461.654608996676;24812.131575394775;24866.627000594643;25260 08:10:33 INFO - PROCESS | 1640 | |2;jquery.html;330.34921205225703;367.98160091995396;389.33229511387964;400.7675548182054;422.5098885293059;15703.21483925805;15756.527304180878;19159;21507.81707006118;21527.461813454633;17031.48905532836;19945.800541994577;20611.69082463764;20995.790042099612;21909.014094365753;5276.12943864262;5408.702521361323;5455.918161227585;5460.153676180198;5972.462478376945;3912.471816304791;5966.79116230932;6045.72794224261;6049.334573196945;6050.697465126748;4100.138970816132;5783.768649254025;5998.1602575639445;6051.425114614105;6114.908276375858;5447.237386765856;5989.101634754778;6072.848178795522;6095.146679464834;6095.512359011291;5985.072313791369;5988.161657367972;5988.520918326523;5990.400959903975;5995.100734889757;13449.529266475627;23830.80845957695;24358.63462048071;24797;26071.217863464128;2591.157873691058;2609.4781043791318;2662.267876334004;2695.7439043290856;2698.5952107183884;10095.798084038279;10456.32033917793;10683.946580267128;12364.814527782091;14676.779848302283;1801.8018018018008;1854.0173707934816;1860.255897640941;1873.5878106816479;1897.5066482714456;125450;128836;129375.70624293637;134588.9811652816;137217;11263.493142808593;11636.476358563885;11739.941300293443;11833.763324733458;12036.699082522831;15650.765238521431;15654.217289135499;15664.451744188898;15671.608209794618;15677.05937643745;8215.876761848576;8542.615582298811;8545.2309292164;8679.783005424788;8693.261072808882;8153.7553873383895;8162.7143049992965;8204.712835050745;8351.707690230935;8353.540555269397;4007.8797636070963;4665.906681866411;4754.690945088558;4789.95210047902;4874.195757699939;1741.7996930352917;1960.3040920473027;1971.7436733224588;2013.6576781947103;2023.3120738948828;1006.6577363696379;1011.2870426349554;1016.3495362967707;1027.2860362048455;1037.9221558383151;18563.72154417685;21155.576888462143;21387;21435.8928205358;21644.134234630754;918.4489306416231;974.4396971741277;1038.7403149212696;1045.1743122932799;1062.4846949229618;10598.0991615712;10847.566097356175;11118.55525778976;11135.888641113484;11218.66344009681;598921;689275;694775;699808;707599;140329;141363;146171;146320;148838;1013.9391636501833;1035.2856528994969;1059.8092343378112;1067.4929408530886;1067.882532921378;15538.533843984247;16001.839981600035;18910.52723681919;19693.365582585815;19701;34047;53504;53930.73034634802;56105;56919.99999999834;82502.17497824944;82762.58618706868;83605.90985225418;84077;85297.57351213452;7531.924680753342;7928.207179282025;7961;8057.153998830273;8216.958915205385;8622.65509379643;11285.887141128484;12160.817587736368;12391.690207744517;12613.49546018149;9085.682001129928;10466.842997355197;10756.51595678212;10860.230641186763;11151.330920144817;9682.612695492102;10468.424236666751;10508.159347252355;10658.786824263627;10730.839037414602;10906.509207085859;10964.026475234215;11023.393713345842;11054.00513953748;11199.88800112021;6939.791806245821;7856.528608283293;7994.5602991836;8001.479903806234;8031.59842007909;8024.959875200587;9707.369021013612;10281.2803103785;10889.891101089204;10949.397783122005 08:10:33 INFO - PROCESS | 1640 | |3;mootools.html;1440.971180576388;1465.1721777195883;1480.111932840296;1486.3980088064338;1489.672272100138;8112.229338212867;8481.575921203937;8483.745487635366;8487.448315859465;8491.95754021229;7487.288707572786;7715.807104822382;8040.8391832163325;8278.54468004261;8299.668013279477;2278.646809744492;2322.3729593009875;2327.1622216002224;2327.2901764961766;2330.533893221354;2303.3320337102305;2330.88345582721;2332.918347857825;2334.1363695432715;2341.637046257833;1799.7840259168918;1880.56746948202;1910.646530391882;2100.6008858316945;2105.0737675422843;2290.9885450572724;2312.387217387394;2312.5721741477882;2317.640765681322;2318.7565305642834;2210.6131427000373;2229.4314949687728;2317.0500094961153;2320.582295186866;2322.3149170994598;8373;8466.365022623328;8477.66089356425;8478.957605211996;8484.490930544187;4476.84331048415;5013.47358527353;5174.844754657366;5175.042617115846;5184.326037615124;3197.5043868200464;3342.866285348583;3368.124287685195;3404.608470025954;3426.5202871597994;1144.627995901327;1195.9402029898558;1202.9699257518544;1237.1340061956575;1240.3116270469886;10725.195610329178;10744.570217191382;10882.29265097766;10886;10912.290701104403;4422.358757980139;4572.7942242599165;4638.5593368629925;4641.651876109306;4652.906941861143;9416.90583094174;9445.622175112918;9447.480388578695;9449.291303152291;9455.479948602893;5140.948590514122;5201.375834899761;5234.18870075139;5253.106971814801;5260.736963151827;4626.606738427204;4684.320773487893;4791.808327666854;4799.520047995243;4813.687110337817;3272.8199949002556;3743.1577894973957;3789.317922773927;3862.575116737157;3872.477215575861;1177.7173478365303;1191.350713860948;1269.9746005079846;1270.6315168601186;1281.4297637551388;855.6021450025768;870.6691457246205;880.4849163239448;905.9506286643223;915.5056269614466;5417.51242388187;5426.186072089139;5606.046972014768;5632.239647647597;5702.37273899879;945.9858102128474;982.2731178927685;987.8962708915604;1000.1698590170141;1034.5396298647029;3654.9634503655157;3661.908452288661;3733.141377483194;3749.9250015000093;3782.167923056923;9805.80388392228;10047.849282260771;10056.949715251523;10085.294029418017;10104.04011618895;9891.307608467338;9987.600495980225;10004.649837255662;10006.54970526328;10030.598776048877;7656.61716914152;7881;7882.054153501502;7896;7899.328557072713;5334.599905007218;5451.046066938349;5579.776808927598;5657.60396772222;5680.062789639664;9207.769805754642;9296.349255552046;9335;9347.813043739223;9367;7747.341475974606;9222.538873056454;9312.301577381588;9408.858867117136;9547;6148.354422785543;6909.067275917687;7026.297370263137;7031.1211098612675;7087.858242835217;7821.178776228641;7825.726099586487;7910.802229944067;7918.722844700408;7921.920780792118;7012.333828286304;7135.6432178391915;7140.750073747394;7175.390091842252;7235.421166306577;6981.930180698331;7006.684699188447;7025.192102908231;7050.977608246673;7063.82340441493;6282.340354262737;6333.683315834098;6416.550841441054;6429.453496452854;6439.066335381437;4854.466008738966;4880.438749543706;4927.507249275044;4959.900801984012;5034.194528875509;4384.49578298487;4422.49141348749;4471.06107717383;4490.550944905483;4573.725576465423 08:10:33 INFO - PROCESS | 1640 | |4;prototype.html;311.40366198729436;358.60374286413514;361.41992102675204;370.7682698313554;372.2016275089934;4667.649926255527;5053.5451809337155;5149;5172.586193104552;5184.7297412133985;4904.75476226189;5120.411152717429;5164.457731938149;5176.767045482953;5189.987952349294;2924.605178300934;3378.1385746634696;3936.0872954013967;3971.821268042945;4013.7591744495426;3357.529945807589;3974.9602503975025;3989.52125744911;3990.481237439129;4013.59184489307;3708.2212735325616;4005.299072662287;4009.67922566194;4017.919641607166;4044.3933409988445;3837.2517359114986;3932.744371615836;3964.8414063437426;4035.435039094529;4049.2104039712417;2835.8723857426257;3006.383691343269;3162.478191098466;3577.2487777566744;3580.695640870529;3881.146147847469;4021.6929497913297;4476.61948734358;4702.3181638662545;5012.298278241013;3980.805758272507;4271.825248056778;4396.340548917656;4630.536946305376;4630.82788290019;4773.665843390964;4863.392075990501;5161.458046905059;5369.650972686802;5445.428230035829;3168.904932851995;3292.983535082333;3693.4275187346007;3735.62643735627;3745.138618117848;4435.911281774379;5062.392512898476;5467.6719396836315;5689.459501347365;5707.343655479632;2913.0823790505924;3555.8577656893435;3688.7026613994394;3749.3813520769313;3786.545614526219;3389.5254664347012;3802.6767724743154;3822.4075268333454;3830.7701537907815;3836.271108489378;4247.469066366704;4407.060893206979;4438.514431918136;4456.442944631921;4466.642668586505;5059.367579052619;5166.689998600096;5471.68679516921;5511.53151982078;5571.916421253684;1122.9438528073563;1214.7791469573021;1237.5977807212691;1238.9530846434748;1250.7561025600103;758.7647829172863;849.4223927729204;856.7943693513637;869.699953516036;871.5337294547387;4206.592659945454;4285.764282964405;4706.435227772689;4818.903621927542;4860.586850117779;5354.223637572531;5355.86610334737;5356.4107948125675;5391.406945236021;5410.594205434608;3735.685283497565;4051.7974101294817;4084.4880398554674;4390.468010306972;4640.767961601974;2517.446161844391;2563.7822034533447;2761.0888406825698;2764.682061562906;2838.587200879236;5049.343585333883;5579.302587176603;5585.972070139624;5589.552835773128;5644.403574355761;4963.45402005779;5146.8970620588125;5526.889462210734;5577.498025177672;5607.607467477319;5020.824271150492;5166.483351664879;5544.390117087117;5565.610407271533;5615.719214039282;4705.529447055267;5400.378956419905;5408.296921400193;5433.375161856437;5433.429489903661;4805;4892.461829198714;5083.745812709423;5122.385313762373;5423.62034657586;4994.500549944976;5367.537938030026;5543.002259593312;5695.743691533974;5703.08750599902;3688.6577023589675;3709.3323201823932;3714.721395895265;3726.16161363691;3986.4219688144476;4675.953240467552;5399.973000135132;5621.381648018796;5678.630888992202;5683.630564013326;4641.535846415331;5032.899342013213;5258.1849813279005;5373.543248823894;5490.858565159511;4561.654311978041;4840.443349014909;5480.931218412371;5492.972535137299;5493.697846618475;5301.920471193012;5305.389880163831;5342.572594192533;5374.489423504917;5402.459754024566;4683.9226977794615;5266.183741520071;5327.200919862052;5408.945910540844;5493.670379777226;4109.671226301829;5377.516023557899;5397.789724015274;5414.536385944307;5463.295668644047 08:10:33 INFO - PROCESS | 1640 | |5;yui.html;726.8255618651522;760.6234913717703;779.6101949025488;800.8278220182661;819.4796304346738;14716.04345717529;15578;15604.375824966988;15618.76571851423;15625.3749850006;14284.92857535711;14434.639134021629;14471.276436178201;14480.493182738606;14486.2756862157;680.7413182990457;697.2400083908539;697.3688811625487;849.6304107713133;865.6234537975969;672.6771149848075;866.0040952904179;866.8916385451819;867.4491697771929;870.1907226279558;927.7402327348353;927.935044546882;928.4661319741142;929.4330458420358;930.2186163622556;713.0195980526776;728.2499026003226;849.8512760266929;921.3734660430904;922.4142669404943;689.7654797368868;692.9237783843773;694.9200841903145;695.9443244540424;696.6516741629185;15034.398624055024;15321.770173447407;15335.463258786;15367.538973830802;15385.692286154213;12942.417591208417;13096.86903130966;13166.670833229151;13857.168569885838;14022.579322620337;12827.294498802563;13125.474981000749;13134.737305253937;13295.135816171918;13755.656108597264;4224.38746381776;4250.957490425087;4486.282194848841;4561.977190114028;4726.1020406122725;103400.48299758528;103456;105924;105925;106797.46601266944;10979.231453798317;11000.22998390105;11087.55649774;11096.944515277371;11172.273802202993;21197.682034769492;21200.93995300229;21234.256801012198;21235.68146477804;21242.36272911815;7677.961610192025;7686.192949740309;7745.496542724817;7888.526688398714;7916.683332666629;4279.657627389802;4309.569043095666;4313.439252897103;4315.201687687788;4348.326009468537;3407.4207384744655;3478.252175782219;3493.7205023598053;3496.947545786815;3497.5802903651725;656.471540409965;660.51782198995;661.3915198017835;675.2268652392983;675.3617831149517;637.6174295422802;640.810960766575;660.5145218264572;664.1896885799317;680.5406350713249;9350.205232555309;9565.808683826284;9679.806403871884;9826.164775993977;9959.502024898726;545.969971651563;563.5069314349944;583.2592607388593;585.7042193692243;610.8625559249133;4656.883577910579;4991.925121123186;5027.648064635514;5115.974420127875;5118.232265160182;85177;89795.20409591771;94553;97214;99639;77971.22028779754;78012;79772;81410.5929470349;81650.59174704207;75552.48895022178;76307;76953;77482.61258693783;78822;9808.754781130528;9825.55784989663;9829.606815727291;9846.113849753556;9849.359791613522;42202.577974219865;45914.081718364774;48256;49290.75354623204;50053.74973125111;58262.70868645799;63315.417114572505;64657;66320;66591.66704166448;13406.128601641252;13481.393337300042;13874.445022199403;13897.930510347383;13903.304834758019;14598.343074561457;15285.847141528442;15327.157006364758;15541.611459713598;15949.840501594836;13463.798043029166;13960.441582336593;14082.366293516612;14118.929405352908;14561.980661353604;13589.388477518338;13768.105073170213;14111.788323175366;14504.34730437154;14701;13706.862931370559;13726.588202353945;13945.02384833052;13962;14314.141151530941;10769.676909692722;11175.161862860155;11233.32600044;11391.145664075393;11903.047756179312;10111.476062506104;10798.244122911636;11115.055220306365;11461.140414469115;11658.358790266617 08:10:33 INFO - PROCESS | 1640 | __end_tp_report 08:10:33 INFO - PROCESS | 1640 | __start_cc_report 08:10:33 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1180 08:10:33 INFO - PROCESS | 1640 | __end_cc_report 08:10:33 INFO - PROCESS | 1640 | __startTimestamp1484928633715__endTimestamp 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | ------- Summary: start ------- 08:10:33 INFO - PROCESS | 1640 | Number of tests: 6 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5777.05 Median:6058.91 stddev:652.39 (10.8%) stddev-sans-first:604.96 08:10:33 INFO - PROCESS | 1640 | Values: 2601.4 3368.9 3379.7 3390.8 3401.0 5611.4 5701.7 5707.0 5712.1 5715.2 5672.8 5719.3 5790.9 5795.0 5837.6 5130.8 5135.1 5163.3 5209.5 5261.4 5279.9 5317.0 5323.6 5326.0 5334.6 5119.5 5301.3 5313.8 5321.8 5339.9 5185.2 5194.2 5211.3 5223.1 5230.5 5194.5 5207.3 5221.3 5237.4 5276.0 5698.3 5728.2 5745.5 5767.5 5807.0 6134.8 6173.8 6190.8 6238.8 6295.9 6285.6 6288.5 6293.8 6302.6 6326.1 5837.7 5859.5 5902.9 5919.2 5942.2 6128.0 6173.8 6234.1 6268.1 6319.1 6120.6 6162.6 6198.9 6199.0 6206.2 6147.4 6206.5 6209.2 6219.8 6221.5 5201.2 6141.5 6152.4 6177.0 6185.5 6186.7 6218.3 6247.3 6403.5 6436.7 4935.4 4951.7 4955.9 5022.3 5038.6 4437.8 4467.4 4489.6 4505.9 4510.1 5917.1 5968.8 5970.5 6009.9 6026.3 6216.9 6238.1 6248.9 6250.6 6253.7 5840.0 5933.9 5962.6 5976.1 6045.4 5425.1 5425.5 5443.6 5465.6 5487.7 6337.8 6340.7 6344.6 6357.2 6369.4 6183.2 6228.2 6253.3 6260.0 6273.7 6171.6 6232.0 6243.4 6262.6 6324.3 6171.3 6219.1 6246.3 6265.0 6282.2 6107.3 6181.4 6249.9 6272.4 6279.2 5524.9 6028.6 6152.0 6174.0 6220.7 6101.0 6103.7 6119.5 6145.0 6170.3 5849.2 6052.5 6052.6 6058.9 6092.0 6046.8 6084.3 6099.4 6129.0 6150.8 6066.2 6079.6 6082.9 6087.8 6097.6 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:63749.70 Median:39025.01 stddev:131005.89 (335.7%) stddev-sans-first:131287.17 08:10:33 INFO - PROCESS | 1640 | Values: 443.3 448.9 526.4 528.2 534.6 27482.3 34228.0 35540.6 42487.6 44491.0 42069.4 42558.0 42668.6 42677.8 42772.6 8204.8 9218.6 9431.0 9431.4 9472.6 8397.7 8597.3 11148.5 11410.4 11429.4 11381.5 11393.0 11416.0 11436.5 11460.8 8432.7 11318.7 11420.5 11423.8 11424.1 8414.1 9614.0 11043.8 11306.5 11520.3 34585.5 41311.0 41620.8 41628.8 41649.0 4047.3 4058.6 4075.1 4077.2 4213.3 29732.0 30111.4 30367.8 30915.5 31156.4 3143.7 3223.5 3311.7 3327.7 3357.3 462880.0 464545.0 464843.0 464961.0 466019.7 60510.7 60523.7 60540.4 60957.4 60960.0 64013.0 64335.4 64474.0 64498.7 64627.9 15656.8 16171.8 16179.0 16221.6 16222.0 10699.7 11318.7 12568.6 12576.3 12604.4 14099.2 14495.3 16023.7 16389.0 16391.8 5325.4 6131.4 6168.7 6178.7 6259.7 725.5 848.6 866.4 867.6 913.6 29772.6 30110.5 30256.8 30305.3 30606.5 939.8 1046.1 1062.7 1091.4 1103.1 14627.4 15057.4 15548.9 15713.9 16004.4 575603.0 575849.0 579299.0 579724.0 580580.0 59230.0 59568.7 59575.4 59968.1 60069.4 1424.2 1451.3 1465.1 1472.5 1473.3 29026.3 29183.0 29235.6 29867.4 30321.4 49944.8 50384.2 50386.5 50387.0 50678.0 419659.0 421053.0 422295.0 422599.0 422614.0 38613.6 39094.8 39499.6 39621.2 39743.4 45600.8 45606.1 46373.5 46851.0 47124.8 38016.4 38366.0 38630.0 39401.0 39737.8 37350.0 37865.2 38371.8 38955.2 39214.6 32097.7 37288.3 37849.4 38099.6 38244.6 31052.0 33528.8 33740.5 33963.8 34091.0 24206.9 24461.7 24812.1 24866.6 25260.0 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:37984.07 Median:21517.64 stddev:113473.90 (527.4%) stddev-sans-first:113757.00 08:10:33 INFO - PROCESS | 1640 | Values: 330.3 368.0 389.3 400.8 422.5 15703.2 15756.5 19159.0 21507.8 21527.5 17031.5 19945.8 20611.7 20995.8 21909.0 5276.1 5408.7 5455.9 5460.2 5972.5 3912.5 5966.8 6045.7 6049.3 6050.7 4100.1 5783.8 5998.2 6051.4 6114.9 5447.2 5989.1 6072.8 6095.1 6095.5 5985.1 5988.2 5988.5 5990.4 5995.1 13449.5 23830.8 24358.6 24797.0 26071.2 2591.2 2609.5 2662.3 2695.7 2698.6 10095.8 10456.3 10683.9 12364.8 14676.8 1801.8 1854.0 1860.3 1873.6 1897.5 125450.0 128836.0 129375.7 134589.0 137217.0 11263.5 11636.5 11739.9 11833.8 12036.7 15650.8 15654.2 15664.5 15671.6 15677.1 8215.9 8542.6 8545.2 8679.8 8693.3 8153.8 8162.7 8204.7 8351.7 8353.5 4007.9 4665.9 4754.7 4790.0 4874.2 1741.8 1960.3 1971.7 2013.7 2023.3 1006.7 1011.3 1016.3 1027.3 1037.9 18563.7 21155.6 21387.0 21435.9 21644.1 918.4 974.4 1038.7 1045.2 1062.5 10598.1 10847.6 11118.6 11135.9 11218.7 598921.0 689275.0 694775.0 699808.0 707599.0 140329.0 141363.0 146171.0 146320.0 148838.0 1013.9 1035.3 1059.8 1067.5 1067.9 15538.5 16001.8 18910.5 19693.4 19701.0 34047.0 53504.0 53930.7 56105.0 56920.0 82502.2 82762.6 83605.9 84077.0 85297.6 7531.9 7928.2 7961.0 8057.2 8217.0 8622.7 11285.9 12160.8 12391.7 12613.5 9085.7 10466.8 10756.5 10860.2 11151.3 9682.6 10468.4 10508.2 10658.8 10730.8 10906.5 10964.0 11023.4 11054.0 11199.9 6939.8 7856.5 7994.6 8001.5 8031.6 8025.0 9707.4 10281.3 10889.9 10949.4 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5399.56 Median:5087.57 stddev:2971.41 (58.4%) stddev-sans-first:2964.85 08:10:33 INFO - PROCESS | 1640 | Values: 1441.0 1465.2 1480.1 1486.4 1489.7 8112.2 8481.6 8483.7 8487.4 8492.0 7487.3 7715.8 8040.8 8278.5 8299.7 2278.6 2322.4 2327.2 2327.3 2330.5 2303.3 2330.9 2332.9 2334.1 2341.6 1799.8 1880.6 1910.6 2100.6 2105.1 2291.0 2312.4 2312.6 2317.6 2318.8 2210.6 2229.4 2317.1 2320.6 2322.3 8373.0 8466.4 8477.7 8479.0 8484.5 4476.8 5013.5 5174.8 5175.0 5184.3 3197.5 3342.9 3368.1 3404.6 3426.5 1144.6 1195.9 1203.0 1237.1 1240.3 10725.2 10744.6 10882.3 10886.0 10912.3 4422.4 4572.8 4638.6 4641.7 4652.9 9416.9 9445.6 9447.5 9449.3 9455.5 5140.9 5201.4 5234.2 5253.1 5260.7 4626.6 4684.3 4791.8 4799.5 4813.7 3272.8 3743.2 3789.3 3862.6 3872.5 1177.7 1191.4 1270.0 1270.6 1281.4 855.6 870.7 880.5 906.0 915.5 5417.5 5426.2 5606.0 5632.2 5702.4 946.0 982.3 987.9 1000.2 1034.5 3655.0 3661.9 3733.1 3749.9 3782.2 9805.8 10047.8 10056.9 10085.3 10104.0 9891.3 9987.6 10004.6 10006.5 10030.6 7656.6 7881.0 7882.1 7896.0 7899.3 5334.6 5451.0 5579.8 5657.6 5680.1 9207.8 9296.3 9335.0 9347.8 9367.0 7747.3 9222.5 9312.3 9408.9 9547.0 6148.4 6909.1 7026.3 7031.1 7087.9 7821.2 7825.7 7910.8 7918.7 7921.9 7012.3 7135.6 7140.8 7175.4 7235.4 6981.9 7006.7 7025.2 7051.0 7063.8 6282.3 6333.7 6416.6 6429.5 6439.1 4854.5 4880.4 4927.5 4959.9 5034.2 4384.5 4422.5 4471.1 4490.6 4573.7 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4308.05 Median:4789.33 stddev:1328.67 (27.7%) stddev-sans-first:1298.09 08:10:33 INFO - PROCESS | 1640 | Values: 311.4 358.6 361.4 370.8 372.2 4667.6 5053.5 5149.0 5172.6 5184.7 4904.8 5120.4 5164.5 5176.8 5190.0 2924.6 3378.1 3936.1 3971.8 4013.8 3357.5 3975.0 3989.5 3990.5 4013.6 3708.2 4005.3 4009.7 4017.9 4044.4 3837.3 3932.7 3964.8 4035.4 4049.2 2835.9 3006.4 3162.5 3577.2 3580.7 3881.1 4021.7 4476.6 4702.3 5012.3 3980.8 4271.8 4396.3 4630.5 4630.8 4773.7 4863.4 5161.5 5369.7 5445.4 3168.9 3293.0 3693.4 3735.6 3745.1 4435.9 5062.4 5467.7 5689.5 5707.3 2913.1 3555.9 3688.7 3749.4 3786.5 3389.5 3802.7 3822.4 3830.8 3836.3 4247.5 4407.1 4438.5 4456.4 4466.6 5059.4 5166.7 5471.7 5511.5 5571.9 1122.9 1214.8 1237.6 1239.0 1250.8 758.8 849.4 856.8 869.7 871.5 4206.6 4285.8 4706.4 4818.9 4860.6 5354.2 5355.9 5356.4 5391.4 5410.6 3735.7 4051.8 4084.5 4390.5 4640.8 2517.4 2563.8 2761.1 2764.7 2838.6 5049.3 5579.3 5586.0 5589.6 5644.4 4963.5 5146.9 5526.9 5577.5 5607.6 5020.8 5166.5 5544.4 5565.6 5615.7 4705.5 5400.4 5408.3 5433.4 5433.4 4805.0 4892.5 5083.7 5122.4 5423.6 4994.5 5367.5 5543.0 5695.7 5703.1 3688.7 3709.3 3714.7 3726.2 3986.4 4676.0 5400.0 5621.4 5678.6 5683.6 4641.5 5032.9 5258.2 5373.5 5490.9 4561.7 4840.4 5480.9 5493.0 5493.7 5301.9 5305.4 5342.6 5374.5 5402.5 4683.9 5266.2 5327.2 5408.9 5493.7 4109.7 5377.5 5397.8 5414.5 5463.3 08:10:33 INFO - PROCESS | 1640 | 08:10:33 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19859.01 Median:25285.48 stddev:27662.43 (109.4%) stddev-sans-first:27702.73 08:10:33 INFO - PROCESS | 1640 | Values: 726.8 760.6 779.6 800.8 819.5 14716.0 15578.0 15604.4 15618.8 15625.4 14284.9 14434.6 14471.3 14480.5 14486.3 680.7 697.2 697.4 849.6 865.6 672.7 866.0 866.9 867.4 870.2 927.7 927.9 928.5 929.4 930.2 713.0 728.2 849.9 921.4 922.4 689.8 692.9 694.9 695.9 696.7 15034.4 15321.8 15335.5 15367.5 15385.7 12942.4 13096.9 13166.7 13857.2 14022.6 12827.3 13125.5 13134.7 13295.1 13755.7 4224.4 4251.0 4486.3 4562.0 4726.1 103400.5 103456.0 105924.0 105925.0 106797.5 10979.2 11000.2 11087.6 11096.9 11172.3 21197.7 21200.9 21234.3 21235.7 21242.4 7678.0 7686.2 7745.5 7888.5 7916.7 4279.7 4309.6 4313.4 4315.2 4348.3 3407.4 3478.3 3493.7 3496.9 3497.6 656.5 660.5 661.4 675.2 675.4 637.6 640.8 660.5 664.2 680.5 9350.2 9565.8 9679.8 9826.2 9959.5 546.0 563.5 583.3 585.7 610.9 4656.9 4991.9 5027.6 5116.0 5118.2 85177.0 89795.2 94553.0 97214.0 99639.0 77971.2 78012.0 79772.0 81410.6 81650.6 75552.5 76307.0 76953.0 77482.6 78822.0 9808.8 9825.6 9829.6 9846.1 9849.4 42202.6 45914.1 48256.0 49290.8 50053.7 58262.7 63315.4 64657.0 66320.0 66591.7 13406.1 13481.4 13874.4 13897.9 13903.3 14598.3 15285.8 15327.2 15541.6 15949.8 13463.8 13960.4 14082.4 14118.9 14562.0 13589.4 13768.1 14111.8 14504.3 14701.0 13706.9 13726.6 13945.0 13962.0 14314.1 10769.7 11175.2 11233.3 11391.1 11903.0 10111.5 10798.2 11115.1 11461.1 11658.4 08:10:33 INFO - PROCESS | 1640 | -------- Summary: end -------- 08:10:33 INFO - PROCESS | 1640 | 08:10:34 INFO - TEST-INFO | 1640: exit 0 08:10:34 INFO - TEST-OK | dromaeo_css | took 1118618ms 08:10:34 INFO - TEST-START | kraken 08:10:34 INFO - operating with platform_type : mac_ 08:10:34 INFO - Initialising browser for kraken test... 08:10:34 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpdFXa1z/profile http://localhost:49235/getInfo.html) 08:10:36 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 08:10:36 INFO - PROCESS | 1650 | colorDepth:24 08:10:36 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 08:10:36 INFO - PROCESS | 1650 | __metrics 08:10:36 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 08:10:36 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:10:36 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:37 INFO - TEST-INFO | 1650: exit 0 08:10:37 INFO - Browser initialized. 08:10:37 INFO - Running cycle 1/1 for kraken test... 08:10:37 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpdFXa1z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:49 INFO - PROCESS | 1651 | RSS: Main: 226316288 08:10:49 INFO - PROCESS | 1651 | 08:10:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 08:10:53 INFO - PROCESS | 1651 | RSS: Main: 287600640 08:10:53 INFO - PROCESS | 1651 | 08:10:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 08:10:56 INFO - PROCESS | 1651 | RSS: Main: 289382400 08:10:56 INFO - PROCESS | 1651 | 08:11:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 08:11:00 INFO - PROCESS | 1651 | RSS: Main: 380522496 08:11:00 INFO - PROCESS | 1651 | 08:11:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 08:11:03 INFO - PROCESS | 1651 | RSS: Main: 283410432 08:11:03 INFO - PROCESS | 1651 | 08:11:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:06 INFO - PROCESS | 1651 | RSS: Main: 286908416 08:11:06 INFO - PROCESS | 1651 | 08:11:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:09 INFO - PROCESS | 1651 | RSS: Main: 329932800 08:11:09 INFO - PROCESS | 1651 | 08:11:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:12 INFO - PROCESS | 1651 | RSS: Main: 330104832 08:11:12 INFO - PROCESS | 1651 | 08:11:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 08:11:16 INFO - PROCESS | 1651 | RSS: Main: 327364608 08:11:16 INFO - PROCESS | 1651 | 08:11:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:18 INFO - PROCESS | 1651 | RSS: Main: 303169536 08:11:18 INFO - PROCESS | 1651 | 08:11:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:11:21 INFO - PROCESS | 1651 | RSS: Main: 304783360 08:11:21 INFO - PROCESS | 1651 | 08:11:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:11:23 INFO - PROCESS | 1651 | RSS: Main: 305922048 08:11:23 INFO - PROCESS | 1651 | 08:11:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:11:27 INFO - PROCESS | 1651 | RSS: Main: 326713344 08:11:27 INFO - PROCESS | 1651 | 08:11:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:11:31 INFO - PROCESS | 1651 | RSS: Main: 320057344 08:11:31 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 08:11:33 INFO - PROCESS | 1651 | RSS: Main: 363991040 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | __start_tp_report 08:11:33 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:11:33 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:11:33 INFO - PROCESS | 1651 | |i|pagename|runs| 08:11:33 INFO - PROCESS | 1651 | |0;ai-astar;104;114;114;113;113;115;114;114;111;113 08:11:33 INFO - PROCESS | 1651 | |1;audio-beat-detection;143;110;110;150;142;121;109;110;148;141 08:11:33 INFO - PROCESS | 1651 | |2;audio-dft;183;181;182;185;205;258;181;183;181;185 08:11:33 INFO - PROCESS | 1651 | |3;audio-fft;78;59;58;87;61;58;72;83;96;76 08:11:33 INFO - PROCESS | 1651 | |4;audio-oscillator;85;71;85;68;74;99;83;67;69;83 08:11:33 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;84;86;83;85;86;87;84;86;87 08:11:33 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;95;96;96;97;96;96;95;96;95 08:11:33 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;87;87;85;84;87;87;87;85;86 08:11:33 INFO - PROCESS | 1651 | |8;json-parse-financial;56;57;54;54;55;56;55;55;56;55 08:11:33 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;63;64;76;78;74;70;67;71;69;68 08:11:33 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;87;86;87;88;86;85;89;87;87;75 08:11:33 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;141;142;143;142;143;138;143;142;182;150 08:11:33 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;177;203;172;172;185;226;209;173;175;172 08:11:33 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;75;83;85;85;68;68;68;65;66;66 08:11:33 INFO - PROCESS | 1651 | __end_tp_report 08:11:33 INFO - PROCESS | 1651 | __start_cc_report 08:11:33 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1946 08:11:33 INFO - PROCESS | 1651 | __end_cc_report 08:11:33 INFO - PROCESS | 1651 | __startTimestamp1484928693332__endTimestamp 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:11:33 INFO - PROCESS | 1651 | Number of tests: 14 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.17 (2.8%) stddev-sans-first:1.13 08:11:33 INFO - PROCESS | 1651 | Values: 104.0 114.0 114.0 113.0 113.0 115.0 114.0 114.0 111.0 113.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:141.50 stddev:17.81 (12.6%) stddev-sans-first:18.09 08:11:33 INFO - PROCESS | 1651 | Values: 143.0 110.0 110.0 150.0 142.0 121.0 109.0 110.0 148.0 141.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:192.40 Median:184.00 stddev:24.14 (13.1%) stddev-sans-first:25.37 08:11:33 INFO - PROCESS | 1651 | Values: 183.0 181.0 182.0 185.0 205.0 258.0 181.0 183.0 181.0 185.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:72.80 Median:77.00 stddev:13.54 (17.6%) stddev-sans-first:14.23 08:11:33 INFO - PROCESS | 1651 | Values: 78.0 59.0 58.0 87.0 61.0 58.0 72.0 83.0 96.0 76.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:83.00 stddev:10.30 (12.4%) stddev-sans-first:10.64 08:11:33 INFO - PROCESS | 1651 | Values: 85.0 71.0 85.0 68.0 74.0 99.0 83.0 67.0 69.0 83.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.41 08:11:33 INFO - PROCESS | 1651 | Values: 88.0 84.0 86.0 83.0 85.0 86.0 87.0 84.0 86.0 87.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 08:11:33 INFO - PROCESS | 1651 | Values: 95.0 95.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 95.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:87.00 stddev:1.10 (1.3%) stddev-sans-first:1.17 08:11:33 INFO - PROCESS | 1651 | Values: 86.0 87.0 87.0 85.0 84.0 87.0 87.0 87.0 85.0 86.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:0.95 (1.7%) stddev-sans-first:0.97 08:11:33 INFO - PROCESS | 1651 | Values: 56.0 57.0 54.0 54.0 55.0 56.0 55.0 55.0 56.0 55.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:4.90 (6.9%) stddev-sans-first:4.49 08:11:33 INFO - PROCESS | 1651 | Values: 63.0 64.0 76.0 78.0 74.0 70.0 67.0 71.0 69.0 68.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:87.00 stddev:3.92 (4.5%) stddev-sans-first:4.13 08:11:33 INFO - PROCESS | 1651 | Values: 87.0 86.0 87.0 88.0 86.0 85.0 89.0 87.0 87.0 75.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:143.00 stddev:12.79 (8.9%) stddev-sans-first:13.41 08:11:33 INFO - PROCESS | 1651 | Values: 141.0 142.0 143.0 142.0 143.0 138.0 143.0 142.0 182.0 150.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:181.00 stddev:19.37 (10.7%) stddev-sans-first:20.24 08:11:33 INFO - PROCESS | 1651 | Values: 177.0 203.0 172.0 172.0 185.0 226.0 209.0 173.0 175.0 172.0 08:11:33 INFO - PROCESS | 1651 | 08:11:33 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:71.50 stddev:8.36 (11.7%) stddev-sans-first:8.83 08:11:33 INFO - PROCESS | 1651 | Values: 75.0 83.0 85.0 85.0 68.0 68.0 68.0 65.0 66.0 66.0 08:11:33 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:11:33 INFO - PROCESS | 1651 | 08:11:34 INFO - TEST-INFO | 1651: exit 0 08:11:34 INFO - TEST-OK | kraken | took 59877ms 08:11:34 INFO - SUITE-END | took 1178s 08:11:34 INFO - Completed test suite (00:19:38) 08:11:34 INFO - javascript benchmark 08:11:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.427685909099, 3368.949465758014, 3379.72962163027, 3390.7626466147367, 3401.0477066421404, 5611.382747897728, 5701.657900525966, 5707.0, 5712.143178523218, 5715.171300161474, 5672.801451949183, 5719.256496655439, 5790.855228619276, 5794.985877471436, 5837.620554663955, 5130.846074617767, 5135.12702840518, 5163.302954101205, 5209.453007434222, 5261.39493958194, 5279.894402111955, 5317.0, 5323.627346085776, 5326.0, 5334.5999050071205, 5119.513646203604, 5301.310829592167, 5313.787448502056, 5321.813736519222, 5339.866503337409, 5185.170372740344, 5194.246834209056, 5211.296474975868, 5223.059849227137, 5230.476952304777, 5194.532492075694, 5207.3490813648295, 5221.347331583552, 5237.423883372826, 5276.0, 5698.316202055738, 5728.22668939692, 5745.454181852718, 5767.538596912237, 5806.970965145148, 6134.803982731532, 6173.81478555644, 6190.84522886927, 6238.781642642532, 6295.905561416583, 6285.560010799246, 6288.496920246369, 6293.811185664437, 6302.55882088254, 6326.114343991799, 5837.678927658934, 5859.472647461706, 5902.911456328158, 5919.200907877382, 5942.168096466498, 6128.044828652092, 6173.753049878044, 6234.127222188898, 6268.122462855204, 6319.05214217871, 6120.6299886969155, 6162.630242185483, 6198.876022479525, 6199.0, 6206.162168107247, 6147.354527774609, 6206.503479721611, 6209.223847019122, 6219.751209951642, 6221.47117495018, 5201.245819356172, 6141.455323060903, 6152.384761523812, 6177.011678131477, 6185.536084793658, 6186.690665466709, 6218.347073557211, 6247.312795592481, 6403.455706264926, 6436.678166091677, 4935.432425271068, 4951.653384263067, 4955.90088198234, 5022.321986531844, 5038.64729468941, 4437.778111094497, 4467.352233926063, 4489.6408287336935, 4505.932411013838, 4510.120526497301, 5917.142014407887, 5968.820935371946, 5970.462658360769, 6009.909851352233, 6026.276846778414, 6216.906746398808, 6238.1266622672865, 6248.9062664060075, 6250.624962502265, 6253.74985000604, 5839.970800145972, 5933.851653708605, 5962.5826192167, 5976.103584462278, 6045.395460454008, 5425.104857698436, 5425.511703946585, 5443.591730620219, 5465.6447330923365, 5487.725613719298, 6337.841553961188, 6340.71466784005, 6344.619322840645, 6357.205349331426, 6369.363063693593, 6183.227096612924, 6228.22147231596, 6253.343398943228, 6259.998400255937, 6273.74905003813, 6171.59884607499, 6232.0, 6243.37566243372, 6262.5929314594405, 6324.335944725922, 6171.290301615192, 6219.0982307566055, 6246.281677606951, 6265.0, 6282.246130464374, 6107.328193898757, 6181.443670069715, 6249.9062514063235, 6272.435480806749, 6279.152314437675, 5524.861878453071, 6028.638281703112, 6152.046432802923, 6173.969130154321, 6220.72006759706, 6100.993336099494, 6103.731658266399, 6119.472088496418, 6145.047517634774, 6170.259568851767, 5849.181114644039, 6052.485538729257, 6052.606580572248, 6058.90911636317, 6092.0, 6046.818595442144, 6084.33072362031, 6099.3900609938655, 6128.9693551531955, 6150.815475535741, 6066.211392518944, 6079.574429789872, 6082.939170608237, 6087.756489740361, 6097.634141951497], "value": 5733.185431353724, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.2840961846618, 448.8922658561946, 526.4183077699141, 528.1786821492577, 534.6337758635335, 27482.312942176457, 34228.0, 35540.64459355409, 42487.575124248746, 44491.0, 42069.36895946556, 42558.0, 42668.57331426685, 42677.78661106698, 42772.57227427725, 8204.794880128014, 9218.585163667634, 9430.952845235764, 9431.386959847589, 9472.573734181979, 8397.664093436286, 8597.312215022783, 11148.498317575728, 11410.429478526083, 11429.371384573846, 11381.544738210461, 11392.974632283092, 11416.0, 11436.542538298458, 11460.828087578693, 8432.747017589481, 11318.660440186808, 11420.486078126463, 11423.828642570368, 11424.143189260756, 8414.074451810297, 9614.010185772895, 11043.779124417548, 11306.491207895664, 11520.251183673117, 34585.48121778175, 41310.967225819295, 41620.791896040326, 41628.75113746592, 41648.95877603054, 4047.251258517184, 4058.641362607711, 4075.1442197138635, 4077.1641813428473, 4213.325867861158, 29732.0, 30111.397772044656, 30367.848160759055, 30915.536266956013, 31156.376872462424, 3143.7327827134723, 3223.5164725291393, 3311.7350611950988, 3327.6505966873374, 3357.278185190196, 462880.0, 464545.0, 464842.9999999966, 464961.0, 466019.66990165174, 60510.69744651249, 60523.69738151369, 60540.39459605436, 60957.390426095175, 60960.0, 64013.0, 64335.356646432934, 64474.0, 64498.67750661311, 64627.921509811276, 15656.765148522782, 16171.838281617269, 16179.0, 16221.59446013859, 16222.026678399334, 10699.679009629723, 11318.717032074264, 12568.622941311774, 12576.308303043237, 12604.369781510888, 14099.224542650047, 14495.275236238145, 16023.679526409407, 16389.0, 16391.754123688155, 5325.4142044375085, 6131.417515336036, 6168.691565421711, 6178.69106544671, 6259.655718935411, 725.5465334166146, 848.6181218451721, 866.445474896067, 867.5965675960582, 913.5980168725739, 29772.553411698842, 30110.54834177489, 30256.84871575672, 30305.257825149678, 30606.54090188649, 939.7650587353162, 1046.1317106801337, 1062.675883855416, 1091.3779145886926, 1103.0844399148848, 14627.414903403745, 15057.397704091714, 15548.92225538865, 15713.907866435648, 16004.439844605384, 575603.0, 575849.0, 579299.0, 579724.0, 580580.0, 59230.0, 59568.70215648981, 59575.40424595698, 59968.10047849286, 60069.39930600725, 1424.1882127187612, 1451.3468938977503, 1465.0916431812345, 1472.506710252056, 1473.3075454536352, 29026.27434314159, 29183.0, 29235.561466578445, 29867.402651947275, 30321.393572127992, 49944.750276248385, 50384.24423633575, 50386.49613503818, 50386.992260155326, 50678.0, 419659.0, 421053.0, 422295.0, 422599.0, 422614.0, 38613.613863861, 39094.80452597719, 39499.60500395074, 39621.2075758489, 39743.40384894171, 45600.7719961398, 45606.08787824158, 46373.536264636925, 46851.0, 47124.76437617927, 38016.42975355427, 38366.0, 38630.0, 39401.01497462586, 39737.82097432256, 37350.0, 37865.24269514539, 38371.80814096023, 38955.2208955825, 39214.607853921094, 32097.679023210403, 37288.254234915694, 37849.4322585156, 38099.61900380961, 38244.61755382411, 31052.0, 33528.83235583904, 33740.49389259212, 33963.830180848934, 34091.0, 24206.878965605763, 24461.654608996676, 24812.131575394775, 24866.627000594643, 25260.0], "value": 19855.254735799692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.34921205225703, 367.98160091995396, 389.33229511387964, 400.7675548182054, 422.5098885293059, 15703.21483925805, 15756.527304180878, 19159.0, 21507.81707006118, 21527.461813454633, 17031.48905532836, 19945.800541994577, 20611.69082463764, 20995.790042099612, 21909.014094365753, 5276.12943864262, 5408.702521361323, 5455.918161227585, 5460.153676180198, 5972.462478376945, 3912.471816304791, 5966.79116230932, 6045.72794224261, 6049.334573196945, 6050.697465126748, 4100.138970816132, 5783.768649254025, 5998.1602575639445, 6051.425114614105, 6114.908276375858, 5447.237386765856, 5989.101634754778, 6072.848178795522, 6095.146679464834, 6095.512359011291, 5985.072313791369, 5988.161657367972, 5988.520918326523, 5990.400959903975, 5995.100734889757, 13449.529266475627, 23830.80845957695, 24358.63462048071, 24797.0, 26071.217863464128, 2591.157873691058, 2609.4781043791318, 2662.267876334004, 2695.7439043290856, 2698.5952107183884, 10095.798084038279, 10456.32033917793, 10683.946580267128, 12364.814527782091, 14676.779848302283, 1801.8018018018008, 1854.0173707934816, 1860.255897640941, 1873.5878106816479, 1897.5066482714456, 125450.0, 128836.0, 129375.70624293637, 134588.9811652816, 137217.0, 11263.493142808593, 11636.476358563885, 11739.941300293443, 11833.763324733458, 12036.699082522831, 15650.765238521431, 15654.217289135499, 15664.451744188898, 15671.608209794618, 15677.05937643745, 8215.876761848576, 8542.615582298811, 8545.2309292164, 8679.783005424788, 8693.261072808882, 8153.7553873383895, 8162.7143049992965, 8204.712835050745, 8351.707690230935, 8353.540555269397, 4007.8797636070963, 4665.906681866411, 4754.690945088558, 4789.95210047902, 4874.195757699939, 1741.7996930352917, 1960.3040920473027, 1971.7436733224588, 2013.6576781947103, 2023.3120738948828, 1006.6577363696379, 1011.2870426349554, 1016.3495362967707, 1027.2860362048455, 1037.9221558383151, 18563.72154417685, 21155.576888462143, 21387.0, 21435.8928205358, 21644.134234630754, 918.4489306416231, 974.4396971741277, 1038.7403149212696, 1045.1743122932799, 1062.4846949229618, 10598.0991615712, 10847.566097356175, 11118.55525778976, 11135.888641113484, 11218.66344009681, 598921.0, 689275.0, 694775.0, 699808.0, 707599.0, 140329.0, 141363.0, 146171.0, 146320.0, 148838.0, 1013.9391636501833, 1035.2856528994969, 1059.8092343378112, 1067.4929408530886, 1067.882532921378, 15538.533843984247, 16001.839981600035, 18910.52723681919, 19693.365582585815, 19701.0, 34047.0, 53504.0, 53930.73034634802, 56105.0, 56919.99999999834, 82502.17497824944, 82762.58618706868, 83605.90985225418, 84077.0, 85297.57351213452, 7531.924680753342, 7928.207179282025, 7961.0, 8057.153998830273, 8216.958915205385, 8622.65509379643, 11285.887141128484, 12160.817587736368, 12391.690207744517, 12613.49546018149, 9085.682001129928, 10466.842997355197, 10756.51595678212, 10860.230641186763, 11151.330920144817, 9682.612695492102, 10468.424236666751, 10508.159347252355, 10658.786824263627, 10730.839037414602, 10906.509207085859, 10964.026475234215, 11023.393713345842, 11054.00513953748, 11199.88800112021, 6939.791806245821, 7856.528608283293, 7994.5602991836, 8001.479903806234, 8031.59842007909, 8024.959875200587, 9707.369021013612, 10281.2803103785, 10889.891101089204, 10949.397783122005], "value": 9645.758953761886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.971180576388, 1465.1721777195883, 1480.111932840296, 1486.3980088064338, 1489.672272100138, 8112.229338212867, 8481.575921203937, 8483.745487635366, 8487.448315859465, 8491.95754021229, 7487.288707572786, 7715.807104822382, 8040.8391832163325, 8278.54468004261, 8299.668013279477, 2278.646809744492, 2322.3729593009875, 2327.1622216002224, 2327.2901764961766, 2330.533893221354, 2303.3320337102305, 2330.88345582721, 2332.918347857825, 2334.1363695432715, 2341.637046257833, 1799.7840259168918, 1880.56746948202, 1910.646530391882, 2100.6008858316945, 2105.0737675422843, 2290.9885450572724, 2312.387217387394, 2312.5721741477882, 2317.640765681322, 2318.7565305642834, 2210.6131427000373, 2229.4314949687728, 2317.0500094961153, 2320.582295186866, 2322.3149170994598, 8373.0, 8466.365022623328, 8477.66089356425, 8478.957605211996, 8484.490930544187, 4476.84331048415, 5013.47358527353, 5174.844754657366, 5175.042617115846, 5184.326037615124, 3197.5043868200464, 3342.866285348583, 3368.124287685195, 3404.608470025954, 3426.5202871597994, 1144.627995901327, 1195.9402029898558, 1202.9699257518544, 1237.1340061956575, 1240.3116270469886, 10725.195610329178, 10744.570217191382, 10882.29265097766, 10886.0, 10912.290701104403, 4422.358757980139, 4572.7942242599165, 4638.5593368629925, 4641.651876109306, 4652.906941861143, 9416.90583094174, 9445.622175112918, 9447.480388578695, 9449.291303152291, 9455.479948602893, 5140.948590514122, 5201.375834899761, 5234.18870075139, 5253.106971814801, 5260.736963151827, 4626.606738427204, 4684.320773487893, 4791.808327666854, 4799.520047995243, 4813.687110337817, 3272.8199949002556, 3743.1577894973957, 3789.317922773927, 3862.575116737157, 3872.477215575861, 1177.7173478365303, 1191.350713860948, 1269.9746005079846, 1270.6315168601186, 1281.4297637551388, 855.6021450025768, 870.6691457246205, 880.4849163239448, 905.9506286643223, 915.5056269614466, 5417.51242388187, 5426.186072089139, 5606.046972014768, 5632.239647647597, 5702.37273899879, 945.9858102128474, 982.2731178927685, 987.8962708915604, 1000.1698590170141, 1034.5396298647029, 3654.9634503655157, 3661.908452288661, 3733.141377483194, 3749.9250015000093, 3782.167923056923, 9805.80388392228, 10047.849282260771, 10056.949715251523, 10085.294029418017, 10104.04011618895, 9891.307608467338, 9987.600495980225, 10004.649837255662, 10006.54970526328, 10030.598776048877, 7656.61716914152, 7881.0, 7882.054153501502, 7896.0, 7899.328557072713, 5334.599905007218, 5451.046066938349, 5579.776808927598, 5657.60396772222, 5680.062789639664, 9207.769805754642, 9296.349255552046, 9335.0, 9347.813043739223, 9367.0, 7747.341475974606, 9222.538873056454, 9312.301577381588, 9408.858867117136, 9547.0, 6148.354422785543, 6909.067275917687, 7026.297370263137, 7031.1211098612675, 7087.858242835217, 7821.178776228641, 7825.726099586487, 7910.802229944067, 7918.722844700408, 7921.920780792118, 7012.333828286304, 7135.6432178391915, 7140.750073747394, 7175.390091842252, 7235.421166306577, 6981.930180698331, 7006.684699188447, 7025.192102908231, 7050.977608246673, 7063.82340441493, 6282.340354262737, 6333.683315834098, 6416.550841441054, 6429.453496452854, 6439.066335381437, 4854.466008738966, 4880.438749543706, 4927.507249275044, 4959.900801984012, 5034.194528875509, 4384.49578298487, 4422.49141348749, 4471.06107717383, 4490.550944905483, 4573.725576465423], "value": 4382.324971387239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.40366198729436, 358.60374286413514, 361.41992102675204, 370.7682698313554, 372.2016275089934, 4667.649926255527, 5053.5451809337155, 5149.0, 5172.586193104552, 5184.7297412133985, 4904.75476226189, 5120.411152717429, 5164.457731938149, 5176.767045482953, 5189.987952349294, 2924.605178300934, 3378.1385746634696, 3936.0872954013967, 3971.821268042945, 4013.7591744495426, 3357.529945807589, 3974.9602503975025, 3989.52125744911, 3990.481237439129, 4013.59184489307, 3708.2212735325616, 4005.299072662287, 4009.67922566194, 4017.919641607166, 4044.3933409988445, 3837.2517359114986, 3932.744371615836, 3964.8414063437426, 4035.435039094529, 4049.2104039712417, 2835.8723857426257, 3006.383691343269, 3162.478191098466, 3577.2487777566744, 3580.695640870529, 3881.146147847469, 4021.6929497913297, 4476.61948734358, 4702.3181638662545, 5012.298278241013, 3980.805758272507, 4271.825248056778, 4396.340548917656, 4630.536946305376, 4630.82788290019, 4773.665843390964, 4863.392075990501, 5161.458046905059, 5369.650972686802, 5445.428230035829, 3168.904932851995, 3292.983535082333, 3693.4275187346007, 3735.62643735627, 3745.138618117848, 4435.911281774379, 5062.392512898476, 5467.6719396836315, 5689.459501347365, 5707.343655479632, 2913.0823790505924, 3555.8577656893435, 3688.7026613994394, 3749.3813520769313, 3786.545614526219, 3389.5254664347012, 3802.6767724743154, 3822.4075268333454, 3830.7701537907815, 3836.271108489378, 4247.469066366704, 4407.060893206979, 4438.514431918136, 4456.442944631921, 4466.642668586505, 5059.367579052619, 5166.689998600096, 5471.68679516921, 5511.53151982078, 5571.916421253684, 1122.9438528073563, 1214.7791469573021, 1237.5977807212691, 1238.9530846434748, 1250.7561025600103, 758.7647829172863, 849.4223927729204, 856.7943693513637, 869.699953516036, 871.5337294547387, 4206.592659945454, 4285.764282964405, 4706.435227772689, 4818.903621927542, 4860.586850117779, 5354.223637572531, 5355.86610334737, 5356.4107948125675, 5391.406945236021, 5410.594205434608, 3735.685283497565, 4051.7974101294817, 4084.4880398554674, 4390.468010306972, 4640.767961601974, 2517.446161844391, 2563.7822034533447, 2761.0888406825698, 2764.682061562906, 2838.587200879236, 5049.343585333883, 5579.302587176603, 5585.972070139624, 5589.552835773128, 5644.403574355761, 4963.45402005779, 5146.8970620588125, 5526.889462210734, 5577.498025177672, 5607.607467477319, 5020.824271150492, 5166.483351664879, 5544.390117087117, 5565.610407271533, 5615.719214039282, 4705.529447055267, 5400.378956419905, 5408.296921400193, 5433.375161856437, 5433.429489903661, 4805.0, 4892.461829198714, 5083.745812709423, 5122.385313762373, 5423.62034657586, 4994.500549944976, 5367.537938030026, 5543.002259593312, 5695.743691533974, 5703.08750599902, 3688.6577023589675, 3709.3323201823932, 3714.721395895265, 3726.16161363691, 3986.4219688144476, 4675.953240467552, 5399.973000135132, 5621.381648018796, 5678.630888992202, 5683.630564013326, 4641.535846415331, 5032.899342013213, 5258.1849813279005, 5373.543248823894, 5490.858565159511, 4561.654311978041, 4840.443349014909, 5480.931218412371, 5492.972535137299, 5493.697846618475, 5301.920471193012, 5305.389880163831, 5342.572594192533, 5374.489423504917, 5402.459754024566, 4683.9226977794615, 5266.183741520071, 5327.200919862052, 5408.945910540844, 5493.670379777226, 4109.671226301829, 5377.516023557899, 5397.789724015274, 5414.536385944307, 5463.295668644047], "value": 3901.8491651957834, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.8255618651522, 760.6234913717703, 779.6101949025488, 800.8278220182661, 819.4796304346738, 14716.04345717529, 15578.0, 15604.375824966988, 15618.76571851423, 15625.3749850006, 14284.92857535711, 14434.639134021629, 14471.276436178201, 14480.493182738606, 14486.2756862157, 680.7413182990457, 697.2400083908539, 697.3688811625487, 849.6304107713133, 865.6234537975969, 672.6771149848075, 866.0040952904179, 866.8916385451819, 867.4491697771929, 870.1907226279558, 927.7402327348353, 927.935044546882, 928.4661319741142, 929.4330458420358, 930.2186163622556, 713.0195980526776, 728.2499026003226, 849.8512760266929, 921.3734660430904, 922.4142669404943, 689.7654797368868, 692.9237783843773, 694.9200841903145, 695.9443244540424, 696.6516741629185, 15034.398624055024, 15321.770173447407, 15335.463258786, 15367.538973830802, 15385.692286154213, 12942.417591208417, 13096.86903130966, 13166.670833229151, 13857.168569885838, 14022.579322620337, 12827.294498802563, 13125.474981000749, 13134.737305253937, 13295.135816171918, 13755.656108597264, 4224.38746381776, 4250.957490425087, 4486.282194848841, 4561.977190114028, 4726.1020406122725, 103400.48299758528, 103456.0, 105924.0, 105925.0, 106797.46601266944, 10979.231453798317, 11000.22998390105, 11087.55649774, 11096.944515277371, 11172.273802202993, 21197.682034769492, 21200.93995300229, 21234.256801012198, 21235.68146477804, 21242.36272911815, 7677.961610192025, 7686.192949740309, 7745.496542724817, 7888.526688398714, 7916.683332666629, 4279.657627389802, 4309.569043095666, 4313.439252897103, 4315.201687687788, 4348.326009468537, 3407.4207384744655, 3478.252175782219, 3493.7205023598053, 3496.947545786815, 3497.5802903651725, 656.471540409965, 660.51782198995, 661.3915198017835, 675.2268652392983, 675.3617831149517, 637.6174295422802, 640.810960766575, 660.5145218264572, 664.1896885799317, 680.5406350713249, 9350.205232555309, 9565.808683826284, 9679.806403871884, 9826.164775993977, 9959.502024898726, 545.969971651563, 563.5069314349944, 583.2592607388593, 585.7042193692243, 610.8625559249133, 4656.883577910579, 4991.925121123186, 5027.648064635514, 5115.974420127875, 5118.232265160182, 85177.0, 89795.20409591771, 94553.0, 97214.0, 99639.0, 77971.22028779754, 78012.0, 79772.0, 81410.5929470349, 81650.59174704207, 75552.48895022178, 76307.0, 76953.0, 77482.61258693783, 78822.0, 9808.754781130528, 9825.55784989663, 9829.606815727291, 9846.113849753556, 9849.359791613522, 42202.577974219865, 45914.081718364774, 48256.0, 49290.75354623204, 50053.74973125111, 58262.70868645799, 63315.417114572505, 64657.0, 66320.0, 66591.66704166448, 13406.128601641252, 13481.393337300042, 13874.445022199403, 13897.930510347383, 13903.304834758019, 14598.343074561457, 15285.847141528442, 15327.157006364758, 15541.611459713598, 15949.840501594836, 13463.798043029166, 13960.441582336593, 14082.366293516612, 14118.929405352908, 14561.980661353604, 13589.388477518338, 13768.105073170213, 14111.788323175366, 14504.34730437154, 14701.0, 13706.862931370559, 13726.588202353945, 13945.02384833052, 13962.0, 14314.141151530941, 10769.676909692722, 11175.161862860155, 11233.32600044, 11391.145664075393, 11903.047756179312, 10111.476062506104, 10798.244122911636, 11115.055220306365, 11461.140414469115, 11658.358790266617], "value": 7491.057108601239, "unit": "score"}], "name": "dromaeo_css", "value": 7211.56104523775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0, 114.0, 111.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 110.0, 150.0, 142.0, 121.0, 109.0, 110.0, 148.0, 141.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 182.0, 185.0, 205.0, 258.0, 181.0, 183.0, 181.0, 185.0], "value": 192.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 87.0, 61.0, 58.0, 72.0, 83.0, 96.0, 76.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 85.0, 68.0, 74.0, 99.0, 83.0, 67.0, 69.0, 83.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 86.0, 83.0, 85.0, 86.0, 87.0, 84.0, 86.0, 87.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 85.0, 84.0, 87.0, 87.0, 87.0, 85.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 54.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 76.0, 78.0, 74.0, 70.0, 67.0, 71.0, 69.0, 68.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 88.0, 86.0, 85.0, 89.0, 87.0, 87.0, 75.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 143.0, 142.0, 143.0, 138.0, 143.0, 142.0, 182.0, 150.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 203.0, 172.0, 172.0, 185.0, 226.0, 209.0, 173.0, 175.0, 172.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 85.0, 85.0, 68.0, 68.0, 68.0, 65.0, 66.0, 66.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1468.8000000000002, "alertThreshold": 2.0}]} 08:11:34 INFO - Return code: 0 08:11:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:11:34 ERROR - # TBPL SUCCESS # 08:11:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:34 INFO - 2017-01-20 08:11:34.654 screenresolution[1655:9806] starting screenresolution argv=screenresolution get 08:11:34 INFO - 2017-01-20 08:11:34.657 screenresolution[1655:9806] Display 0: 1600x1200x32@60 08:11:34 INFO - 2017-01-20 08:11:34.663 screenresolution[1656:9809] starting screenresolution argv=screenresolution list 08:11:34 INFO - Available Modes on Display 0 08:11:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:34 INFO - Intel Iris: 08:11:34 INFO - Chipset Model: Intel Iris 08:11:34 INFO - Type: GPU 08:11:34 INFO - Bus: Built-In 08:11:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:11:34 INFO - Vendor: Intel (0x8086) 08:11:34 INFO - Device ID: 0x0a2e 08:11:34 INFO - Revision ID: 0x0009 08:11:34 INFO - Displays: 08:11:34 INFO - Display: 08:11:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:34 INFO - Display Serial Number: 1600x1200 60 08:11:34 INFO - Main Display: Yes 08:11:34 INFO - Mirror: Off 08:11:34 INFO - Online: Yes 08:11:34 INFO - Rotation: Supported 08:11:34 INFO - Return code: 0 08:11:34 INFO - Running post-action listener: _resource_record_post_action 08:11:34 INFO - [mozharness: 2017-01-20 16:11:34.907419Z] Finished run-tests step (success) 08:11:34 INFO - Running post-run listener: _resource_record_post_run 08:11:34 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37872640; Write bytes: 553738240; Read time: 242; Write time: 1655 08:11:34 INFO - TinderboxPrint: CPU usage
53.8% 08:11:34 INFO - TinderboxPrint: I/O read bytes / time
37,872,640 / 242 08:11:34 INFO - TinderboxPrint: I/O write bytes / time
553,738,240 / 1,655 08:11:34 INFO - TinderboxPrint: CPU idle
2,221.4 (46.2%) 08:11:34 INFO - TinderboxPrint: CPU system
958.8 (20.0%) 08:11:34 INFO - TinderboxPrint: CPU user
1,625.5 (33.8%) 08:11:34 INFO - TinderboxPrint: Swap in / out
288,587,776 / 0 08:11:34 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 249215488; Write bytes: 244127744; Read time: 18088; Write time: 497 08:11:34 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34427904; Write bytes: 298018816; Read time: 217; Write time: 1122 08:11:35 INFO - Running post-run listener: _upload_blobber_files 08:11:35 INFO - Blob upload gear active. 08:11:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:11:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:11:35 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:11:35 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:11:35 INFO - (blobuploader) - INFO - Open directory for files ... 08:11:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:11:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:11:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:36 INFO - (blobuploader) - INFO - Done attempting. 08:11:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:11:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:11:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:38 INFO - (blobuploader) - INFO - Done attempting. 08:11:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:11:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:11:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:39 INFO - (blobuploader) - INFO - Done attempting. 08:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:41 INFO - (blobuploader) - INFO - Done attempting. 08:11:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:11:41 INFO - Return code: 0 08:11:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:11:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:11:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f4d738160da9a96809c494a7d82b823163b28a2891410ca92abda90d3297230b3d60ce46eb19a814ddf3bf96fd123e590202796df5278692771c446f1e5f9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f597e44f6f39847422d3234fea07fcc62f21988f5ad115b41cb168f522d597de0e9afbaa6b9141b4e1b90639d27acaa44650447c2b0e7b2d9c8adc839bebad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3adbe77b5329f40579f7c8d50b63abff92ce02418987603273716016ddef638bef75b25488c533c8a1c6427ce3c6d0a20a605d8ca0cddb339320a07f1ff8f9b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f54815d2cd05faa7fdda92e384940250122ad739ec664c7512dc01cbaad71c61de3d17a6279d431c08dfe59f7a2d65e434e321505735926c0502449916e3ee"} 08:11:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:11:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:11:41 INFO - Contents: 08:11:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f4d738160da9a96809c494a7d82b823163b28a2891410ca92abda90d3297230b3d60ce46eb19a814ddf3bf96fd123e590202796df5278692771c446f1e5f9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f597e44f6f39847422d3234fea07fcc62f21988f5ad115b41cb168f522d597de0e9afbaa6b9141b4e1b90639d27acaa44650447c2b0e7b2d9c8adc839bebad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3adbe77b5329f40579f7c8d50b63abff92ce02418987603273716016ddef638bef75b25488c533c8a1c6427ce3c6d0a20a605d8ca0cddb339320a07f1ff8f9b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f54815d2cd05faa7fdda92e384940250122ad739ec664c7512dc01cbaad71c61de3d17a6279d431c08dfe59f7a2d65e434e321505735926c0502449916e3ee"} 08:11:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:11:41 INFO - Copying logs to upload dir... 08:11:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:11:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.224447 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-20 08:11:41.518376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 08:11:41.522101) ========= 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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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/Firefox/sha512/7f4d738160da9a96809c494a7d82b823163b28a2891410ca92abda90d3297230b3d60ce46eb19a814ddf3bf96fd123e590202796df5278692771c446f1e5f9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f597e44f6f39847422d3234fea07fcc62f21988f5ad115b41cb168f522d597de0e9afbaa6b9141b4e1b90639d27acaa44650447c2b0e7b2d9c8adc839bebad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3adbe77b5329f40579f7c8d50b63abff92ce02418987603273716016ddef638bef75b25488c533c8a1c6427ce3c6d0a20a605d8ca0cddb339320a07f1ff8f9b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f54815d2cd05faa7fdda92e384940250122ad739ec664c7512dc01cbaad71c61de3d17a6279d431c08dfe59f7a2d65e434e321505735926c0502449916e3ee"} build_url:https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010944 build_url: 'https://queue.taskcluster.net/v1/task/ftJkggv8RnCrj-2_Ek8Z4A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f4d738160da9a96809c494a7d82b823163b28a2891410ca92abda90d3297230b3d60ce46eb19a814ddf3bf96fd123e590202796df5278692771c446f1e5f9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f597e44f6f39847422d3234fea07fcc62f21988f5ad115b41cb168f522d597de0e9afbaa6b9141b4e1b90639d27acaa44650447c2b0e7b2d9c8adc839bebad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3adbe77b5329f40579f7c8d50b63abff92ce02418987603273716016ddef638bef75b25488c533c8a1c6427ce3c6d0a20a605d8ca0cddb339320a07f1ff8f9b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f54815d2cd05faa7fdda92e384940250122ad739ec664c7512dc01cbaad71c61de3d17a6279d431c08dfe59f7a2d65e434e321505735926c0502449916e3ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 08:11:41.556698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 08:11:41.557154) ========= 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.Pe25ohoS3k/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.BnKsOlj1Vr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.005079 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 08:11:41.608810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 08:11:41.609393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 08:11:41.610046) ========= ========= Total master_lag: 3.93 =========