builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0363 starttime: 1484151749.9 results: success (0) buildid: 20170111064105 builduid: 436d7f61a8e34b309d7a3e14525f209e revision: d9206eb08d6bb601658d8af93cbe9eacb98e18ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:29.901387) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:29.901833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:29.902127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:29.928450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:29.928782) ========= 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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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-11 08:22:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2017-01-11 08:22:30 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:30.076152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:30.076534) ========= 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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.025486 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:30.125555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-11 08:22:30.125928) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9206eb08d6bb601658d8af93cbe9eacb98e18ca --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 d9206eb08d6bb601658d8af93cbe9eacb98e18ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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-11 08:22:30,226 truncating revision to first 12 chars 2017-01-11 08:22:30,226 Setting DEBUG logging. 2017-01-11 08:22:30,226 attempt 1/10 2017-01-11 08:22:30,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9206eb08d6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 08:22:31,201 unpacking tar archive at: mozilla-central-d9206eb08d6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248579 ========= master_lag: 2.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-11 08:22:33.574079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:33.574485) ========= script_repo_revision: d9206eb08d6bb601658d8af93cbe9eacb98e18ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:33.574915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:33.575180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 08:22:34.230481) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-11 08:22:34.230848) ========= /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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:22:34 INFO - MultiFileLogger online at 20170111 08:22:34 in /builds/slave/test 08:22:34 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 08:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:34 INFO - {'append_to_log': False, 08:22:34 INFO - 'base_work_dir': '/builds/slave/test', 08:22:34 INFO - 'blob_upload_branch': 'Firefox', 08:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:34 INFO - 'branch': 'Firefox', 08:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:34 INFO - 'config_files': ('talos/mac_config.py',), 08:22:34 INFO - 'default_actions': ('clobber', 08:22:34 INFO - 'read-buildbot-config', 08:22:34 INFO - 'download-and-extract', 08:22:34 INFO - 'populate-webroot', 08:22:34 INFO - 'create-virtualenv', 08:22:34 INFO - 'install', 08:22:34 INFO - 'run-tests'), 08:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:34 INFO - 'download_minidump_stackwalk': True, 08:22:34 INFO - 'download_symbols': 'ondemand', 08:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:34 INFO - 'installer_path': 'installer.exe', 08:22:34 INFO - 'log_level': 'info', 08:22:34 INFO - 'log_name': 'talos', 08:22:34 INFO - 'log_to_console': True, 08:22:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:22:34 INFO - 'opt_config_files': (), 08:22:34 INFO - 'pip_index': False, 08:22:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:22:34 INFO - 'cmd': ('bash', 08:22:34 INFO - '-c', 08:22:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:22:34 INFO - 'enabled': True, 08:22:34 INFO - 'halt_on_failure': False, 08:22:34 INFO - 'name': 'check_screen_resolution'},), 08:22:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:22:34 INFO - 'cmd': ('bash', 08:22:34 INFO - '-c', 08:22:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:22:34 INFO - 'enabled': True, 08:22:34 INFO - 'halt_on_failure': False, 08:22:34 INFO - 'name': 'check_screen_resolution'},), 08:22:34 INFO - 'run_cmd_checks_enabled': True, 08:22:34 INFO - 'sps_profile': False, 08:22:34 INFO - 'sps_profile_interval': 0, 08:22:34 INFO - 'suite': 'dromaeojs', 08:22:34 INFO - 'system_bits': '32', 08:22:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:34 INFO - 'title': 't-yosemite-r7-0363', 08:22:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:34 INFO - 'use_talos_json': True, 08:22:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:34 INFO - 'work_dir': 'build'} 08:22:34 INFO - [mozharness: 2017-01-11 16:22:34.438140Z] Running clobber step. 08:22:34 INFO - Running pre-action listener: _resource_record_pre_action 08:22:34 INFO - Running main action method: clobber 08:22:34 INFO - rmtree: /builds/slave/test/build 08:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:36 INFO - Running post-action listener: _resource_record_post_action 08:22:36 INFO - [mozharness: 2017-01-11 16:22:36.731896Z] Finished clobber step (success) 08:22:36 INFO - [mozharness: 2017-01-11 16:22:36.732020Z] Running read-buildbot-config step. 08:22:36 INFO - Running pre-action listener: _resource_record_pre_action 08:22:36 INFO - Running main action method: read_buildbot_config 08:22:36 INFO - Using buildbot properties: 08:22:36 INFO - { 08:22:36 INFO - "project": "", 08:22:36 INFO - "product": "firefox", 08:22:36 INFO - "script_repo_revision": "production", 08:22:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:22:36 INFO - "repository": "", 08:22:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:22:36 INFO - "buildid": "20170111064105", 08:22:36 INFO - "pgo_build": "False", 08:22:36 INFO - "basedir": "/builds/slave/test", 08:22:36 INFO - "buildnumber": 12, 08:22:36 INFO - "slavename": "t-yosemite-r7-0363", 08:22:36 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:22:36 INFO - "platform": "yosemite_r7", 08:22:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:22:36 INFO - "branch": "mozilla-central", 08:22:36 INFO - "repo_path": "mozilla-central", 08:22:36 INFO - "revision": "d9206eb08d6bb601658d8af93cbe9eacb98e18ca", 08:22:36 INFO - "stage_platform": "macosx64", 08:22:36 INFO - "builduid": "436d7f61a8e34b309d7a3e14525f209e", 08:22:36 INFO - "slavebuilddir": "test" 08:22:36 INFO - } 08:22:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:22:36 INFO - Running post-action listener: _resource_record_post_action 08:22:36 INFO - [mozharness: 2017-01-11 16:22:36.735631Z] Finished read-buildbot-config step (success) 08:22:36 INFO - [mozharness: 2017-01-11 16:22:36.735773Z] Running download-and-extract step. 08:22:36 INFO - Running pre-action listener: _resource_record_pre_action 08:22:36 INFO - Running main action method: download_and_extract 08:22:36 INFO - mkdir: /builds/slave/test/build/tests 08:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:36 INFO - trying https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/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 08:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/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 08:22:37 INFO - Downloaded 1199 bytes. 08:22:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:22:37 INFO - Using the following test package requirements: 08:22:37 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:22:37 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:22:37 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:22:37 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'jsshell-mac.zip'], 08:22:37 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:22:37 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:22:37 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:22:37 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:22:37 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:22:37 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:22:37 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:22:37 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:22:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:22:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:22:37 INFO - Fetch https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:22:38 INFO - Expected file size: 16311438 08:22:38 INFO - Obtained file size: 16311438 08:22:45 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 08:22:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:22:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:22:45 INFO - Fetch https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:22:46 INFO - Expected file size: 16311438 08:22:46 INFO - Obtained file size: 16311438 08:22:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:22:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:22:52 INFO - Fetch https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:22:53 INFO - Expected file size: 14403529 08:22:53 INFO - Obtained file size: 14403529 08:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:54 INFO - trying https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/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 08:22:56 INFO - Downloaded 69838582 bytes. 08:22:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:22:56 INFO - mkdir: /builds/slave/test/properties 08:22:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:22:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:22:56 INFO - Contents: 08:22:56 INFO - build_url:https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:22:56 INFO - Running post-action listener: _resource_record_post_action 08:22:56 INFO - Running post-action listener: set_extra_try_arguments 08:22:56 INFO - [mozharness: 2017-01-11 16:22:56.781429Z] Finished download-and-extract step (success) 08:22:56 INFO - [mozharness: 2017-01-11 16:22:56.781559Z] Running populate-webroot step. 08:22:56 INFO - Running pre-action listener: _resource_record_pre_action 08:22:56 INFO - Running main action method: populate_webroot 08:22:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:22:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:22:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:22:56 INFO - '--tppagecycles', 08:22:56 INFO - '7'], 08:22:56 INFO - 'tests': ['tsvgm']}}, 08:22:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:22:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:22:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:22:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:22:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:22:56 INFO - 'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:22:56 INFO - 'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['damp', 'tps']}, 08:22:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:22:56 INFO - 'tests': ['damp', 'tps']}, 08:22:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['dromaeo_dom']}, 08:22:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:22:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['basic_compositor_video']}, 08:22:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:22:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['a11yr', 08:22:56 INFO - 'ts_paint', 08:22:56 INFO - 'tpaint', 08:22:56 INFO - 'sessionrestore', 08:22:56 INFO - 'sessionrestore_no_auto_restore', 08:22:56 INFO - 'tabpaint']}, 08:22:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:22:56 INFO - 'ts_paint', 08:22:56 INFO - 'tpaint', 08:22:56 INFO - 'sessionrestore', 08:22:56 INFO - 'sessionrestore_no_auto_restore', 08:22:56 INFO - 'tabpaint']}, 08:22:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:22:56 INFO - 'ts_paint', 08:22:56 INFO - 'tpaint', 08:22:56 INFO - 'sessionrestore', 08:22:56 INFO - 'sessionrestore_no_auto_restore', 08:22:56 INFO - 'tabpaint']}, 08:22:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:22:56 INFO - 'ts_paint', 08:22:56 INFO - 'tpaint', 08:22:56 INFO - 'sessionrestore', 08:22:56 INFO - 'sessionrestore_no_auto_restore', 08:22:56 INFO - 'tabpaint']}, 08:22:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['a11yr', 08:22:56 INFO - 'ts_paint', 08:22:56 INFO - 'tpaint', 08:22:56 INFO - 'sessionrestore', 08:22:56 INFO - 'sessionrestore_no_auto_restore', 08:22:56 INFO - 'tabpaint']}, 08:22:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['a11yr', 08:22:56 INFO - 'ts_paint', 08:22:56 INFO - 'tpaint', 08:22:56 INFO - 'sessionrestore', 08:22:56 INFO - 'sessionrestore_no_auto_restore', 08:22:56 INFO - 'tabpaint']}, 08:22:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['tsvgx', 08:22:56 INFO - 'tsvgr_opacity', 08:22:56 INFO - 'tart', 08:22:56 INFO - 'tscrollx', 08:22:56 INFO - 'cart', 08:22:56 INFO - 'tsvg_static']}, 08:22:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:22:56 INFO - 'tsvgr_opacity', 08:22:56 INFO - 'tart', 08:22:56 INFO - 'tscrollx', 08:22:56 INFO - 'cart', 08:22:56 INFO - 'tsvg_static']}, 08:22:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:22:56 INFO - 'talos_options': ['--disable-e10s'], 08:22:56 INFO - 'tests': ['tp5o']}, 08:22:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:22:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:22:56 INFO - 'talos_options': ['--disable-e10s', 08:22:56 INFO - '--xperf_path', 08:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:56 INFO - 'tests': ['tp5n']}, 08:22:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:22:56 INFO - 'talos_options': ['--xperf_path', 08:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:56 INFO - 'tests': ['tp5n']}}, 08:22:56 INFO - 'talos.zip': {'path': '', 08:22:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:22:56 INFO - Running post-action listener: _resource_record_post_action 08:22:56 INFO - [mozharness: 2017-01-11 16:22:56.800466Z] Finished populate-webroot step (success) 08:22:56 INFO - [mozharness: 2017-01-11 16:22:56.800577Z] Running create-virtualenv step. 08:22:56 INFO - Running pre-action listener: _resource_record_pre_action 08:22:56 INFO - Running main action method: create_virtualenv 08:22:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:22:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:22:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:22:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:22:56 INFO - Using real prefix '/tools/python27' 08:22:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:22:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:00 INFO - Installing pip.................done. 08:23:00 INFO - Return code: 0 08:23:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:23:00 INFO - Reading from file tmpfile_stdout 08:23:00 INFO - Output received: 08:23:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:23:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:00 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 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:00 INFO - 'HOME': '/Users/cltbld', 08:23:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:00 INFO - 'LOGNAME': 'cltbld', 08:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:00 INFO - 'MOZ_NO_REMOTE': '1', 08:23:00 INFO - 'NO_EM_RESTART': '1', 08:23:00 INFO - 'PAGER': '/bin/cat', 08:23:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:00 INFO - 'PWD': '/builds/slave/test', 08:23:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:00 INFO - 'SHELL': '/bin/bash', 08:23:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:00 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:00 INFO - 'USER': 'cltbld', 08:23:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:00 INFO - 'XPC_FLAGS': '0x0', 08:23:00 INFO - 'XPC_SERVICE_NAME': '0', 08:23:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:23:01 INFO - Cleaning up... 08:23:01 INFO - Return code: 0 08:23:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:23:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:01 INFO - 'HOME': '/Users/cltbld', 08:23:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:01 INFO - 'LOGNAME': 'cltbld', 08:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:01 INFO - 'MOZ_NO_REMOTE': '1', 08:23:01 INFO - 'NO_EM_RESTART': '1', 08:23:01 INFO - 'PAGER': '/bin/cat', 08:23:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:01 INFO - 'PWD': '/builds/slave/test', 08:23:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:01 INFO - 'SHELL': '/bin/bash', 08:23:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:01 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:01 INFO - 'USER': 'cltbld', 08:23:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:01 INFO - 'XPC_FLAGS': '0x0', 08:23:01 INFO - 'XPC_SERVICE_NAME': '0', 08:23:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:01 INFO - Downloading/unpacking psutil>=3.1.1 08:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:04 INFO - Installing collected packages: psutil 08:23:04 INFO - Running setup.py install for psutil 08:23:05 INFO - building 'psutil._psutil_osx' extension 08:23:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:23:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:23:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:23:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:23:05 INFO - building 'psutil._psutil_posix' extension 08:23:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:23:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:23:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:23:05 INFO - ^ 08:23:05 INFO - 1 warning generated. 08:23:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:23:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:06 INFO - Successfully installed psutil 08:23:06 INFO - Cleaning up... 08:23:06 INFO - Return code: 0 08:23:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:06 INFO - 'HOME': '/Users/cltbld', 08:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:06 INFO - 'LOGNAME': 'cltbld', 08:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:06 INFO - 'MOZ_NO_REMOTE': '1', 08:23:06 INFO - 'NO_EM_RESTART': '1', 08:23:06 INFO - 'PAGER': '/bin/cat', 08:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:06 INFO - 'PWD': '/builds/slave/test', 08:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:06 INFO - 'SHELL': '/bin/bash', 08:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:06 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:06 INFO - 'USER': 'cltbld', 08:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:06 INFO - 'XPC_FLAGS': '0x0', 08:23:06 INFO - 'XPC_SERVICE_NAME': '0', 08:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:09 INFO - Installing collected packages: mozsystemmonitor 08:23:09 INFO - Running setup.py install for mozsystemmonitor 08:23:09 INFO - Successfully installed mozsystemmonitor 08:23:09 INFO - Cleaning up... 08:23:09 INFO - Return code: 0 08:23:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:23:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:09 INFO - 'HOME': '/Users/cltbld', 08:23:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:09 INFO - 'LOGNAME': 'cltbld', 08:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:09 INFO - 'MOZ_NO_REMOTE': '1', 08:23:09 INFO - 'NO_EM_RESTART': '1', 08:23:09 INFO - 'PAGER': '/bin/cat', 08:23:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:09 INFO - 'PWD': '/builds/slave/test', 08:23:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:09 INFO - 'SHELL': '/bin/bash', 08:23:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:09 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:09 INFO - 'USER': 'cltbld', 08:23:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:09 INFO - 'XPC_FLAGS': '0x0', 08:23:09 INFO - 'XPC_SERVICE_NAME': '0', 08:23:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:09 INFO - Downloading/unpacking jsonschema==2.5.1 08:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:12 INFO - warning: no files found matching '*.txt' 08:23:12 INFO - no previously-included directories found matching 'build' 08:23:12 INFO - no previously-included directories found matching 'dist' 08:23:12 INFO - no previously-included directories found matching '.git*' 08:23:12 INFO - Installing collected packages: jsonschema, functools32 08:23:12 INFO - Running setup.py install for functools32 08:23:13 INFO - warning: no files found matching '*.txt' 08:23:13 INFO - no previously-included directories found matching 'build' 08:23:13 INFO - no previously-included directories found matching 'dist' 08:23:13 INFO - no previously-included directories found matching '.git*' 08:23:13 INFO - Successfully installed jsonschema functools32 08:23:13 INFO - Cleaning up... 08:23:13 INFO - Return code: 0 08:23:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:13 INFO - 'HOME': '/Users/cltbld', 08:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:13 INFO - 'LOGNAME': 'cltbld', 08:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:13 INFO - 'MOZ_NO_REMOTE': '1', 08:23:13 INFO - 'NO_EM_RESTART': '1', 08:23:13 INFO - 'PAGER': '/bin/cat', 08:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:13 INFO - 'PWD': '/builds/slave/test', 08:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:13 INFO - 'SHELL': '/bin/bash', 08:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:13 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:13 INFO - 'USER': 'cltbld', 08:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:13 INFO - 'XPC_FLAGS': '0x0', 08:23:13 INFO - 'XPC_SERVICE_NAME': '0', 08:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:23:13 INFO - Cleaning up... 08:23:13 INFO - Return code: 0 08:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:13 INFO - 'HOME': '/Users/cltbld', 08:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:13 INFO - 'LOGNAME': 'cltbld', 08:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:13 INFO - 'MOZ_NO_REMOTE': '1', 08:23:13 INFO - 'NO_EM_RESTART': '1', 08:23:13 INFO - 'PAGER': '/bin/cat', 08:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:13 INFO - 'PWD': '/builds/slave/test', 08:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:13 INFO - 'SHELL': '/bin/bash', 08:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:13 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:13 INFO - 'USER': 'cltbld', 08:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:13 INFO - 'XPC_FLAGS': '0x0', 08:23:13 INFO - 'XPC_SERVICE_NAME': '0', 08:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:17 INFO - Downloading docopt-0.6.1.tar.gz 08:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:17 INFO - Running setup.py install for blobuploader 08:23:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:17 INFO - Running setup.py install for requests 08:23:18 INFO - Running setup.py install for docopt 08:23:18 INFO - Successfully installed blobuploader requests docopt 08:23:18 INFO - Cleaning up... 08:23:18 INFO - Return code: 0 08:23:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:18 INFO - 'HOME': '/Users/cltbld', 08:23:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:18 INFO - 'LOGNAME': 'cltbld', 08:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:18 INFO - 'MOZ_NO_REMOTE': '1', 08:23:18 INFO - 'NO_EM_RESTART': '1', 08:23:18 INFO - 'PAGER': '/bin/cat', 08:23:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:18 INFO - 'PWD': '/builds/slave/test', 08:23:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:18 INFO - 'SHELL': '/bin/bash', 08:23:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:18 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:18 INFO - 'USER': 'cltbld', 08:23:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:18 INFO - 'XPC_FLAGS': '0x0', 08:23:18 INFO - 'XPC_SERVICE_NAME': '0', 08:23:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:18 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-cI7VBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:18 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-MPkgg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-k6eSql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-jRShsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Nvm2G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-TXnKKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-eyvSei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-8jibc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-rlifeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-e0Gkb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ekypGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:19 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-9OwQrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:20 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-4vyPS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:20 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-V4QYlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:20 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-CYSwIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:20 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ymVhrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:20 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-fFzENh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:20 INFO - Running setup.py install for manifestparser 08:23:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:20 INFO - Running setup.py install for mozcrash 08:23:20 INFO - Running setup.py install for mozdebug 08:23:21 INFO - Running setup.py install for mozdevice 08:23:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozfile 08:23:21 INFO - Running setup.py install for mozhttpd 08:23:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozinfo 08:23:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozInstall 08:23:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozleak 08:23:21 INFO - Running setup.py install for mozlog 08:23:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for moznetwork 08:23:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozprocess 08:23:22 INFO - Running setup.py install for mozprofile 08:23:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozrunner 08:23:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozscreenshot 08:23:22 INFO - Running setup.py install for moztest 08:23:23 INFO - Running setup.py install for mozversion 08:23:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:23 INFO - Cleaning up... 08:23:23 INFO - Return code: 0 08:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 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 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:23 INFO - 'HOME': '/Users/cltbld', 08:23:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:23 INFO - 'LOGNAME': 'cltbld', 08:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:23 INFO - 'MOZ_NO_REMOTE': '1', 08:23:23 INFO - 'NO_EM_RESTART': '1', 08:23:23 INFO - 'PAGER': '/bin/cat', 08:23:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:23 INFO - 'PWD': '/builds/slave/test', 08:23:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:23 INFO - 'SHELL': '/bin/bash', 08:23:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:23 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:23 INFO - 'USER': 'cltbld', 08:23:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:23 INFO - 'XPC_FLAGS': '0x0', 08:23:23 INFO - 'XPC_SERVICE_NAME': '0', 08:23:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Bc8hKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-8KUwP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-lm8DEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-8M5HJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-LFZuoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-kP23Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Nu7brJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-MalPYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-KUKS0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-zCOdSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-tRLj7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-AdPMHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-8i5cNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-7avvSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-n9LRxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-K0calW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:25 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)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-9zyzYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:25 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)) 08:23:25 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)) 08:23:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:28 INFO - Downloading blessings-1.6.tar.gz 08:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:28 INFO - Installing collected packages: blessings 08:23:28 INFO - Running setup.py install for blessings 08:23:29 INFO - Successfully installed blessings 08:23:29 INFO - Cleaning up... 08:23:29 INFO - Return code: 0 08:23:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:29 INFO - Reading from file tmpfile_stdout 08:23:29 INFO - Current package versions: 08:23:29 INFO - blessings == 1.6 08:23:29 INFO - blobuploader == 1.2.4 08:23:29 INFO - docopt == 0.6.1 08:23:29 INFO - functools32 == 3.2.3-2 08:23:29 INFO - jsonschema == 2.5.1 08:23:29 INFO - manifestparser == 1.1 08:23:29 INFO - mozInstall == 1.12 08:23:29 INFO - mozcrash == 1.0 08:23:29 INFO - mozdebug == 0.1 08:23:29 INFO - mozdevice == 0.49 08:23:29 INFO - mozfile == 1.2 08:23:29 INFO - mozhttpd == 0.7 08:23:29 INFO - mozinfo == 0.9 08:23:29 INFO - mozleak == 0.1 08:23:29 INFO - mozlog == 3.4 08:23:29 INFO - moznetwork == 0.27 08:23:29 INFO - mozprocess == 0.24 08:23:29 INFO - mozprofile == 0.28 08:23:29 INFO - mozrunner == 6.13 08:23:29 INFO - mozscreenshot == 0.1 08:23:29 INFO - mozsystemmonitor == 0.3 08:23:29 INFO - moztest == 0.8 08:23:29 INFO - mozversion == 1.4 08:23:29 INFO - psutil == 3.1.1 08:23:29 INFO - requests == 1.2.3 08:23:29 INFO - wsgiref == 0.1.2 08:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:29 INFO - 'HOME': '/Users/cltbld', 08:23:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:29 INFO - 'LOGNAME': 'cltbld', 08:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:29 INFO - 'MOZ_NO_REMOTE': '1', 08:23:29 INFO - 'NO_EM_RESTART': '1', 08:23:29 INFO - 'PAGER': '/bin/cat', 08:23:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:29 INFO - 'PWD': '/builds/slave/test', 08:23:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:29 INFO - 'SHELL': '/bin/bash', 08:23:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:29 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:29 INFO - 'USER': 'cltbld', 08:23:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:29 INFO - 'XPC_FLAGS': '0x0', 08:23:29 INFO - 'XPC_SERVICE_NAME': '0', 08:23:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:29 INFO - Cleaning up... 08:23:29 INFO - Return code: 0 08:23:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b211b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b214768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd2497de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, '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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:23:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:29 INFO - 'HOME': '/Users/cltbld', 08:23:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:29 INFO - 'LOGNAME': 'cltbld', 08:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:29 INFO - 'MOZ_NO_REMOTE': '1', 08:23:29 INFO - 'NO_EM_RESTART': '1', 08:23:29 INFO - 'PAGER': '/bin/cat', 08:23:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:29 INFO - 'PWD': '/builds/slave/test', 08:23:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:29 INFO - 'SHELL': '/bin/bash', 08:23:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:29 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:29 INFO - 'USER': 'cltbld', 08:23:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:29 INFO - 'XPC_FLAGS': '0x0', 08:23:29 INFO - 'XPC_SERVICE_NAME': '0', 08:23:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:30 INFO - Cleaning up... 08:23:30 INFO - Return code: 0 08:23:30 INFO - Running post-action listener: _resource_record_post_action 08:23:30 INFO - Running post-action listener: _start_resource_monitoring 08:23:30 INFO - Starting resource monitoring. 08:23:30 INFO - [mozharness: 2017-01-11 16:23:30.113235Z] Finished create-virtualenv step (success) 08:23:30 INFO - [mozharness: 2017-01-11 16:23:30.114303Z] Running install step. 08:23:30 INFO - Running pre-action listener: _resource_record_pre_action 08:23:30 INFO - Running main action method: install 08:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:30 INFO - Reading from file tmpfile_stdout 08:23:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:30 INFO - Reading from file tmpfile_stdout 08:23:30 INFO - Output received: 08:23:30 INFO - Usage: mozinstall [options] installer 08:23:30 INFO - Options: 08:23:30 INFO - -h, --help show this help message and exit 08:23:30 INFO - -d DEST, --destination=DEST 08:23:30 INFO - Directory to install application into. [default: 08:23:30 INFO - "/builds/slave/test"] 08:23:30 INFO - --app=APP Application being installed. [default: firefox] 08:23:30 INFO - mkdir: /builds/slave/test/build/application 08:23:30 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'] 08:23:30 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 08:23:52 INFO - Reading from file tmpfile_stdout 08:23:52 INFO - Output received: 08:23:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:23:52 INFO - Running post-action listener: _resource_record_post_action 08:23:52 INFO - [mozharness: 2017-01-11 16:23:52.393571Z] Finished install step (success) 08:23:52 INFO - [mozharness: 2017-01-11 16:23:52.393703Z] Running run-tests step. 08:23:52 INFO - Running pre-action listener: _resource_record_pre_action 08:23:52 INFO - Running main action method: run_tests 08:23:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:23:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:23:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:23:52 INFO - 2017-01-11 08:23:52.408 screenresolution[1643:7432] starting screenresolution argv=screenresolution get 08:23:52 INFO - 2017-01-11 08:23:52.410 screenresolution[1643:7432] Display 0: 1600x1200x32@60 08:23:52 INFO - 2017-01-11 08:23:52.416 screenresolution[1644:7434] starting screenresolution argv=screenresolution list 08:23:52 INFO - Available Modes on Display 0 08:23:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:23:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:23:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:23:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:23:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:23:52 INFO - Intel Iris: 08:23:52 INFO - Chipset Model: Intel Iris 08:23:52 INFO - Type: GPU 08:23:52 INFO - Bus: Built-In 08:23:52 INFO - VRAM (Dynamic, Max): 1536 MB 08:23:52 INFO - Vendor: Intel (0x8086) 08:23:52 INFO - Device ID: 0x0a2e 08:23:52 INFO - Revision ID: 0x0009 08:23:52 INFO - Displays: 08:23:52 INFO - Display: 08:23:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:23:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:23:52 INFO - Display Serial Number: 1600x1200 60 08:23:52 INFO - Main Display: Yes 08:23:52 INFO - Mirror: Off 08:23:52 INFO - Online: Yes 08:23:52 INFO - Rotation: Supported 08:23:52 INFO - Return code: 0 08:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:52 INFO - Python 2.7.3 08:23:52 INFO - Return code: 0 08:23:52 INFO - grabbing minidump binary from tooltool 08:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:52 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 0x10afefd30>, '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 0x10af16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:23:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:23:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:23:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:52 INFO - Return code: 0 08:23:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:23:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:23:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:52 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/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:23:52 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/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0363 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KdtmEwRd9d/Render', 08:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:52 INFO - 'HOME': '/Users/cltbld', 08:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:52 INFO - 'LOGNAME': 'cltbld', 08:23:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:52 INFO - 'MOZ_NO_REMOTE': '1', 08:23:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:52 INFO - 'NO_EM_RESTART': '1', 08:23:52 INFO - 'PAGER': '/bin/cat', 08:23:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:52 INFO - 'PWD': '/builds/slave/test', 08:23:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:52 INFO - 'SHELL': '/bin/bash', 08:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cs5IehQ3bE/Listeners', 08:23:52 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 08:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:52 INFO - 'USER': 'cltbld', 08:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:52 INFO - 'XPC_FLAGS': '0x0', 08:23:52 INFO - 'XPC_SERVICE_NAME': '0', 08:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:52 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/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:23:52 INFO - mozversion application_buildid: 20170111064105 08:23:52 INFO - mozversion application_changeset: d9206eb08d6bb601658d8af93cbe9eacb98e18ca 08:23:52 INFO - mozversion application_display_name: Nightly 08:23:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:52 INFO - mozversion application_name: Firefox 08:23:52 INFO - mozversion application_remotingname: firefox 08:23:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:23:52 INFO - mozversion application_vendor: Mozilla 08:23:52 INFO - mozversion application_version: 53.0a1 08:23:52 INFO - mozversion platform_buildid: 20170111064105 08:23:52 INFO - mozversion platform_changeset: d9206eb08d6bb601658d8af93cbe9eacb98e18ca 08:23:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:23:52 INFO - mozversion platform_version: 53.0a1 08:23:52 INFO - using testdate: 1484151832 08:23:52 INFO - actual date: 1484151832 08:23:52 INFO - starting webserver on 'localhost:49236' 08:23:52 INFO - SUITE-START | Running 2 tests 08:23:52 INFO - TEST-START | dromaeo_css 08:23:52 INFO - operating with platform_type : mac_ 08:23:52 INFO - Initialising browser for dromaeo_css test... 08:23:53 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpno0sFH/profile http://localhost:49236/getInfo.html) 08:23:55 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 08:23:55 INFO - PROCESS | 1654 | colorDepth:24 08:23:55 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 08:23:55 INFO - PROCESS | 1654 | __metrics 08:23:55 INFO - PROCESS | 1654 | 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:23:55 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:56 INFO - TEST-INFO | 1654: exit 0 08:23:56 INFO - Browser initialized. 08:23:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:56 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpno0sFH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:08 INFO - PROCESS | 1656 | RSS: Main: 226430976 08:24:08 INFO - PROCESS | 1656 | 08:27:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:27:14 INFO - PROCESS | 1656 | RSS: Main: 448684032 08:27:14 INFO - PROCESS | 1656 | 08:28:56 INFO - PROCESS | 1656 | ************************* 08:28:56 INFO - PROCESS | 1656 | A coding exception was thrown and uncaught in a Task. 08:28:56 INFO - PROCESS | 1656 | 08:28:56 INFO - PROCESS | 1656 | Full message: ReferenceError: fetch is not defined 08:28:56 INFO - PROCESS | 1656 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:28:56 INFO - PROCESS | 1656 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:28:56 INFO - PROCESS | 1656 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:28:56 INFO - PROCESS | 1656 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:28:56 INFO - PROCESS | 1656 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:28:56 INFO - PROCESS | 1656 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:28:56 INFO - PROCESS | 1656 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:28:56 INFO - PROCESS | 1656 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:28:56 INFO - PROCESS | 1656 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:28:56 INFO - PROCESS | 1656 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:28:56 INFO - PROCESS | 1656 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:28:56 INFO - PROCESS | 1656 | 08:28:56 INFO - PROCESS | 1656 | ************************* 08:30:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:30:17 INFO - PROCESS | 1656 | RSS: Main: 368488448 08:30:17 INFO - PROCESS | 1656 | 08:33:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 08:33:20 INFO - PROCESS | 1656 | RSS: Main: 353599488 08:33:20 INFO - PROCESS | 1656 | 08:36:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 08:36:23 INFO - PROCESS | 1656 | RSS: Main: 339300352 08:36:23 INFO - PROCESS | 1656 | 08:39:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:39:28 INFO - PROCESS | 1656 | RSS: Main: 330186752 08:39:28 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:42:31 INFO - PROCESS | 1656 | RSS: Main: 483168256 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | __start_tp_report 08:42:31 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 08:42:31 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 08:42:31 INFO - PROCESS | 1656 | |i|pagename|runs| 08:42:31 INFO - PROCESS | 1656 | |0;dojo.html;3301.8183999880002;3307.751918606105;3313.668633136686;3329.816860072695;3367.3265346930607;5582.190582365554;5596.216529685842;5661.830145095649;5663.886722265553;5674.8581285467835;5616.747246373913;5640.323161220659;5720.856978575538;5726.083826587746;5738.512226460756;4208.768517731523;5110.685303190087;5129;5154.433012368637;5181.740912954356;4561.948738776134;5166.483351664822;5232.3459567554055;5252.789888404459;5293.8941221175555;5201.297824793643;5210.16637338026;5222.92165617516;5235.057689615867;5246.186841039645;5103.693778373309;5121.975604879002;5161.329027226437;5165.096108181053;5195.506426889439;5146.279520867081;5214.765335559909;5218.452062533417;5225.268462415265;5231.790728370861;5639.8590035249035;5651.039323315046;5662.773489060432;5671.404502527216;5675.574331925122;6226.501879849601;6242.032484964838;6255.562110652256;6257.061440783873;6259.530535209878;6124.441964285734;6137.539684523678;6143.815685529441;6219.626822390625;6250.406211409909;5781.4507621775865;5801.158831969341;5828.825135245949;5843.590948633598;5856.765729370863;6308.589941653778;6315.873682526324;6346.27017892939;6358.841028974312;6382.266039405527;5980.372060933626;6143.96928015357;6154.984427569401;6159.630422174684;6160.10678451622;6145.7708458307625;6185.288691800411;6212.06818977157;6226.501879849601;6229.875402491924;6214.161088253119;6216.160818289473;6221.688915554295;6224.9377506224355;6230.00319948806;6161.4146656067605;6177.81466556004;6244.1570387997035;6246.3441338659695;6250.343713910065;4863.878403039952;4910.288008238786;4918.139325618003;4918.409790825052;4983.327250821165;4371.737695738266;4398.868033958986;4403;4427.490838553607;4459.754713490789;5730.942690573124;5747.942520574825;5754.5971781975695;5757.136429535603;5808.970955145282;6117.785877494355;6193.473554747807;6288.748450061947;6308.116863639002;6311.431971122621;5712.914306285409;5717.142428635655;5745.712714364265;5751.769929202785;5788.678945381601;4375.234333991539;5423.511883930465;5427.972860135674;5434.021876062347;5440.455954404528;6303.558750887486;6318.84202894913;6319.936800631935;6320.399562041599;6328.873422531616;6114.692773002257;6121.971262793606;6179.351168127461;6209.906851397323;6245.344238855037;6326.304106548184;6328.968355158195;6340.1440805490665;6342.936570634234;6344.460720838596;5952.226210592596;6064.545159112996;6066.15073889647;6133.110698948717;6142.447179753844;6144.617461071402;6154;6190.226221722285;6194.225721784777;6205.782797602063;5762.884742305214;5979.1928089707335;5986.730597123227;5991.730372133177;6003.519718422428;5988.640681559121;5992.8801423972145;5993.101034844808;5995.310539288038;6005.429484198994;5842.328132264844;5853.970730146322;5864.853378665567;5875.588708790344;5927.051671732502;5897.174395584536;5958.970205148947;5967.343592204767;6121.479674227562;6127.938720612915;5808.477237048686;5821.970890145692;5838.12428135783;5877.676727779842;5922.940770592239 08:42:31 INFO - PROCESS | 1656 | |1;ext.html;437.752669741596;452.138675822558;457.84166059868534;520.323579346849;521.4160140642481;37198.44202336967;39144.021399465026;39453.408198877005;39481;39589.208215835664;39482.012949676275;39764.20471590567;39828.40257396134;39829.80085099571;39893.002674933145;8381.24568788809;9175.770605734844;9363.6722714705;9379.202767764715;9398.436093834393;8482.279006284472;11201.383923884183;11290.491927863224;11309.264897781659;11453.942730286379;11137.554497820078;11217.326960382403;11229.157813164005;11240.213185077047;11248.887511124865;8386.958065209696;8621.69824056155;10424.530896109656;11180.944095279552;11284.830727539094;10865.022148006638;11177.944110279477;11202.66392008241;11341.319520828776;11346.71633209168;39253.82238532849;39257;39262.411063834064;39284.41073383873;39306.60693393058;4025.1345960618314;4031.113155105872;4043.2722110020186;4065.5934406559404;4068.877933661995;29898.85050574755;29929;29983.550246746316;29988.55017174744;30011.249718756986;3122.5160100184507;3260.3968265870653;3311.9006429807146;3313.122022663996;3313.685199906029;489684;491565;492087.5395622999;492777;493167.9999999964;55762.76948921998;56019.71990140023;56105;56109.71945140248;56190;59744;59862.10206846901;59897;60012.69993650004;60013;15311.617209569627;15539.689206215813;15551.611209719847;15555.22223888801;15568.844311556966;10956.506957186946;11207.775844483227;11213.887861121448;12075.698107547381;12152.453139608739;11232.943835280772;13692.863071369158;13699.520516781864;15004.699906001819;15393.076415415111;5707.857303567361;5900.734466948998;6662.200535935622;6692.732290708317;6712.463002959751;872.6509396241428;879.2745984562762;900.342749792655;901.7655409593552;912.9954350228206;29162.708372916422;29243.415131697246;29362.265943351587;29724;30145;1060.4432672846663;1064.4890452582804;1093.305750848217;1111.0445017285128;1166.6849950513315;14421;15051.247437628293;15064.246787660573;15204.46784362542;15516.767248491282;620227;623369.8831505814;625009.2489826116;625840;626935;56552.43447565554;56761;56777.716111420006;56845.43154568484;56847.43152568504;1393.2963853254244;1438.503716217903;1452.0924422236103;1454.1275234859;1456.3810380588206;27600.89596416121;28320.291992700346;28976;29182.854085729436;29183.416331672823;47234.76382618065;59318.40681593129;61269;61311.08033379414;61415.692921535105;597289;610735;611788;612242;612848;42684.62007172099;43105;43486.782566086964;43771.34342984794;43989.78005110082;39706.65426896034;46113.769431153974;46690.766546167055;47752.7612361936;47904;37006.814965925;39283.92889279957;39812.80093599513;39986.200275994895;41033.79483102685;33364.499532507514;39542.20915581615;39916.40125398179;40394;40902.795486022376;38885.22229555449;39083;39316.01709957274;39559;39830.20339593134;31773.523397149525;34550.82724586361;34735.652643473244;34913.68320009595;35044;25518.617220742075;25759.742402575735;25808.225753227434;26218.737812622392;26381.34046648849 08:42:31 INFO - PROCESS | 1656 | |2;jquery.html;371.3019523296203;389.09729427727683;393.7342293951583;400.36142352947047;423.5573825352506;14990.925045374772;16305.592360191002;19586.510337241576;20851.478713032182;21745.021474033667;17403.3038678453;21197;21614.919254037315;21685.566288674218;21808.563828723418;5694.117411801167;5721.628094173886;5810.680412577307;5860.296764388279;5958.433948774881;4113.547509773923;5760.740766665489;5879.323877754049;5884.6469211847425;5885.470307672309;4295.849645262417;4296.441462609872;5475.206095116206;6448.903266451007;6526.086347911296;6304.87390252197;6476.3199864014305;6483.546151769378;6499.837504062389;6508.576942498722;5668.404817494186;5747.109198074305;5762.855928601776;5767.0772676372;5770.076787713988;25573;25973.610395844076;26006.479870402676;26008.959641614314;26610.73389266102;2722.91831245061;3044.88861565527;3048.634163900324;3090.6754790746872;3090.814551126917;14677.339519721532;14906.105633662015;15248.39006439741;15267;15301.693966120727;1749.7987731410924;1782.7364408798499;1835.1008006077059;1865.1886429403253;1906.037451087206;108982;109990.45004775006;110645.44677276643;111929;112539.43730281378;9966.651167209113;10087.848682269772;11238.943805280922;11522.539098436137;11532.617605310097;14441.566752997427;14446.566603001927;14450.566483005527;14461;14478.782818257734;8265.917340826634;8522.318214542945;8542.701005464778;8698.956505217433;8700.564971751513;8181.100078991306;8435.955683086302;8471.95764021176;8518.190771876662;8721.825563488695;6159.322474527888;6189.7620475905;6658.83352916181;7031.824204394931;7066.858662826715;1602.3991003373735;1819.2535166240293;1911.856610754199;1914.5066847858693;1915.4540955827522;1038.8545603615348;1042.4631314872847;1051.574112484445;1055.18223376882;1090.2640717515644;21610;21990.45023874416;22048.88975555112;22049.559008819735;22491.88754056219;1062.0972173652333;1065.3288428290282;1090.4929207918356;1096.4627332606965;1097.9066779323687;9198.63205471787;11104.333739975627;11488.942555287338;11961.40192990347;12082.033437324993;679385;680786;730035;731603;752636;110173;128635;153867;154193.22903385412;159029;949.8955114937352;1102.063246240689;1142.1091548592112;1143.7883991461606;1146.3465824479965;18249.543761406072;19695.21219151218;19907.60184796267;20114.69827952611;20184.293549725688;55291;61797.69101154465;61908.07137893025;61965;64758.676206618664;90395;91890.54054729684;92249;92595.07404925865;96959.06081878181;6034.39656034393;8280.337572994025;8437.282830959437;8476.788080298042;8536.871946920925;12640.925521330422;13052.673683157996;13502.594922152352;13548.458061677817;13591.844693201188;9681.70954871355;11236.606718765132;11319.207655464039;11632.651020469399;11701.824472632747;9172.6789562365;11186.440677966231;11290.040346570633;11604.187706860777;11643.47604357789;9535.904640953502;11762.23545469576;11786.587469438871;11835.881641183478;11902.345371004678;8155;8374.83250335002;8416.87374689368;8426.4944103354;8583.699570515002;11233.943830280796;11241.32552046847;11624.709382265512;11758.3532905691;11839.1712580122 08:42:31 INFO - PROCESS | 1656 | |3;mootools.html;1435.6913263648314;1436.8347640021398;1439.35807022353;1461.254760072363;1463.107504422302;7927.801804954879;8278.296344810691;8294.087650358455;8304.294134998525;8305.211004954519;6534.640594767297;7355;7590.5066170698865;8079.596020198981;8097.1902809718995;2042.560849417375;2183.967240491394;2256.7066281383395;2297.253392647388;2304.5275718477674;2271.954560908781;2289.301762962296;2301.390131615123;2307.1348244408346;2310.445493081657;2208.205046183373;2219.323106452531;2234.5084081502123;2235.5417139486367;2246.29241788836;2228.0308065991344;2245.5733410652088;2247.2359397804744;2250.8167077934377;2251.3020963501203;2114.503091773432;2167.41479800453;2267.4331417145713;2287.885605719707;2293.323469576479;8133.59332033396;8200.302974247195;8201.630926608317;8217.671293148267;8232.83534329316;4978.327925730016;5142.974285128588;5149.0989076911765;5158.148905430599;5170.327857378555;3197.58431403916;3360.714339281164;3369.1913940654067;3370.561826962504;3474.617792042873;1165.6211731187398;1207.082617210926;1213.168979249217;1259.779538580754;1260.5021016698445;10529.736756581147;10571.94714026425;10678.94660526708;10679.41263230522;10680.14558835299;4099.754014759064;4546.431696037996;4595.126925884071;4623.791929363187;4629.1436084324505;9199.540022998823;9224.584893679801;9226;9229.16937475617;9231.538423078819;5162.561182299547;5163.328767260307;5169.224616307584;5171.3277273954145;5171.456997015259;4676.392069031004;4685.812567497262;4716.481187069419;4716.976415117902;4739.3601863748645;3711.6659500645073;3735.9626403735615;3771.453139294787;3815.771053736785;3835.2904712627696;1247.1270110922392;1247.7504499100216;1249.144336129754;1263.7662032524013;1264.607971528829;873.5021038008274;897.3808072430003;907.7276816954887;938.7653086728318;949.8432758594754;5209.749660081629;5599.384067752544;5695.8860822784145;5900.616459930091;5983.1623572699855;957.621739412928;958.7075941837667;1014.5941623350719;1019.612547232062;1037.5331101004579;3559.341521818472;3735.402335626287;3814.48504451901;3817.2365526894732;3855.1904100139286;9559.522023898777;9774.364666296668;9873.80252394948;9900.059494348025;9936.652217172508;9780.559874805509;9836.606535738634;9857.605695772088;9867.259955503223;9871.703848884545;7143.285671432815;7349.154847192642;7562.735304264324;7600.2779735925;7606.733764318333;5661.490465858093;5683.516901063456;5692.516136128475;5815.331236907809;5851.356350801493;8891.333150013645;8909.242714369351;8925.866112008196;9211.907880921373;9243;8141.470804397695;9016.774580635536;9018;9170.724878253663;9175.174234318943;6488.188976377953;6703.02806093104;6851.314868513308;6950.8609827804175;7092.503524753424;7694.769156925301;7727.9691396894505;7859.017622797151;7860.292573668397;7862.2923936845955;6946.930530694628;6988.79033628992;6996.6151861648095;7135.250798666273;7173.246809084971;6765.289644587444;6889.276625954403;6905.274946130785;6909.7581584644295;6920.342567456084;6192.81421557354;6347.587406818542;6352.428281454691;6355.713992870239;6358.395952384516;4826.493218212177;4868.683535570177;4896.828610998598;4911.607071434348;4972.776225069808;4891.673661909793;4932.161532539405;4960.032793605213;5013.072581572421;5036.974815125901 08:42:31 INFO - PROCESS | 1656 | |4;prototype.html;300.38571122055396;357.69595843533;373.5871861592939;378.64633933687077;381.93316169670317;4860.368152140221;4980.626453016021;5326.680399176047;5361.973190134044;5362.410134885159;4153.667706583474;4554.931676024862;4946.9257961130525;5116.641835071547;5131.846044618658;3974.3839704845795;4110.568390319011;4114.300568903293;4152.314868046768;4161.354989976543;3784.394496880486;4114.683301343572;4138.234426631067;4150.771707556083;4192.580741925798;3968.6229808168177;4076.8177228603668;4097.221527909703;4113.547509773923;4144.295469770146;3399.6770306820813;3781.773093614392;3904.648581627667;4070.715049946505;4141.9585804142025;3002.4445477586714;3635.836532309662;3660.9450858237146;3666.2667466506805;3670.9354287256665;4795.328653988445;4929.8028078876805;5137.434882162959;5178.974105129488;5179.585633149339;4517.683762136652;4612.838550650711;4624.606908412789;4639.350490931272;4647.744374059425;5600.691961942091;5603.579731520153;5615.466530679579;5621.522170615503;5647.362264943162;3293.79224371336;3446.172918499542;3713.313037088147;3867.1878905429894;3876.3604005339084;4789.616830653575;5068.350787433043;5561.77752889884;5831.475167234969;5878.707304151384;3613.95195393333;3674.5590529136675;3763.284975854579;3854.383298672199;3873.8644147455266;3933.872571305819;3938.6258305460933;3950.2297052075146;3954.426608141861;3956.208758248304;4426;4528;4535.297028960516;4563.106310880948;4607.562281583244;4828.855134345975;5229.869253268623;5591.720413979285;5599.8600034998635;5606.6636001840025;953.4708236928433;1047.4396198034167;1212.8241404996227;1273.3824095313767;1277.7827769279245;818.4802650317091;833.4457585705438;848.3552500099845;865.5412631305418;870.8954925408991;4582.495925448198;4923.113839508923;4924.276503223843;4943.90112197754;4948.777305021283;5074;5441.918371224435;5444.428335024844;5466.316710411199;5499.670019798825;4005.1589166275407;4355.80398882051;4470.6870519064005;4499.290269697494;4686.305374409728;2739.643846299968;2777.708340624246;2834.518131917579;2845.231787417386;2852.0196394767518;5327.694714794822;5336.399080275979;5628;5638.689872057076;5685.573581981285;5373.931036550956;5445.346558413015;5864.237649105589;5874.472637114381;5895.498882594941;4782.402199725035;5714.285714285715;5845.620034697731;5953.3451320354725;5989.970050149808;5005.72354049715;5370.838874833761;5413.7834486620095;5719.714014299351;5757.3379061406795;5017.448080711046;5194.714290714047;5307.336582927134;5669.064604340238;5710.971445142748;5513.807016754395;5739.799107031234;5967.9701601491715;5982.572896056973;6022.861884031106;3613.7289703271836;3825.6748176404203;3863.96136038636;3892.4115463216644;3912.765234085964;4780.179693980568;5557.5553955682635;5669.574781891292;5737.827865164052;5739.454751798572;4684.882877928079;5422.376426710979;5632.352279487911;5649.0060268058;5655.802046928337;4745.291694989732;4902.333206709736;5028.270900719448;5573.665580065209;5595.328560572757;4650.558196971282;5198.610104242272;5359.866003349947;5469.562435005269;5485.588580856372;4229.598188172119;5325.707086110301;5488.643238189505;5541.972290138524;5548.472895074961;5360.222767698584;5380.273663055437;5381.542568881689;5393.946060539344;5445.673259604437 08:42:31 INFO - PROCESS | 1656 | |5;yui.html;628.8176428835637;708.1891234536453;745.8582869254841;769.1500891514876;821.7082935557877;14788.18664973426;15587.376504939788;15590.98658587191;15614;15614.219289035545;14277.92861035696;14414.783778243334;14424.062435941683;14427.855721442782;14431.350589223484;660.465023331101;677.2651672934871;699.9300069992986;846.5132548784474;848.5841937450666;852.9658813647446;853.8420392227426;869.7303835810919;870.0559892516627;870.1211776106115;891.7235656946367;932.5616960028809;940.2712897504455;944.0417975754615;945.1021529546923;713.5682911838367;736.7679181057949;935.4948327902924;937.1378331934636;938.5401153434836;663.2174034639124;677.3869647968596;679.9592024478497;681.0431343961742;683.6889215406978;14724.55826325212;14837.480688175861;14935.402583896632;14966.47617333399;15018.774718379233;13641.908647308192;13645.317734113354;13776.724465510633;13820.723585528232;13908.095973761672;12547.874521254762;12645.620631381073;12766.234025958473;12880.484780608858;13146.934265328613;4334.826606935719;4399.758013309267;4549.522300158469;4555.248384016633;4556.658250631216;82621;97391.51304243505;101321;105413.47293263562;108037;10796.958828289766;10799.460026998619;10827.079698225582;10972.561097556169;11206.719832004102;21482.78517214808;21719;21719.56560868774;21776.346709598736;21943.561128777335;7527.096748390119;7566.735164269224;7616.657250423634;7790.727324543614;7809.414293927978;3740.9064773380883;3874.089588946595;4011.1777085697363;4130.690198235145;4153.979230103831;3411.692947634725;3442.5524681791208;3461.3423449544507;3489.6335884732243;3503.404421248394;559.2059275828334;624.6283461340495;637.6492928889093;640.0303540136697;646.7574659502686;636.3191385217773;643.5616397351914;648.5589798936674;651.1665068712056;666.6865085270388;8985;9825.705228843146;9854.014598540089;9903.554340054714;10067.697969060793;630.3412933484428;630.8107567729663;653.1574269192784;655.8130932684162;687.7386593094692;4802.615790736802;4820.132376172252;4836.879078023007;4854.538818812207;4866.270059491105;100839.48740768894;104416.47791760993;104516.47741761242;105560.94439055664;107309;82076.58961705153;82673.58663206645;84082.15917840743;84361;90614.54692726494;63280.68359658265;65671;80587.7911831323;82392.76410853842;83395;10232.11370784705;10904.727381815517;10939.671809845717;10963;11237.3257604544;47288;48560.028799423104;48953.755231223615;51137.23294150665;51484.22773658473;62513.687431562554;65757.67121164364;65864.6706766463;66497;68191;12500.31248281317;12857.96904913842;13006.479740810262;13279.203247805162;13619.18284902909;14461.566153015427;14810.851891480947;14818.594834548174;14946.626334341294;14963.850361496246;13723.519676811264;13752.587422377344;13802.861971380158;13956.644264057033;14045.227512486912;13641.2117104093;13786.310684465536;13830.723385532434;13992.650183745487;14055.789163162357;13496.865031349953;13519.459221631418;13769.173849569059;13789.793153102511;13940;11024.779504410028;11143.498542565441;11173;11570.370884638303;11630.534778609099;10343.172546196136;10515;10825.796753754363;10921.83617245726;11020.834687479855 08:42:31 INFO - PROCESS | 1656 | __end_tp_report 08:42:31 INFO - PROCESS | 1656 | __start_cc_report 08:42:31 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2531 08:42:31 INFO - PROCESS | 1656 | __end_cc_report 08:42:31 INFO - PROCESS | 1656 | __startTimestamp1484152951418__endTimestamp 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | ------- Summary: start ------- 08:42:31 INFO - PROCESS | 1656 | Number of tests: 6 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5707.58 Median:5875.59 stddev:657.47 (11.2%) stddev-sans-first:631.82 08:42:31 INFO - PROCESS | 1656 | Values: 3301.8 3307.8 3313.7 3329.8 3367.3 5582.2 5596.2 5661.8 5663.9 5674.9 5616.7 5640.3 5720.9 5726.1 5738.5 4208.8 5110.7 5129.0 5154.4 5181.7 4561.9 5166.5 5232.3 5252.8 5293.9 5201.3 5210.2 5222.9 5235.1 5246.2 5103.7 5122.0 5161.3 5165.1 5195.5 5146.3 5214.8 5218.5 5225.3 5231.8 5639.9 5651.0 5662.8 5671.4 5675.6 6226.5 6242.0 6255.6 6257.1 6259.5 6124.4 6137.5 6143.8 6219.6 6250.4 5781.5 5801.2 5828.8 5843.6 5856.8 6308.6 6315.9 6346.3 6358.8 6382.3 5980.4 6144.0 6155.0 6159.6 6160.1 6145.8 6185.3 6212.1 6226.5 6229.9 6214.2 6216.2 6221.7 6224.9 6230.0 6161.4 6177.8 6244.2 6246.3 6250.3 4863.9 4910.3 4918.1 4918.4 4983.3 4371.7 4398.9 4403.0 4427.5 4459.8 5730.9 5747.9 5754.6 5757.1 5809.0 6117.8 6193.5 6288.7 6308.1 6311.4 5712.9 5717.1 5745.7 5751.8 5788.7 4375.2 5423.5 5428.0 5434.0 5440.5 6303.6 6318.8 6319.9 6320.4 6328.9 6114.7 6122.0 6179.4 6209.9 6245.3 6326.3 6329.0 6340.1 6342.9 6344.5 5952.2 6064.5 6066.2 6133.1 6142.4 6144.6 6154.0 6190.2 6194.2 6205.8 5762.9 5979.2 5986.7 5991.7 6003.5 5988.6 5992.9 5993.1 5995.3 6005.4 5842.3 5854.0 5864.9 5875.6 5927.1 5897.2 5959.0 5967.3 6121.5 6127.9 5808.5 5822.0 5838.1 5877.7 5922.9 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:70959.52 Median:39467.20 stddev:154424.50 (391.3%) stddev-sans-first:154766.92 08:42:31 INFO - PROCESS | 1656 | Values: 437.8 452.1 457.8 520.3 521.4 37198.4 39144.0 39453.4 39481.0 39589.2 39482.0 39764.2 39828.4 39829.8 39893.0 8381.2 9175.8 9363.7 9379.2 9398.4 8482.3 11201.4 11290.5 11309.3 11453.9 11137.6 11217.3 11229.2 11240.2 11248.9 8387.0 8621.7 10424.5 11180.9 11284.8 10865.0 11177.9 11202.7 11341.3 11346.7 39253.8 39257.0 39262.4 39284.4 39306.6 4025.1 4031.1 4043.3 4065.6 4068.9 29898.9 29929.0 29983.6 29988.6 30011.2 3122.5 3260.4 3311.9 3313.1 3313.7 489684.0 491565.0 492087.5 492777.0 493168.0 55762.8 56019.7 56105.0 56109.7 56190.0 59744.0 59862.1 59897.0 60012.7 60013.0 15311.6 15539.7 15551.6 15555.2 15568.8 10956.5 11207.8 11213.9 12075.7 12152.5 11232.9 13692.9 13699.5 15004.7 15393.1 5707.9 5900.7 6662.2 6692.7 6712.5 872.7 879.3 900.3 901.8 913.0 29162.7 29243.4 29362.3 29724.0 30145.0 1060.4 1064.5 1093.3 1111.0 1166.7 14421.0 15051.2 15064.2 15204.5 15516.8 620227.0 623369.9 625009.2 625840.0 626935.0 56552.4 56761.0 56777.7 56845.4 56847.4 1393.3 1438.5 1452.1 1454.1 1456.4 27600.9 28320.3 28976.0 29182.9 29183.4 47234.8 59318.4 61269.0 61311.1 61415.7 597289.0 610735.0 611788.0 612242.0 612848.0 42684.6 43105.0 43486.8 43771.3 43989.8 39706.7 46113.8 46690.8 47752.8 47904.0 37006.8 39283.9 39812.8 39986.2 41033.8 33364.5 39542.2 39916.4 40394.0 40902.8 38885.2 39083.0 39316.0 39559.0 39830.2 31773.5 34550.8 34735.7 34913.7 35044.0 25518.6 25759.7 25808.2 26218.7 26381.3 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:39361.51 Median:22019.67 stddev:118806.26 (539.5%) stddev-sans-first:119103.47 08:42:31 INFO - PROCESS | 1656 | Values: 371.3 389.1 393.7 400.4 423.6 14990.9 16305.6 19586.5 20851.5 21745.0 17403.3 21197.0 21614.9 21685.6 21808.6 5694.1 5721.6 5810.7 5860.3 5958.4 4113.5 5760.7 5879.3 5884.6 5885.5 4295.8 4296.4 5475.2 6448.9 6526.1 6304.9 6476.3 6483.5 6499.8 6508.6 5668.4 5747.1 5762.9 5767.1 5770.1 25573.0 25973.6 26006.5 26009.0 26610.7 2722.9 3044.9 3048.6 3090.7 3090.8 14677.3 14906.1 15248.4 15267.0 15301.7 1749.8 1782.7 1835.1 1865.2 1906.0 108982.0 109990.5 110645.4 111929.0 112539.4 9966.7 10087.8 11238.9 11522.5 11532.6 14441.6 14446.6 14450.6 14461.0 14478.8 8265.9 8522.3 8542.7 8699.0 8700.6 8181.1 8436.0 8472.0 8518.2 8721.8 6159.3 6189.8 6658.8 7031.8 7066.9 1602.4 1819.3 1911.9 1914.5 1915.5 1038.9 1042.5 1051.6 1055.2 1090.3 21610.0 21990.5 22048.9 22049.6 22491.9 1062.1 1065.3 1090.5 1096.5 1097.9 9198.6 11104.3 11488.9 11961.4 12082.0 679385.0 680786.0 730035.0 731603.0 752636.0 110173.0 128635.0 153867.0 154193.2 159029.0 949.9 1102.1 1142.1 1143.8 1146.3 18249.5 19695.2 19907.6 20114.7 20184.3 55291.0 61797.7 61908.1 61965.0 64758.7 90395.0 91890.5 92249.0 92595.1 96959.1 6034.4 8280.3 8437.3 8476.8 8536.9 12640.9 13052.7 13502.6 13548.5 13591.8 9681.7 11236.6 11319.2 11632.7 11701.8 9172.7 11186.4 11290.0 11604.2 11643.5 9535.9 11762.2 11786.6 11835.9 11902.3 8155.0 8374.8 8416.9 8426.5 8583.7 11233.9 11241.3 11624.7 11758.4 11839.2 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5344.90 Median:5170.83 stddev:2878.45 (55.7%) stddev-sans-first:2871.54 08:42:31 INFO - PROCESS | 1656 | Values: 1435.7 1436.8 1439.4 1461.3 1463.1 7927.8 8278.3 8294.1 8304.3 8305.2 6534.6 7355.0 7590.5 8079.6 8097.2 2042.6 2184.0 2256.7 2297.3 2304.5 2272.0 2289.3 2301.4 2307.1 2310.4 2208.2 2219.3 2234.5 2235.5 2246.3 2228.0 2245.6 2247.2 2250.8 2251.3 2114.5 2167.4 2267.4 2287.9 2293.3 8133.6 8200.3 8201.6 8217.7 8232.8 4978.3 5143.0 5149.1 5158.1 5170.3 3197.6 3360.7 3369.2 3370.6 3474.6 1165.6 1207.1 1213.2 1259.8 1260.5 10529.7 10571.9 10678.9 10679.4 10680.1 4099.8 4546.4 4595.1 4623.8 4629.1 9199.5 9224.6 9226.0 9229.2 9231.5 5162.6 5163.3 5169.2 5171.3 5171.5 4676.4 4685.8 4716.5 4717.0 4739.4 3711.7 3736.0 3771.5 3815.8 3835.3 1247.1 1247.8 1249.1 1263.8 1264.6 873.5 897.4 907.7 938.8 949.8 5209.7 5599.4 5695.9 5900.6 5983.2 957.6 958.7 1014.6 1019.6 1037.5 3559.3 3735.4 3814.5 3817.2 3855.2 9559.5 9774.4 9873.8 9900.1 9936.7 9780.6 9836.6 9857.6 9867.3 9871.7 7143.3 7349.2 7562.7 7600.3 7606.7 5661.5 5683.5 5692.5 5815.3 5851.4 8891.3 8909.2 8925.9 9211.9 9243.0 8141.5 9016.8 9018.0 9170.7 9175.2 6488.2 6703.0 6851.3 6950.9 7092.5 7694.8 7728.0 7859.0 7860.3 7862.3 6946.9 6988.8 6996.6 7135.3 7173.2 6765.3 6889.3 6905.3 6909.8 6920.3 6192.8 6347.6 6352.4 6355.7 6358.4 4826.5 4868.7 4896.8 4911.6 4972.8 4891.7 4932.2 4960.0 5013.1 5037.0 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4462.98 Median:4936.85 stddev:1363.58 (27.6%) stddev-sans-first:1331.14 08:42:31 INFO - PROCESS | 1656 | Values: 300.4 357.7 373.6 378.6 381.9 4860.4 4980.6 5326.7 5362.0 5362.4 4153.7 4554.9 4946.9 5116.6 5131.8 3974.4 4110.6 4114.3 4152.3 4161.4 3784.4 4114.7 4138.2 4150.8 4192.6 3968.6 4076.8 4097.2 4113.5 4144.3 3399.7 3781.8 3904.6 4070.7 4142.0 3002.4 3635.8 3660.9 3666.3 3670.9 4795.3 4929.8 5137.4 5179.0 5179.6 4517.7 4612.8 4624.6 4639.4 4647.7 5600.7 5603.6 5615.5 5621.5 5647.4 3293.8 3446.2 3713.3 3867.2 3876.4 4789.6 5068.4 5561.8 5831.5 5878.7 3614.0 3674.6 3763.3 3854.4 3873.9 3933.9 3938.6 3950.2 3954.4 3956.2 4426.0 4528.0 4535.3 4563.1 4607.6 4828.9 5229.9 5591.7 5599.9 5606.7 953.5 1047.4 1212.8 1273.4 1277.8 818.5 833.4 848.4 865.5 870.9 4582.5 4923.1 4924.3 4943.9 4948.8 5074.0 5441.9 5444.4 5466.3 5499.7 4005.2 4355.8 4470.7 4499.3 4686.3 2739.6 2777.7 2834.5 2845.2 2852.0 5327.7 5336.4 5628.0 5638.7 5685.6 5373.9 5445.3 5864.2 5874.5 5895.5 4782.4 5714.3 5845.6 5953.3 5990.0 5005.7 5370.8 5413.8 5719.7 5757.3 5017.4 5194.7 5307.3 5669.1 5711.0 5513.8 5739.8 5968.0 5982.6 6022.9 3613.7 3825.7 3864.0 3892.4 3912.8 4780.2 5557.6 5669.6 5737.8 5739.5 4684.9 5422.4 5632.4 5649.0 5655.8 4745.3 4902.3 5028.3 5573.7 5595.3 4650.6 5198.6 5359.9 5469.6 5485.6 4229.6 5325.7 5488.6 5542.0 5548.5 5360.2 5380.3 5381.5 5393.9 5445.7 08:42:31 INFO - PROCESS | 1656 | 08:42:31 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:20153.77 Median:3942.63 stddev:28476.10 (722.3%) stddev-sans-first:28518.24 08:42:31 INFO - PROCESS | 1656 | Values: 628.8 708.2 745.9 769.2 821.7 14788.2 15587.4 15591.0 15614.0 15614.2 14277.9 14414.8 14424.1 14427.9 14431.4 660.5 677.3 699.9 846.5 848.6 853.0 853.8 869.7 870.1 870.1 891.7 932.6 940.3 944.0 945.1 713.6 736.8 935.5 937.1 938.5 663.2 677.4 680.0 681.0 683.7 14724.6 14837.5 14935.4 14966.5 15018.8 13641.9 13645.3 13776.7 13820.7 13908.1 12547.9 12645.6 12766.2 12880.5 13146.9 4334.8 4399.8 4549.5 4555.2 4556.7 82621.0 97391.5 101321.0 105413.5 108037.0 10797.0 10799.5 10827.1 10972.6 11206.7 21482.8 21719.0 21719.6 21776.3 21943.6 7527.1 7566.7 7616.7 7790.7 7809.4 3740.9 3874.1 4011.2 4130.7 4154.0 3411.7 3442.6 3461.3 3489.6 3503.4 559.2 624.6 637.6 640.0 646.8 636.3 643.6 648.6 651.2 666.7 8985.0 9825.7 9854.0 9903.6 10067.7 630.3 630.8 653.2 655.8 687.7 4802.6 4820.1 4836.9 4854.5 4866.3 100839.5 104416.5 104516.5 105560.9 107309.0 82076.6 82673.6 84082.2 84361.0 90614.5 63280.7 65671.0 80587.8 82392.8 83395.0 10232.1 10904.7 10939.7 10963.0 11237.3 47288.0 48560.0 48953.8 51137.2 51484.2 62513.7 65757.7 65864.7 66497.0 68191.0 12500.3 12858.0 13006.5 13279.2 13619.2 14461.6 14810.9 14818.6 14946.6 14963.9 13723.5 13752.6 13802.9 13956.6 14045.2 13641.2 13786.3 13830.7 13992.7 14055.8 13496.9 13519.5 13769.2 13789.8 13940.0 11024.8 11143.5 11173.0 11570.4 11630.5 10343.2 10515.0 10825.8 10921.8 11020.8 08:42:31 INFO - PROCESS | 1656 | -------- Summary: end -------- 08:42:31 INFO - PROCESS | 1656 | 08:42:32 INFO - TEST-INFO | 1656: exit 0 08:42:32 INFO - TEST-OK | dromaeo_css | took 1119078ms 08:42:32 INFO - TEST-START | kraken 08:42:32 INFO - operating with platform_type : mac_ 08:42:32 INFO - Initialising browser for kraken test... 08:42:32 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmppH6Pqt/profile http://localhost:49236/getInfo.html) 08:42:34 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 08:42:34 INFO - PROCESS | 1667 | colorDepth:24 08:42:34 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 08:42:34 INFO - PROCESS | 1667 | __metrics 08:42:34 INFO - PROCESS | 1667 | 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:42:34 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:35 INFO - TEST-INFO | 1667: exit 0 08:42:35 INFO - Browser initialized. 08:42:35 INFO - Running cycle 1/1 for kraken test... 08:42:35 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmppH6Pqt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:47 INFO - PROCESS | 1668 | RSS: Main: 235511808 08:42:47 INFO - PROCESS | 1668 | 08:42:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:50 INFO - PROCESS | 1668 | RSS: Main: 286973952 08:42:50 INFO - PROCESS | 1668 | 08:42:53 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:42:54 INFO - PROCESS | 1668 | RSS: Main: 286281728 08:42:54 INFO - PROCESS | 1668 | 08:42:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:42:58 INFO - PROCESS | 1668 | RSS: Main: 381534208 08:42:58 INFO - PROCESS | 1668 | 08:43:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:43:00 INFO - PROCESS | 1668 | RSS: Main: 282869760 08:43:00 INFO - PROCESS | 1668 | 08:43:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:03 INFO - PROCESS | 1668 | RSS: Main: 286810112 08:43:03 INFO - PROCESS | 1668 | 08:43:05 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:06 INFO - PROCESS | 1668 | RSS: Main: 326619136 08:43:06 INFO - PROCESS | 1668 | 08:43:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:10 INFO - PROCESS | 1668 | RSS: Main: 331104256 08:43:10 INFO - PROCESS | 1668 | 08:43:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:43:13 INFO - PROCESS | 1668 | RSS: Main: 327340032 08:43:13 INFO - PROCESS | 1668 | 08:43:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:15 INFO - PROCESS | 1668 | RSS: Main: 303833088 08:43:15 INFO - PROCESS | 1668 | 08:43:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:18 INFO - PROCESS | 1668 | RSS: Main: 308846592 08:43:18 INFO - PROCESS | 1668 | 08:43:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:21 INFO - PROCESS | 1668 | RSS: Main: 309542912 08:43:21 INFO - PROCESS | 1668 | 08:43:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:25 INFO - PROCESS | 1668 | RSS: Main: 324464640 08:43:25 INFO - PROCESS | 1668 | 08:43:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:28 INFO - PROCESS | 1668 | RSS: Main: 318382080 08:43:28 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:43:30 INFO - PROCESS | 1668 | RSS: Main: 362471424 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | __start_tp_report 08:43:30 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 08:43:30 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 08:43:30 INFO - PROCESS | 1668 | |i|pagename|runs| 08:43:30 INFO - PROCESS | 1668 | |0;ai-astar;114;113;113;113;113;114;113;114;113;112 08:43:30 INFO - PROCESS | 1668 | |1;audio-beat-detection;138;111;106;140;110;106;127;139;160;110 08:43:30 INFO - PROCESS | 1668 | |2;audio-dft;183;184;183;184;182;183;181;182;185;185 08:43:30 INFO - PROCESS | 1668 | |3;audio-fft;78;58;60;87;60;58;59;58;73;58 08:43:30 INFO - PROCESS | 1668 | |4;audio-oscillator;84;70;86;70;69;70;84;69;70;85 08:43:30 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;87;85;87;84;86;84;88;85;87;83 08:43:30 INFO - PROCESS | 1668 | |6;imaging-darkroom;93;94;93;107;149;93;93;98;93;94 08:43:30 INFO - PROCESS | 1668 | |7;imaging-desaturate;89;88;83;86;71;127;138;98;87;87 08:43:30 INFO - PROCESS | 1668 | |8;json-parse-financial;56;55;53;53;56;55;55;55;55;55 08:43:30 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;67;73;81;73;74;71;72;73;72;73 08:43:30 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;86;87;87;86;99;107;81;87;86;89 08:43:30 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;140;141;141;139;139;139;155;147;210;155 08:43:30 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;175;175;172;175;179;173;172;170;172;171 08:43:30 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;68;67;68;67;69;73;84;87;86;74 08:43:30 INFO - PROCESS | 1668 | __end_tp_report 08:43:30 INFO - PROCESS | 1668 | __start_cc_report 08:43:30 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2025 08:43:30 INFO - PROCESS | 1668 | __end_cc_report 08:43:30 INFO - PROCESS | 1668 | __startTimestamp1484153010675__endTimestamp 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | ------- Summary: start ------- 08:43:30 INFO - PROCESS | 1668 | Number of tests: 14 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 08:43:30 INFO - PROCESS | 1668 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 113.0 114.0 113.0 112.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:132.50 stddev:18.82 (14.2%) stddev-sans-first:19.33 08:43:30 INFO - PROCESS | 1668 | Values: 138.0 111.0 106.0 140.0 110.0 106.0 127.0 139.0 160.0 110.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.32 (0.7%) stddev-sans-first:1.39 08:43:30 INFO - PROCESS | 1668 | Values: 183.0 184.0 183.0 184.0 182.0 183.0 181.0 182.0 185.0 185.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:64.90 Median:60.00 stddev:10.54 (17.6%) stddev-sans-first:10.05 08:43:30 INFO - PROCESS | 1668 | Values: 78.0 58.0 60.0 87.0 60.0 58.0 59.0 58.0 73.0 58.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:77.00 stddev:7.82 (10.2%) stddev-sans-first:7.69 08:43:30 INFO - PROCESS | 1668 | Values: 84.0 70.0 86.0 70.0 69.0 70.0 84.0 69.0 70.0 85.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:1.65 (1.9%) stddev-sans-first:1.67 08:43:30 INFO - PROCESS | 1668 | Values: 87.0 85.0 87.0 84.0 86.0 84.0 88.0 85.0 87.0 83.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:93.00 stddev:17.53 (18.9%) stddev-sans-first:18.37 08:43:30 INFO - PROCESS | 1668 | Values: 93.0 94.0 93.0 107.0 149.0 93.0 93.0 98.0 93.0 94.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:87.00 stddev:20.80 (23.9%) stddev-sans-first:21.93 08:43:30 INFO - PROCESS | 1668 | Values: 89.0 88.0 83.0 86.0 71.0 127.0 138.0 98.0 87.0 87.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 08:43:30 INFO - PROCESS | 1668 | Values: 56.0 55.0 53.0 53.0 56.0 55.0 55.0 55.0 55.0 55.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:73.00 stddev:3.45 (4.7%) stddev-sans-first:2.92 08:43:30 INFO - PROCESS | 1668 | Values: 67.0 73.0 81.0 73.0 74.0 71.0 72.0 73.0 72.0 73.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:87.00 stddev:7.63 (8.8%) stddev-sans-first:7.99 08:43:30 INFO - PROCESS | 1668 | Values: 86.0 87.0 87.0 86.0 99.0 107.0 81.0 87.0 86.0 89.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:144.00 stddev:21.81 (15.1%) stddev-sans-first:22.79 08:43:30 INFO - PROCESS | 1668 | Values: 140.0 141.0 141.0 139.0 139.0 139.0 155.0 147.0 210.0 155.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:2.63 (1.5%) stddev-sans-first:2.73 08:43:30 INFO - PROCESS | 1668 | Values: 175.0 175.0 172.0 175.0 179.0 173.0 172.0 170.0 172.0 171.0 08:43:30 INFO - PROCESS | 1668 | 08:43:30 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:73.50 stddev:8.22 (11.2%) stddev-sans-first:8.40 08:43:30 INFO - PROCESS | 1668 | Values: 68.0 67.0 68.0 67.0 69.0 73.0 84.0 87.0 86.0 74.0 08:43:30 INFO - PROCESS | 1668 | -------- Summary: end -------- 08:43:30 INFO - PROCESS | 1668 | 08:43:31 INFO - TEST-INFO | 1668: exit 0 08:43:31 INFO - TEST-OK | kraken | took 59530ms 08:43:31 INFO - SUITE-END | took 1178s 08:43:31 INFO - Completed test suite (00:19:38) 08:43:31 INFO - javascript benchmark 08:43:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.8183999880002, 3307.751918606105, 3313.668633136686, 3329.816860072695, 3367.3265346930607, 5582.190582365554, 5596.216529685842, 5661.830145095649, 5663.886722265553, 5674.8581285467835, 5616.747246373913, 5640.323161220659, 5720.856978575538, 5726.083826587746, 5738.512226460756, 4208.768517731523, 5110.685303190087, 5129.0, 5154.433012368637, 5181.740912954356, 4561.948738776134, 5166.483351664822, 5232.3459567554055, 5252.789888404459, 5293.8941221175555, 5201.297824793643, 5210.16637338026, 5222.92165617516, 5235.057689615867, 5246.186841039645, 5103.693778373309, 5121.975604879002, 5161.329027226437, 5165.096108181053, 5195.506426889439, 5146.279520867081, 5214.765335559909, 5218.452062533417, 5225.268462415265, 5231.790728370861, 5639.8590035249035, 5651.039323315046, 5662.773489060432, 5671.404502527216, 5675.574331925122, 6226.501879849601, 6242.032484964838, 6255.562110652256, 6257.061440783873, 6259.530535209878, 6124.441964285734, 6137.539684523678, 6143.815685529441, 6219.626822390625, 6250.406211409909, 5781.4507621775865, 5801.158831969341, 5828.825135245949, 5843.590948633598, 5856.765729370863, 6308.589941653778, 6315.873682526324, 6346.27017892939, 6358.841028974312, 6382.266039405527, 5980.372060933626, 6143.96928015357, 6154.984427569401, 6159.630422174684, 6160.10678451622, 6145.7708458307625, 6185.288691800411, 6212.06818977157, 6226.501879849601, 6229.875402491924, 6214.161088253119, 6216.160818289473, 6221.688915554295, 6224.9377506224355, 6230.00319948806, 6161.4146656067605, 6177.81466556004, 6244.1570387997035, 6246.3441338659695, 6250.343713910065, 4863.878403039952, 4910.288008238786, 4918.139325618003, 4918.409790825052, 4983.327250821165, 4371.737695738266, 4398.868033958986, 4403.0, 4427.490838553607, 4459.754713490789, 5730.942690573124, 5747.942520574825, 5754.5971781975695, 5757.136429535603, 5808.970955145282, 6117.785877494355, 6193.473554747807, 6288.748450061947, 6308.116863639002, 6311.431971122621, 5712.914306285409, 5717.142428635655, 5745.712714364265, 5751.769929202785, 5788.678945381601, 4375.234333991539, 5423.511883930465, 5427.972860135674, 5434.021876062347, 5440.455954404528, 6303.558750887486, 6318.84202894913, 6319.936800631935, 6320.399562041599, 6328.873422531616, 6114.692773002257, 6121.971262793606, 6179.351168127461, 6209.906851397323, 6245.344238855037, 6326.304106548184, 6328.968355158195, 6340.1440805490665, 6342.936570634234, 6344.460720838596, 5952.226210592596, 6064.545159112996, 6066.15073889647, 6133.110698948717, 6142.447179753844, 6144.617461071402, 6154.0, 6190.226221722285, 6194.225721784777, 6205.782797602063, 5762.884742305214, 5979.1928089707335, 5986.730597123227, 5991.730372133177, 6003.519718422428, 5988.640681559121, 5992.8801423972145, 5993.101034844808, 5995.310539288038, 6005.429484198994, 5842.328132264844, 5853.970730146322, 5864.853378665567, 5875.588708790344, 5927.051671732502, 5897.174395584536, 5958.970205148947, 5967.343592204767, 6121.479674227562, 6127.938720612915, 5808.477237048686, 5821.970890145692, 5838.12428135783, 5877.676727779842, 5922.940770592239], "value": 5664.290544514487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.752669741596, 452.138675822558, 457.84166059868534, 520.323579346849, 521.4160140642481, 37198.44202336967, 39144.021399465026, 39453.408198877005, 39481.0, 39589.208215835664, 39482.012949676275, 39764.20471590567, 39828.40257396134, 39829.80085099571, 39893.002674933145, 8381.24568788809, 9175.770605734844, 9363.6722714705, 9379.202767764715, 9398.436093834393, 8482.279006284472, 11201.383923884183, 11290.491927863224, 11309.264897781659, 11453.942730286379, 11137.554497820078, 11217.326960382403, 11229.157813164005, 11240.213185077047, 11248.887511124865, 8386.958065209696, 8621.69824056155, 10424.530896109656, 11180.944095279552, 11284.830727539094, 10865.022148006638, 11177.944110279477, 11202.66392008241, 11341.319520828776, 11346.71633209168, 39253.82238532849, 39257.0, 39262.411063834064, 39284.41073383873, 39306.60693393058, 4025.1345960618314, 4031.113155105872, 4043.2722110020186, 4065.5934406559404, 4068.877933661995, 29898.85050574755, 29929.0, 29983.550246746316, 29988.55017174744, 30011.249718756986, 3122.5160100184507, 3260.3968265870653, 3311.9006429807146, 3313.122022663996, 3313.685199906029, 489684.0, 491565.0, 492087.5395622999, 492777.0, 493167.9999999964, 55762.76948921998, 56019.71990140023, 56105.0, 56109.71945140248, 56190.0, 59744.0, 59862.10206846901, 59897.0, 60012.69993650004, 60013.0, 15311.617209569627, 15539.689206215813, 15551.611209719847, 15555.22223888801, 15568.844311556966, 10956.506957186946, 11207.775844483227, 11213.887861121448, 12075.698107547381, 12152.453139608739, 11232.943835280772, 13692.863071369158, 13699.520516781864, 15004.699906001819, 15393.076415415111, 5707.857303567361, 5900.734466948998, 6662.200535935622, 6692.732290708317, 6712.463002959751, 872.6509396241428, 879.2745984562762, 900.342749792655, 901.7655409593552, 912.9954350228206, 29162.708372916422, 29243.415131697246, 29362.265943351587, 29724.0, 30145.0, 1060.4432672846663, 1064.4890452582804, 1093.305750848217, 1111.0445017285128, 1166.6849950513315, 14421.0, 15051.247437628293, 15064.246787660573, 15204.46784362542, 15516.767248491282, 620227.0, 623369.8831505814, 625009.2489826116, 625840.0, 626935.0, 56552.43447565554, 56761.0, 56777.716111420006, 56845.43154568484, 56847.43152568504, 1393.2963853254244, 1438.503716217903, 1452.0924422236103, 1454.1275234859, 1456.3810380588206, 27600.89596416121, 28320.291992700346, 28976.0, 29182.854085729436, 29183.416331672823, 47234.76382618065, 59318.40681593129, 61269.0, 61311.08033379414, 61415.692921535105, 597289.0, 610735.0, 611788.0, 612242.0, 612848.0, 42684.62007172099, 43105.0, 43486.782566086964, 43771.34342984794, 43989.78005110082, 39706.65426896034, 46113.769431153974, 46690.766546167055, 47752.7612361936, 47904.0, 37006.814965925, 39283.92889279957, 39812.80093599513, 39986.200275994895, 41033.79483102685, 33364.499532507514, 39542.20915581615, 39916.40125398179, 40394.0, 40902.795486022376, 38885.22229555449, 39083.0, 39316.01709957274, 39559.0, 39830.20339593134, 31773.523397149525, 34550.82724586361, 34735.652643473244, 34913.68320009595, 35044.0, 25518.617220742075, 25759.742402575735, 25808.225753227434, 26218.737812622392, 26381.34046648849], "value": 20135.33298364272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.3019523296203, 389.09729427727683, 393.7342293951583, 400.36142352947047, 423.5573825352506, 14990.925045374772, 16305.592360191002, 19586.510337241576, 20851.478713032182, 21745.021474033667, 17403.3038678453, 21197.0, 21614.919254037315, 21685.566288674218, 21808.563828723418, 5694.117411801167, 5721.628094173886, 5810.680412577307, 5860.296764388279, 5958.433948774881, 4113.547509773923, 5760.740766665489, 5879.323877754049, 5884.6469211847425, 5885.470307672309, 4295.849645262417, 4296.441462609872, 5475.206095116206, 6448.903266451007, 6526.086347911296, 6304.87390252197, 6476.3199864014305, 6483.546151769378, 6499.837504062389, 6508.576942498722, 5668.404817494186, 5747.109198074305, 5762.855928601776, 5767.0772676372, 5770.076787713988, 25573.0, 25973.610395844076, 26006.479870402676, 26008.959641614314, 26610.73389266102, 2722.91831245061, 3044.88861565527, 3048.634163900324, 3090.6754790746872, 3090.814551126917, 14677.339519721532, 14906.105633662015, 15248.39006439741, 15267.0, 15301.693966120727, 1749.7987731410924, 1782.7364408798499, 1835.1008006077059, 1865.1886429403253, 1906.037451087206, 108982.0, 109990.45004775006, 110645.44677276643, 111929.0, 112539.43730281378, 9966.651167209113, 10087.848682269772, 11238.943805280922, 11522.539098436137, 11532.617605310097, 14441.566752997427, 14446.566603001927, 14450.566483005527, 14461.0, 14478.782818257734, 8265.917340826634, 8522.318214542945, 8542.701005464778, 8698.956505217433, 8700.564971751513, 8181.100078991306, 8435.955683086302, 8471.95764021176, 8518.190771876662, 8721.825563488695, 6159.322474527888, 6189.7620475905, 6658.83352916181, 7031.824204394931, 7066.858662826715, 1602.3991003373735, 1819.2535166240293, 1911.856610754199, 1914.5066847858693, 1915.4540955827522, 1038.8545603615348, 1042.4631314872847, 1051.574112484445, 1055.18223376882, 1090.2640717515644, 21610.0, 21990.45023874416, 22048.88975555112, 22049.559008819735, 22491.88754056219, 1062.0972173652333, 1065.3288428290282, 1090.4929207918356, 1096.4627332606965, 1097.9066779323687, 9198.63205471787, 11104.333739975627, 11488.942555287338, 11961.40192990347, 12082.033437324993, 679385.0, 680786.0, 730035.0, 731603.0, 752636.0, 110173.0, 128635.0, 153867.0, 154193.22903385412, 159029.0, 949.8955114937352, 1102.063246240689, 1142.1091548592112, 1143.7883991461606, 1146.3465824479965, 18249.543761406072, 19695.21219151218, 19907.60184796267, 20114.69827952611, 20184.293549725688, 55291.0, 61797.69101154465, 61908.07137893025, 61965.0, 64758.676206618664, 90395.0, 91890.54054729684, 92249.0, 92595.07404925865, 96959.06081878181, 6034.39656034393, 8280.337572994025, 8437.282830959437, 8476.788080298042, 8536.871946920925, 12640.925521330422, 13052.673683157996, 13502.594922152352, 13548.458061677817, 13591.844693201188, 9681.70954871355, 11236.606718765132, 11319.207655464039, 11632.651020469399, 11701.824472632747, 9172.6789562365, 11186.440677966231, 11290.040346570633, 11604.187706860777, 11643.47604357789, 9535.904640953502, 11762.23545469576, 11786.587469438871, 11835.881641183478, 11902.345371004678, 8155.0, 8374.83250335002, 8416.87374689368, 8426.4944103354, 8583.699570515002, 11233.943830280796, 11241.32552046847, 11624.709382265512, 11758.3532905691, 11839.1712580122], "value": 10131.351500007939, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.6913263648314, 1436.8347640021398, 1439.35807022353, 1461.254760072363, 1463.107504422302, 7927.801804954879, 8278.296344810691, 8294.087650358455, 8304.294134998525, 8305.211004954519, 6534.640594767297, 7355.0, 7590.5066170698865, 8079.596020198981, 8097.1902809718995, 2042.560849417375, 2183.967240491394, 2256.7066281383395, 2297.253392647388, 2304.5275718477674, 2271.954560908781, 2289.301762962296, 2301.390131615123, 2307.1348244408346, 2310.445493081657, 2208.205046183373, 2219.323106452531, 2234.5084081502123, 2235.5417139486367, 2246.29241788836, 2228.0308065991344, 2245.5733410652088, 2247.2359397804744, 2250.8167077934377, 2251.3020963501203, 2114.503091773432, 2167.41479800453, 2267.4331417145713, 2287.885605719707, 2293.323469576479, 8133.59332033396, 8200.302974247195, 8201.630926608317, 8217.671293148267, 8232.83534329316, 4978.327925730016, 5142.974285128588, 5149.0989076911765, 5158.148905430599, 5170.327857378555, 3197.58431403916, 3360.714339281164, 3369.1913940654067, 3370.561826962504, 3474.617792042873, 1165.6211731187398, 1207.082617210926, 1213.168979249217, 1259.779538580754, 1260.5021016698445, 10529.736756581147, 10571.94714026425, 10678.94660526708, 10679.41263230522, 10680.14558835299, 4099.754014759064, 4546.431696037996, 4595.126925884071, 4623.791929363187, 4629.1436084324505, 9199.540022998823, 9224.584893679801, 9226.0, 9229.16937475617, 9231.538423078819, 5162.561182299547, 5163.328767260307, 5169.224616307584, 5171.3277273954145, 5171.456997015259, 4676.392069031004, 4685.812567497262, 4716.481187069419, 4716.976415117902, 4739.3601863748645, 3711.6659500645073, 3735.9626403735615, 3771.453139294787, 3815.771053736785, 3835.2904712627696, 1247.1270110922392, 1247.7504499100216, 1249.144336129754, 1263.7662032524013, 1264.607971528829, 873.5021038008274, 897.3808072430003, 907.7276816954887, 938.7653086728318, 949.8432758594754, 5209.749660081629, 5599.384067752544, 5695.8860822784145, 5900.616459930091, 5983.1623572699855, 957.621739412928, 958.7075941837667, 1014.5941623350719, 1019.612547232062, 1037.5331101004579, 3559.341521818472, 3735.402335626287, 3814.48504451901, 3817.2365526894732, 3855.1904100139286, 9559.522023898777, 9774.364666296668, 9873.80252394948, 9900.059494348025, 9936.652217172508, 9780.559874805509, 9836.606535738634, 9857.605695772088, 9867.259955503223, 9871.703848884545, 7143.285671432815, 7349.154847192642, 7562.735304264324, 7600.2779735925, 7606.733764318333, 5661.490465858093, 5683.516901063456, 5692.516136128475, 5815.331236907809, 5851.356350801493, 8891.333150013645, 8909.242714369351, 8925.866112008196, 9211.907880921373, 9243.0, 8141.470804397695, 9016.774580635536, 9018.0, 9170.724878253663, 9175.174234318943, 6488.188976377953, 6703.02806093104, 6851.314868513308, 6950.8609827804175, 7092.503524753424, 7694.769156925301, 7727.9691396894505, 7859.017622797151, 7860.292573668397, 7862.2923936845955, 6946.930530694628, 6988.79033628992, 6996.6151861648095, 7135.250798666273, 7173.246809084971, 6765.289644587444, 6889.276625954403, 6905.274946130785, 6909.7581584644295, 6920.342567456084, 6192.81421557354, 6347.587406818542, 6352.428281454691, 6355.713992870239, 6358.395952384516, 4826.493218212177, 4868.683535570177, 4896.828610998598, 4911.607071434348, 4972.776225069808, 4891.673661909793, 4932.161532539405, 4960.032793605213, 5013.072581572421, 5036.974815125901], "value": 4369.689591720784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.38571122055396, 357.69595843533, 373.5871861592939, 378.64633933687077, 381.93316169670317, 4860.368152140221, 4980.626453016021, 5326.680399176047, 5361.973190134044, 5362.410134885159, 4153.667706583474, 4554.931676024862, 4946.9257961130525, 5116.641835071547, 5131.846044618658, 3974.3839704845795, 4110.568390319011, 4114.300568903293, 4152.314868046768, 4161.354989976543, 3784.394496880486, 4114.683301343572, 4138.234426631067, 4150.771707556083, 4192.580741925798, 3968.6229808168177, 4076.8177228603668, 4097.221527909703, 4113.547509773923, 4144.295469770146, 3399.6770306820813, 3781.773093614392, 3904.648581627667, 4070.715049946505, 4141.9585804142025, 3002.4445477586714, 3635.836532309662, 3660.9450858237146, 3666.2667466506805, 3670.9354287256665, 4795.328653988445, 4929.8028078876805, 5137.434882162959, 5178.974105129488, 5179.585633149339, 4517.683762136652, 4612.838550650711, 4624.606908412789, 4639.350490931272, 4647.744374059425, 5600.691961942091, 5603.579731520153, 5615.466530679579, 5621.522170615503, 5647.362264943162, 3293.79224371336, 3446.172918499542, 3713.313037088147, 3867.1878905429894, 3876.3604005339084, 4789.616830653575, 5068.350787433043, 5561.77752889884, 5831.475167234969, 5878.707304151384, 3613.95195393333, 3674.5590529136675, 3763.284975854579, 3854.383298672199, 3873.8644147455266, 3933.872571305819, 3938.6258305460933, 3950.2297052075146, 3954.426608141861, 3956.208758248304, 4426.0, 4528.0, 4535.297028960516, 4563.106310880948, 4607.562281583244, 4828.855134345975, 5229.869253268623, 5591.720413979285, 5599.8600034998635, 5606.6636001840025, 953.4708236928433, 1047.4396198034167, 1212.8241404996227, 1273.3824095313767, 1277.7827769279245, 818.4802650317091, 833.4457585705438, 848.3552500099845, 865.5412631305418, 870.8954925408991, 4582.495925448198, 4923.113839508923, 4924.276503223843, 4943.90112197754, 4948.777305021283, 5074.0, 5441.918371224435, 5444.428335024844, 5466.316710411199, 5499.670019798825, 4005.1589166275407, 4355.80398882051, 4470.6870519064005, 4499.290269697494, 4686.305374409728, 2739.643846299968, 2777.708340624246, 2834.518131917579, 2845.231787417386, 2852.0196394767518, 5327.694714794822, 5336.399080275979, 5628.0, 5638.689872057076, 5685.573581981285, 5373.931036550956, 5445.346558413015, 5864.237649105589, 5874.472637114381, 5895.498882594941, 4782.402199725035, 5714.285714285715, 5845.620034697731, 5953.3451320354725, 5989.970050149808, 5005.72354049715, 5370.838874833761, 5413.7834486620095, 5719.714014299351, 5757.3379061406795, 5017.448080711046, 5194.714290714047, 5307.336582927134, 5669.064604340238, 5710.971445142748, 5513.807016754395, 5739.799107031234, 5967.9701601491715, 5982.572896056973, 6022.861884031106, 3613.7289703271836, 3825.6748176404203, 3863.96136038636, 3892.4115463216644, 3912.765234085964, 4780.179693980568, 5557.5553955682635, 5669.574781891292, 5737.827865164052, 5739.454751798572, 4684.882877928079, 5422.376426710979, 5632.352279487911, 5649.0060268058, 5655.802046928337, 4745.291694989732, 4902.333206709736, 5028.270900719448, 5573.665580065209, 5595.328560572757, 4650.558196971282, 5198.610104242272, 5359.866003349947, 5469.562435005269, 5485.588580856372, 4229.598188172119, 5325.707086110301, 5488.643238189505, 5541.972290138524, 5548.472895074961, 5360.222767698584, 5380.273663055437, 5381.542568881689, 5393.946060539344, 5445.673259604437], "value": 4034.5494070259474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.8176428835637, 708.1891234536453, 745.8582869254841, 769.1500891514876, 821.7082935557877, 14788.18664973426, 15587.376504939788, 15590.98658587191, 15614.0, 15614.219289035545, 14277.92861035696, 14414.783778243334, 14424.062435941683, 14427.855721442782, 14431.350589223484, 660.465023331101, 677.2651672934871, 699.9300069992986, 846.5132548784474, 848.5841937450666, 852.9658813647446, 853.8420392227426, 869.7303835810919, 870.0559892516627, 870.1211776106115, 891.7235656946367, 932.5616960028809, 940.2712897504455, 944.0417975754615, 945.1021529546923, 713.5682911838367, 736.7679181057949, 935.4948327902924, 937.1378331934636, 938.5401153434836, 663.2174034639124, 677.3869647968596, 679.9592024478497, 681.0431343961742, 683.6889215406978, 14724.55826325212, 14837.480688175861, 14935.402583896632, 14966.47617333399, 15018.774718379233, 13641.908647308192, 13645.317734113354, 13776.724465510633, 13820.723585528232, 13908.095973761672, 12547.874521254762, 12645.620631381073, 12766.234025958473, 12880.484780608858, 13146.934265328613, 4334.826606935719, 4399.758013309267, 4549.522300158469, 4555.248384016633, 4556.658250631216, 82621.0, 97391.51304243505, 101321.0, 105413.47293263562, 108037.0, 10796.958828289766, 10799.460026998619, 10827.079698225582, 10972.561097556169, 11206.719832004102, 21482.78517214808, 21719.0, 21719.56560868774, 21776.346709598736, 21943.561128777335, 7527.096748390119, 7566.735164269224, 7616.657250423634, 7790.727324543614, 7809.414293927978, 3740.9064773380883, 3874.089588946595, 4011.1777085697363, 4130.690198235145, 4153.979230103831, 3411.692947634725, 3442.5524681791208, 3461.3423449544507, 3489.6335884732243, 3503.404421248394, 559.2059275828334, 624.6283461340495, 637.6492928889093, 640.0303540136697, 646.7574659502686, 636.3191385217773, 643.5616397351914, 648.5589798936674, 651.1665068712056, 666.6865085270388, 8985.0, 9825.705228843146, 9854.014598540089, 9903.554340054714, 10067.697969060793, 630.3412933484428, 630.8107567729663, 653.1574269192784, 655.8130932684162, 687.7386593094692, 4802.615790736802, 4820.132376172252, 4836.879078023007, 4854.538818812207, 4866.270059491105, 100839.48740768894, 104416.47791760993, 104516.47741761242, 105560.94439055664, 107309.0, 82076.58961705153, 82673.58663206645, 84082.15917840743, 84361.0, 90614.54692726494, 63280.68359658265, 65671.0, 80587.7911831323, 82392.76410853842, 83395.0, 10232.11370784705, 10904.727381815517, 10939.671809845717, 10963.0, 11237.3257604544, 47288.0, 48560.028799423104, 48953.755231223615, 51137.23294150665, 51484.22773658473, 62513.687431562554, 65757.67121164364, 65864.6706766463, 66497.0, 68191.0, 12500.31248281317, 12857.96904913842, 13006.479740810262, 13279.203247805162, 13619.18284902909, 14461.566153015427, 14810.851891480947, 14818.594834548174, 14946.626334341294, 14963.850361496246, 13723.519676811264, 13752.587422377344, 13802.861971380158, 13956.644264057033, 14045.227512486912, 13641.2117104093, 13786.310684465536, 13830.723385532434, 13992.650183745487, 14055.789163162357, 13496.865031349953, 13519.459221631418, 13769.173849569059, 13789.793153102511, 13940.0, 11024.779504410028, 11143.498542565441, 11173.0, 11570.370884638303, 11630.534778609099, 10343.172546196136, 10515.0, 10825.796753754363, 10921.83617245726, 11020.834687479855], "value": 7486.6945252804035, "unit": "score"}], "name": "dromaeo_css", "value": 7309.587199521045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 106.0, 140.0, 110.0, 106.0, 127.0, 139.0, 160.0, 110.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 184.0, 182.0, 183.0, 181.0, 182.0, 185.0, 185.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 60.0, 87.0, 60.0, 58.0, 59.0, 58.0, 73.0, 58.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 86.0, 70.0, 69.0, 70.0, 84.0, 69.0, 70.0, 85.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 86.0, 84.0, 88.0, 85.0, 87.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 107.0, 149.0, 93.0, 93.0, 98.0, 93.0, 94.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 83.0, 86.0, 71.0, 127.0, 138.0, 98.0, 87.0, 87.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 53.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 81.0, 73.0, 74.0, 71.0, 72.0, 73.0, 72.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 86.0, 99.0, 107.0, 81.0, 87.0, 86.0, 89.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 141.0, 139.0, 139.0, 139.0, 155.0, 147.0, 210.0, 155.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 172.0, 175.0, 179.0, 173.0, 172.0, 170.0, 172.0, 171.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 69.0, 73.0, 84.0, 87.0, 86.0, 74.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1458.8999999999999, "alertThreshold": 2.0}]} 08:43:31 INFO - Return code: 0 08:43:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:31 INFO - # TBPL SUCCESS # 08:43:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:31 INFO - 2017-01-11 08:43:31.979 screenresolution[1672:9720] starting screenresolution argv=screenresolution get 08:43:31 INFO - 2017-01-11 08:43:31.981 screenresolution[1672:9720] Display 0: 1600x1200x32@60 08:43:31 INFO - 2017-01-11 08:43:31.987 screenresolution[1673:9723] starting screenresolution argv=screenresolution list 08:43:31 INFO - Available Modes on Display 0 08:43:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:32 INFO - Intel Iris: 08:43:32 INFO - Chipset Model: Intel Iris 08:43:32 INFO - Type: GPU 08:43:32 INFO - Bus: Built-In 08:43:32 INFO - VRAM (Dynamic, Max): 1536 MB 08:43:32 INFO - Vendor: Intel (0x8086) 08:43:32 INFO - Device ID: 0x0a2e 08:43:32 INFO - Revision ID: 0x0009 08:43:32 INFO - Displays: 08:43:32 INFO - Display: 08:43:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:32 INFO - Display Serial Number: 1600x1200 60 08:43:32 INFO - Main Display: Yes 08:43:32 INFO - Mirror: Off 08:43:32 INFO - Online: Yes 08:43:32 INFO - Rotation: Supported 08:43:32 INFO - Return code: 0 08:43:32 INFO - Running post-action listener: _resource_record_post_action 08:43:32 INFO - [mozharness: 2017-01-11 16:43:32.220686Z] Finished run-tests step (success) 08:43:32 INFO - Running post-run listener: _resource_record_post_run 08:43:32 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37737472; Write bytes: 550307840; Read time: 238; Write time: 1664 08:43:32 INFO - TinderboxPrint: CPU usage
53.7% 08:43:32 INFO - TinderboxPrint: I/O read bytes / time
37,737,472 / 238 08:43:32 INFO - TinderboxPrint: I/O write bytes / time
550,307,840 / 1,664 08:43:32 INFO - TinderboxPrint: CPU idle
2,226.8 (46.3%) 08:43:32 INFO - TinderboxPrint: CPU system
959.5 (20.0%) 08:43:32 INFO - TinderboxPrint: CPU user
1,619.4 (33.7%) 08:43:32 INFO - TinderboxPrint: Swap in / out
287,207,424 / 0 08:43:32 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 246452736; Write bytes: 240256512; Read time: 17612; Write time: 529 08:43:32 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34386944; Write bytes: 296518144; Read time: 215; Write time: 1096 08:43:32 INFO - Running post-run listener: _upload_blobber_files 08:43:32 INFO - Blob upload gear active. 08:43:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:32 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:43:32 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:43:32 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:43:33 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:34 INFO - (blobuploader) - INFO - Done attempting. 08:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:35 INFO - (blobuploader) - INFO - Done attempting. 08:43:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:43:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:36 INFO - (blobuploader) - INFO - Done attempting. 08:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:38 INFO - (blobuploader) - INFO - Done attempting. 08:43:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:38 INFO - Return code: 0 08:43:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6b9d05afeea8fe197a9a207f31fcddce540f50c57ef13132bb0d797413abf9aed1842b2bf7d7df26826280954d4f03c37491278ec64011ff6793572396cf5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d494067466dbc5ea91b04a922a11a92673b43225e4ba24e0851557435f8eb7dd3cf1acd0676c8d378814041164b50e652dde213791a56710f5c34824a6a3d33d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b7a76cf684229114d53a9066d1a49f3a56ce213a8692aa7cee2fc26545c757137463113bf8f1d8058ed5208d35be4f35722b0d58ecbcbfc9862f63bbaaf8b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc307b28e9667dbf9d0e2c0d6a065d447686c0836c90008c54080b58329478c4c374098410743d46c0d2ce5831195bf059e5fe42cae5a912d9550570c45f836"} 08:43:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:38 INFO - Contents: 08:43:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6b9d05afeea8fe197a9a207f31fcddce540f50c57ef13132bb0d797413abf9aed1842b2bf7d7df26826280954d4f03c37491278ec64011ff6793572396cf5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d494067466dbc5ea91b04a922a11a92673b43225e4ba24e0851557435f8eb7dd3cf1acd0676c8d378814041164b50e652dde213791a56710f5c34824a6a3d33d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b7a76cf684229114d53a9066d1a49f3a56ce213a8692aa7cee2fc26545c757137463113bf8f1d8058ed5208d35be4f35722b0d58ecbcbfc9862f63bbaaf8b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc307b28e9667dbf9d0e2c0d6a065d447686c0836c90008c54080b58329478c4c374098410743d46c0d2ce5831195bf059e5fe42cae5a912d9550570c45f836"} 08:43:38 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:38 INFO - Copying logs to upload dir... 08:43:38 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.443720 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-11 08:43:38.718007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 08:43:38.721108) ========= 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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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/9f6b9d05afeea8fe197a9a207f31fcddce540f50c57ef13132bb0d797413abf9aed1842b2bf7d7df26826280954d4f03c37491278ec64011ff6793572396cf5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d494067466dbc5ea91b04a922a11a92673b43225e4ba24e0851557435f8eb7dd3cf1acd0676c8d378814041164b50e652dde213791a56710f5c34824a6a3d33d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b7a76cf684229114d53a9066d1a49f3a56ce213a8692aa7cee2fc26545c757137463113bf8f1d8058ed5208d35be4f35722b0d58ecbcbfc9862f63bbaaf8b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc307b28e9667dbf9d0e2c0d6a065d447686c0836c90008c54080b58329478c4c374098410743d46c0d2ce5831195bf059e5fe42cae5a912d9550570c45f836"} build_url:https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/b3sLrzrETBW_9pSYUuP5yQ/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/9f6b9d05afeea8fe197a9a207f31fcddce540f50c57ef13132bb0d797413abf9aed1842b2bf7d7df26826280954d4f03c37491278ec64011ff6793572396cf5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d494067466dbc5ea91b04a922a11a92673b43225e4ba24e0851557435f8eb7dd3cf1acd0676c8d378814041164b50e652dde213791a56710f5c34824a6a3d33d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b7a76cf684229114d53a9066d1a49f3a56ce213a8692aa7cee2fc26545c757137463113bf8f1d8058ed5208d35be4f35722b0d58ecbcbfc9862f63bbaaf8b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc307b28e9667dbf9d0e2c0d6a065d447686c0836c90008c54080b58329478c4c374098410743d46c0d2ce5831195bf059e5fe42cae5a912d9550570c45f836"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 08:43:38.756684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:43:38.757122) ========= 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.KdtmEwRd9d/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.Cs5IehQ3bE/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.005123 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:43:38.806853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 08:43:38.807205) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 08:43:38.807558) ========= ========= Total master_lag: 2.36 =========